builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1460868313.52 results: success (0) buildid: 20160416210219 builduid: ce7806e457d84634b0dbd07c2fd7f25a revision: 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.516303) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.516765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.517091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.595235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.595611) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 21:45:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-04-16 21:45:13 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132870 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.778622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.779415) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016861 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.831165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:13.831513) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 21:45:13,974 truncating revision to first 12 chars 2016-04-16 21:45:13,974 Setting DEBUG logging. 2016-04-16 21:45:13,974 attempt 1/10 2016-04-16 21:45:13,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f58e7ce1ab8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 21:45:14,536 unpacking tar archive at: fx-team-2f58e7ce1ab8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.872815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:14.717828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:14.718160) ========= script_repo_revision: 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:14.718578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:14.718876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 21:45:14.730823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-04-16 21:45:14.731203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:45:15 INFO - MultiFileLogger online at 20160416 21:45:15 in /builds/slave/test 21:45:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:45:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:45:15 INFO - {'append_to_log': False, 21:45:15 INFO - 'base_work_dir': '/builds/slave/test', 21:45:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:45:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:45:15 INFO - 'branch': 'Fx-Team-Non-PGO', 21:45:15 INFO - 'buildbot_json_path': 'buildprops.json', 21:45:15 INFO - 'config_files': ('talos/linux_config.py',), 21:45:15 INFO - 'default_actions': ('clobber', 21:45:15 INFO - 'read-buildbot-config', 21:45:15 INFO - 'download-and-extract', 21:45:15 INFO - 'populate-webroot', 21:45:15 INFO - 'create-virtualenv', 21:45:15 INFO - 'install', 21:45:15 INFO - 'run-tests'), 21:45:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:45:15 INFO - 'download_minidump_stackwalk': True, 21:45:15 INFO - 'download_symbols': 'ondemand', 21:45:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:45:15 INFO - 'tooltool.py': '/tools/tooltool.py', 21:45:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:45:15 INFO - '/tools/misc-python/virtualenv.py')}, 21:45:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:45:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:45:15 INFO - 'installer_path': 'installer.exe', 21:45:15 INFO - 'log_level': 'info', 21:45:15 INFO - 'log_name': 'talos', 21:45:15 INFO - 'log_to_console': True, 21:45:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:45:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:45:15 INFO - 'opt_config_files': (), 21:45:15 INFO - 'pip_index': False, 21:45:15 INFO - 'sps_profile': False, 21:45:15 INFO - 'sps_profile_interval': 0, 21:45:15 INFO - 'suite': 'dromaeojs', 21:45:15 INFO - 'system_bits': '32', 21:45:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:45:15 INFO - 'title': 'talos-linux64-ix-022', 21:45:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:45:15 INFO - 'use_talos_json': True, 21:45:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:45:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:45:15 INFO - 'work_dir': 'build'} 21:45:15 INFO - ##### 21:45:15 INFO - ##### Running clobber step. 21:45:15 INFO - ##### 21:45:15 INFO - Running pre-action listener: _resource_record_pre_action 21:45:15 INFO - Running main action method: clobber 21:45:15 INFO - rmtree: /builds/slave/test/build 21:45:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:45:15 INFO - Running post-action listener: _resource_record_post_action 21:45:15 INFO - ##### 21:45:15 INFO - ##### Running read-buildbot-config step. 21:45:15 INFO - ##### 21:45:15 INFO - Running pre-action listener: _resource_record_pre_action 21:45:15 INFO - Running main action method: read_buildbot_config 21:45:15 INFO - Using buildbot properties: 21:45:15 INFO - { 21:45:15 INFO - "project": "", 21:45:15 INFO - "product": "firefox", 21:45:15 INFO - "script_repo_revision": "production", 21:45:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:45:15 INFO - "repository": "", 21:45:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:45:15 INFO - "buildid": "20160416210219", 21:45:15 INFO - "pgo_build": "False", 21:45:15 INFO - "basedir": "/builds/slave/test", 21:45:15 INFO - "buildnumber": 1650, 21:45:15 INFO - "slavename": "talos-linux64-ix-022", 21:45:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:45:15 INFO - "platform": "ubuntu64_hw", 21:45:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:45:15 INFO - "branch": "fx-team", 21:45:15 INFO - "repo_path": "integration/fx-team", 21:45:15 INFO - "revision": "2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799", 21:45:15 INFO - "stage_platform": "linux64", 21:45:15 INFO - "builduid": "ce7806e457d84634b0dbd07c2fd7f25a", 21:45:15 INFO - "slavebuilddir": "test" 21:45:15 INFO - } 21:45:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:45:15 INFO - Running post-action listener: _resource_record_post_action 21:45:15 INFO - ##### 21:45:15 INFO - ##### Running download-and-extract step. 21:45:15 INFO - ##### 21:45:15 INFO - Running pre-action listener: _resource_record_pre_action 21:45:15 INFO - Running main action method: download_and_extract 21:45:15 INFO - mkdir: /builds/slave/test/build/tests 21:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:15 INFO - https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:45:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:45:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:45:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:45:24 INFO - Downloaded 1361 bytes. 21:45:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:45:24 INFO - Using the following test package requirements: 21:45:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:45:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:45:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:24 INFO - u'jsshell-linux-x86_64.zip'], 21:45:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:45:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:45:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:45:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:45:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:45:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:24 INFO - https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:45:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:45:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:45:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:45:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:45:26 INFO - Downloaded 22203703 bytes. 21:45:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:45:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:45:28 INFO - Return code: 0 21:45:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:28 INFO - https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:45:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:45:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:45:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:45:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:45:38 INFO - Downloaded 22203703 bytes. 21:45:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:45:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:45:40 INFO - Return code: 0 21:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:40 INFO - https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:45:41 INFO - Downloaded 10841076 bytes. 21:45:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:45:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:45:41 INFO - Return code: 0 21:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:41 INFO - https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:45:43 INFO - Downloaded 54450906 bytes. 21:45:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:45:43 INFO - mkdir: /builds/slave/test/properties 21:45:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:45:43 INFO - Writing to file /builds/slave/test/properties/build_url 21:45:43 INFO - Contents: 21:45:43 INFO - build_url:https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:45:44 INFO - Running post-action listener: _resource_record_post_action 21:45:44 INFO - Running post-action listener: set_extra_try_arguments 21:45:44 INFO - ##### 21:45:44 INFO - ##### Running populate-webroot step. 21:45:44 INFO - ##### 21:45:44 INFO - Running pre-action listener: _resource_record_pre_action 21:45:44 INFO - Running main action method: populate_webroot 21:45:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:45:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:45:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:45:44 INFO - '--tppagecycles', 21:45:44 INFO - '7'], 21:45:44 INFO - 'tests': ['tsvgm']}}, 21:45:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:45:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:45:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:45:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:45:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:44 INFO - 'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:44 INFO - 'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['damp', 'tps']}, 21:45:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:44 INFO - 'tests': ['damp', 'tps']}, 21:45:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['dromaeo_dom']}, 21:45:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:45:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['a11yr', 21:45:44 INFO - 'ts_paint', 21:45:44 INFO - 'tpaint', 21:45:44 INFO - 'sessionrestore', 21:45:44 INFO - 'sessionrestore_no_auto_restore', 21:45:44 INFO - 'tabpaint']}, 21:45:44 INFO - 'other-e10s': {'tests': ['a11yr', 21:45:44 INFO - 'ts_paint', 21:45:44 INFO - 'tpaint', 21:45:44 INFO - 'sessionrestore', 21:45:44 INFO - 'sessionrestore_no_auto_restore', 21:45:44 INFO - 'tabpaint']}, 21:45:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:45:44 INFO - 'ts_paint', 21:45:44 INFO - 'tpaint', 21:45:44 INFO - 'sessionrestore', 21:45:44 INFO - 'sessionrestore_no_auto_restore', 21:45:44 INFO - 'tabpaint']}, 21:45:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:45:44 INFO - 'ts_paint', 21:45:44 INFO - 'tpaint', 21:45:44 INFO - 'sessionrestore', 21:45:44 INFO - 'sessionrestore_no_auto_restore', 21:45:44 INFO - 'tabpaint']}, 21:45:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['a11yr', 21:45:44 INFO - 'ts_paint', 21:45:44 INFO - 'tpaint', 21:45:44 INFO - 'sessionrestore', 21:45:44 INFO - 'sessionrestore_no_auto_restore', 21:45:44 INFO - 'tabpaint']}, 21:45:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['a11yr', 21:45:44 INFO - 'ts_paint', 21:45:44 INFO - 'tpaint', 21:45:44 INFO - 'sessionrestore', 21:45:44 INFO - 'sessionrestore_no_auto_restore', 21:45:44 INFO - 'tabpaint']}, 21:45:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['tsvgx', 21:45:44 INFO - 'tsvgr_opacity', 21:45:44 INFO - 'tart', 21:45:44 INFO - 'tscrollx', 21:45:44 INFO - 'cart']}, 21:45:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:45:44 INFO - 'tsvgr_opacity', 21:45:44 INFO - 'tart', 21:45:44 INFO - 'tscrollx', 21:45:44 INFO - 'cart']}, 21:45:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:44 INFO - 'talos_options': ['--disable-e10s'], 21:45:44 INFO - 'tests': ['tp5o']}, 21:45:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:44 INFO - 'tests': ['tp5o']}, 21:45:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:44 INFO - 'talos_options': ['--disable-e10s', 21:45:44 INFO - '--xperf_path', 21:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:44 INFO - 'tests': ['tp5n']}, 21:45:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:44 INFO - 'talos_options': ['--xperf_path', 21:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:44 INFO - 'tests': ['tp5n']}}, 21:45:44 INFO - 'talos.zip': {'path': '', 21:45:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:45:44 INFO - Running post-action listener: _resource_record_post_action 21:45:44 INFO - ##### 21:45:44 INFO - ##### Running create-virtualenv step. 21:45:44 INFO - ##### 21:45:44 INFO - Running pre-action listener: _resource_record_pre_action 21:45:44 INFO - Running main action method: create_virtualenv 21:45:44 INFO - Creating virtualenv /builds/slave/test/build/venv 21:45:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:45:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:45:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:45:44 INFO - Using real prefix '/usr' 21:45:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:45:44 INFO - Installing distribute.............................................................................................................................................................................................done. 21:45:46 INFO - Installing pip.................done. 21:45:46 INFO - Return code: 0 21:45:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:45:46 INFO - Using env: {'DISPLAY': ':0', 21:45:46 INFO - 'HOME': '/home/cltbld', 21:45:46 INFO - 'LANG': 'en_US.UTF-8', 21:45:46 INFO - 'LANGUAGE': 'en_US:en', 21:45:46 INFO - 'LOGNAME': 'cltbld', 21:45:46 INFO - 'MAIL': '/var/mail/cltbld', 21:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:46 INFO - 'MOZ_NO_REMOTE': '1', 21:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:46 INFO - 'NO_EM_RESTART': '1', 21:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:46 INFO - 'PWD': '/builds/slave/test', 21:45:46 INFO - 'SHELL': '/bin/bash', 21:45:46 INFO - 'SHLVL': '1', 21:45:46 INFO - 'TERM': 'linux', 21:45:46 INFO - 'TMOUT': '86400', 21:45:46 INFO - 'USER': 'cltbld', 21:45:46 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:46 INFO - '_': '/tools/buildbot/bin/python'} 21:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:45:47 INFO - Cleaning up... 21:45:47 INFO - Return code: 0 21:45:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:45:47 INFO - Using env: {'DISPLAY': ':0', 21:45:47 INFO - 'HOME': '/home/cltbld', 21:45:47 INFO - 'LANG': 'en_US.UTF-8', 21:45:47 INFO - 'LANGUAGE': 'en_US:en', 21:45:47 INFO - 'LOGNAME': 'cltbld', 21:45:47 INFO - 'MAIL': '/var/mail/cltbld', 21:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:47 INFO - 'MOZ_NO_REMOTE': '1', 21:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:47 INFO - 'NO_EM_RESTART': '1', 21:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:47 INFO - 'PWD': '/builds/slave/test', 21:45:47 INFO - 'SHELL': '/bin/bash', 21:45:47 INFO - 'SHLVL': '1', 21:45:47 INFO - 'TERM': 'linux', 21:45:47 INFO - 'TMOUT': '86400', 21:45:47 INFO - 'USER': 'cltbld', 21:45:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:47 INFO - '_': '/tools/buildbot/bin/python'} 21:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:47 INFO - Downloading/unpacking psutil>=0.7.1 21:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:45:49 INFO - Installing collected packages: psutil 21:45:49 INFO - Running setup.py install for psutil 21:45:49 INFO - building 'psutil._psutil_linux' extension 21:45:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:45:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:45:50 INFO - building 'psutil._psutil_posix' extension 21:45:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:45:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:45:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:45:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:45:51 INFO - Successfully installed psutil 21:45:51 INFO - Cleaning up... 21:45:52 INFO - Return code: 0 21:45:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:45:52 INFO - Using env: {'DISPLAY': ':0', 21:45:52 INFO - 'HOME': '/home/cltbld', 21:45:52 INFO - 'LANG': 'en_US.UTF-8', 21:45:52 INFO - 'LANGUAGE': 'en_US:en', 21:45:52 INFO - 'LOGNAME': 'cltbld', 21:45:52 INFO - 'MAIL': '/var/mail/cltbld', 21:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:52 INFO - 'MOZ_NO_REMOTE': '1', 21:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:52 INFO - 'NO_EM_RESTART': '1', 21:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:52 INFO - 'PWD': '/builds/slave/test', 21:45:52 INFO - 'SHELL': '/bin/bash', 21:45:52 INFO - 'SHLVL': '1', 21:45:52 INFO - 'TERM': 'linux', 21:45:52 INFO - 'TMOUT': '86400', 21:45:52 INFO - 'USER': 'cltbld', 21:45:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:52 INFO - '_': '/tools/buildbot/bin/python'} 21:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:45:54 INFO - Installing collected packages: mozsystemmonitor 21:45:54 INFO - Running setup.py install for mozsystemmonitor 21:45:54 INFO - Successfully installed mozsystemmonitor 21:45:54 INFO - Cleaning up... 21:45:54 INFO - Return code: 0 21:45:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:45:54 INFO - Using env: {'DISPLAY': ':0', 21:45:54 INFO - 'HOME': '/home/cltbld', 21:45:54 INFO - 'LANG': 'en_US.UTF-8', 21:45:54 INFO - 'LANGUAGE': 'en_US:en', 21:45:54 INFO - 'LOGNAME': 'cltbld', 21:45:54 INFO - 'MAIL': '/var/mail/cltbld', 21:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:54 INFO - 'MOZ_NO_REMOTE': '1', 21:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:54 INFO - 'NO_EM_RESTART': '1', 21:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:54 INFO - 'PWD': '/builds/slave/test', 21:45:54 INFO - 'SHELL': '/bin/bash', 21:45:54 INFO - 'SHLVL': '1', 21:45:54 INFO - 'TERM': 'linux', 21:45:54 INFO - 'TMOUT': '86400', 21:45:54 INFO - 'USER': 'cltbld', 21:45:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:54 INFO - '_': '/tools/buildbot/bin/python'} 21:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:54 INFO - Downloading/unpacking blobuploader==1.2.4 21:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:56 INFO - Downloading blobuploader-1.2.4.tar.gz 21:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:45:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:45:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:57 INFO - Downloading docopt-0.6.1.tar.gz 21:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:45:57 INFO - Installing collected packages: blobuploader, requests, docopt 21:45:57 INFO - Running setup.py install for blobuploader 21:45:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:45:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:45:57 INFO - Running setup.py install for requests 21:45:57 INFO - Running setup.py install for docopt 21:45:57 INFO - Successfully installed blobuploader requests docopt 21:45:57 INFO - Cleaning up... 21:45:57 INFO - Return code: 0 21:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:45:57 INFO - Using env: {'DISPLAY': ':0', 21:45:57 INFO - 'HOME': '/home/cltbld', 21:45:57 INFO - 'LANG': 'en_US.UTF-8', 21:45:57 INFO - 'LANGUAGE': 'en_US:en', 21:45:57 INFO - 'LOGNAME': 'cltbld', 21:45:57 INFO - 'MAIL': '/var/mail/cltbld', 21:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:57 INFO - 'MOZ_NO_REMOTE': '1', 21:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:57 INFO - 'NO_EM_RESTART': '1', 21:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:57 INFO - 'PWD': '/builds/slave/test', 21:45:57 INFO - 'SHELL': '/bin/bash', 21:45:57 INFO - 'SHLVL': '1', 21:45:57 INFO - 'TERM': 'linux', 21:45:57 INFO - 'TMOUT': '86400', 21:45:57 INFO - 'USER': 'cltbld', 21:45:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:57 INFO - '_': '/tools/buildbot/bin/python'} 21:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:45:58 INFO - Running setup.py (path:/tmp/pip-jCkRC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:45:58 INFO - Running setup.py (path:/tmp/pip-H8uOp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:45:58 INFO - Running setup.py (path:/tmp/pip-BZurzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:45:58 INFO - Running setup.py (path:/tmp/pip-5LGh_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:45:58 INFO - Running setup.py (path:/tmp/pip-61nEB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:45:58 INFO - Running setup.py (path:/tmp/pip-BYcgqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:45:58 INFO - Running setup.py (path:/tmp/pip-sHV_9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:45:58 INFO - Running setup.py (path:/tmp/pip-aLurfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:45:58 INFO - Running setup.py (path:/tmp/pip-S_wQZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:45:58 INFO - Running setup.py (path:/tmp/pip-9p_Lj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:45:58 INFO - Running setup.py (path:/tmp/pip-1KYg1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:45:58 INFO - Running setup.py (path:/tmp/pip-Z1PVel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:45:59 INFO - Running setup.py (path:/tmp/pip-ejIqDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:45:59 INFO - Running setup.py (path:/tmp/pip-cacRiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:45:59 INFO - Running setup.py (path:/tmp/pip-w2xktK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:45:59 INFO - Running setup.py (path:/tmp/pip-ll5bX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:45:59 INFO - Running setup.py (path:/tmp/pip-79ZI9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:45:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:45:59 INFO - Running setup.py install for manifestparser 21:45:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:45:59 INFO - Running setup.py install for mozcrash 21:45:59 INFO - Running setup.py install for mozdebug 21:45:59 INFO - Running setup.py install for mozdevice 21:45:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:45:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:45:59 INFO - Running setup.py install for mozfile 21:45:59 INFO - Running setup.py install for mozhttpd 21:45:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:45:59 INFO - Running setup.py install for mozinfo 21:46:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Running setup.py install for mozInstall 21:46:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Running setup.py install for mozleak 21:46:00 INFO - Running setup.py install for mozlog 21:46:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Running setup.py install for moznetwork 21:46:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Running setup.py install for mozprocess 21:46:00 INFO - Running setup.py install for mozprofile 21:46:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Running setup.py install for mozrunner 21:46:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Running setup.py install for mozscreenshot 21:46:00 INFO - Running setup.py install for moztest 21:46:01 INFO - Running setup.py install for mozversion 21:46:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:01 INFO - Cleaning up... 21:46:01 INFO - Return code: 0 21:46:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:46:01 INFO - Using env: {'DISPLAY': ':0', 21:46:01 INFO - 'HOME': '/home/cltbld', 21:46:01 INFO - 'LANG': 'en_US.UTF-8', 21:46:01 INFO - 'LANGUAGE': 'en_US:en', 21:46:01 INFO - 'LOGNAME': 'cltbld', 21:46:01 INFO - 'MAIL': '/var/mail/cltbld', 21:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:01 INFO - 'MOZ_NO_REMOTE': '1', 21:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:01 INFO - 'NO_EM_RESTART': '1', 21:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:01 INFO - 'PWD': '/builds/slave/test', 21:46:01 INFO - 'SHELL': '/bin/bash', 21:46:01 INFO - 'SHLVL': '1', 21:46:01 INFO - 'TERM': 'linux', 21:46:01 INFO - 'TMOUT': '86400', 21:46:01 INFO - 'USER': 'cltbld', 21:46:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:01 INFO - '_': '/tools/buildbot/bin/python'} 21:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:01 INFO - Running setup.py (path:/tmp/pip-RFJefR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:01 INFO - Running setup.py (path:/tmp/pip-sbBIs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:01 INFO - Running setup.py (path:/tmp/pip-gaXym3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:01 INFO - Running setup.py (path:/tmp/pip-frU4cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:01 INFO - Running setup.py (path:/tmp/pip-iLnHgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:01 INFO - Running setup.py (path:/tmp/pip-6Jag1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:01 INFO - Running setup.py (path:/tmp/pip-mN6z4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:01 INFO - Running setup.py (path:/tmp/pip-rydBWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:01 INFO - Running setup.py (path:/tmp/pip-4bWNf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:02 INFO - Running setup.py (path:/tmp/pip-TKEHQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:02 INFO - Running setup.py (path:/tmp/pip-ideu1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:02 INFO - Running setup.py (path:/tmp/pip-Wu5AZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:02 INFO - Running setup.py (path:/tmp/pip-E4xanX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:02 INFO - Running setup.py (path:/tmp/pip-B90cMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:02 INFO - Running setup.py (path:/tmp/pip-0LWzRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:02 INFO - Running setup.py (path:/tmp/pip-ZDNy_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:02 INFO - Running setup.py (path:/tmp/pip-9XxsG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:04 INFO - Downloading blessings-1.6.tar.gz 21:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:04 INFO - Installing collected packages: blessings 21:46:04 INFO - Running setup.py install for blessings 21:46:04 INFO - Successfully installed blessings 21:46:04 INFO - Cleaning up... 21:46:04 INFO - Return code: 0 21:46:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:46:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:04 INFO - Reading from file tmpfile_stdout 21:46:04 INFO - Current package versions: 21:46:04 INFO - argparse == 1.2.1 21:46:04 INFO - blessings == 1.6 21:46:04 INFO - blobuploader == 1.2.4 21:46:04 INFO - docopt == 0.6.1 21:46:04 INFO - manifestparser == 1.1 21:46:04 INFO - mozInstall == 1.12 21:46:04 INFO - mozcrash == 0.17 21:46:04 INFO - mozdebug == 0.1 21:46:04 INFO - mozdevice == 0.48 21:46:04 INFO - mozfile == 1.2 21:46:04 INFO - mozhttpd == 0.7 21:46:04 INFO - mozinfo == 0.9 21:46:04 INFO - mozleak == 0.1 21:46:04 INFO - mozlog == 3.1 21:46:04 INFO - moznetwork == 0.27 21:46:04 INFO - mozprocess == 0.22 21:46:04 INFO - mozprofile == 0.28 21:46:04 INFO - mozrunner == 6.11 21:46:04 INFO - mozscreenshot == 0.1 21:46:04 INFO - mozsystemmonitor == 0.0 21:46:04 INFO - moztest == 0.7 21:46:04 INFO - mozversion == 1.4 21:46:04 INFO - psutil == 3.1.1 21:46:04 INFO - requests == 1.2.3 21:46:04 INFO - wsgiref == 0.1.2 21:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:46:04 INFO - Using env: {'DISPLAY': ':0', 21:46:04 INFO - 'HOME': '/home/cltbld', 21:46:04 INFO - 'LANG': 'en_US.UTF-8', 21:46:04 INFO - 'LANGUAGE': 'en_US:en', 21:46:04 INFO - 'LOGNAME': 'cltbld', 21:46:04 INFO - 'MAIL': '/var/mail/cltbld', 21:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:04 INFO - 'MOZ_NO_REMOTE': '1', 21:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:04 INFO - 'NO_EM_RESTART': '1', 21:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:04 INFO - 'PWD': '/builds/slave/test', 21:46:04 INFO - 'SHELL': '/bin/bash', 21:46:04 INFO - 'SHLVL': '1', 21:46:04 INFO - 'TERM': 'linux', 21:46:04 INFO - 'TMOUT': '86400', 21:46:04 INFO - 'USER': 'cltbld', 21:46:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:04 INFO - '_': '/tools/buildbot/bin/python'} 21:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:46:05 INFO - Cleaning up... 21:46:05 INFO - Return code: 0 21:46:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:46:05 INFO - Using env: {'DISPLAY': ':0', 21:46:05 INFO - 'HOME': '/home/cltbld', 21:46:05 INFO - 'LANG': 'en_US.UTF-8', 21:46:05 INFO - 'LANGUAGE': 'en_US:en', 21:46:05 INFO - 'LOGNAME': 'cltbld', 21:46:05 INFO - 'MAIL': '/var/mail/cltbld', 21:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:05 INFO - 'MOZ_NO_REMOTE': '1', 21:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:05 INFO - 'NO_EM_RESTART': '1', 21:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:05 INFO - 'PWD': '/builds/slave/test', 21:46:05 INFO - 'SHELL': '/bin/bash', 21:46:05 INFO - 'SHLVL': '1', 21:46:05 INFO - 'TERM': 'linux', 21:46:05 INFO - 'TMOUT': '86400', 21:46:05 INFO - 'USER': 'cltbld', 21:46:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:05 INFO - '_': '/tools/buildbot/bin/python'} 21:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:05 INFO - Downloading/unpacking jsonschema 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:07 INFO - Downloading/unpacking functools32 (from jsonschema) 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:07 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:07 INFO - warning: no files found matching '*.txt' 21:46:07 INFO - no previously-included directories found matching 'build' 21:46:07 INFO - no previously-included directories found matching 'dist' 21:46:07 INFO - no previously-included directories found matching '.git*' 21:46:07 INFO - Installing collected packages: jsonschema, functools32 21:46:07 INFO - Running setup.py install for functools32 21:46:07 INFO - warning: no files found matching '*.txt' 21:46:07 INFO - no previously-included directories found matching 'build' 21:46:07 INFO - no previously-included directories found matching 'dist' 21:46:07 INFO - no previously-included directories found matching '.git*' 21:46:07 INFO - Successfully installed jsonschema functools32 21:46:07 INFO - Cleaning up... 21:46:07 INFO - Return code: 0 21:46:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f118418af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:46:07 INFO - Using env: {'DISPLAY': ':0', 21:46:07 INFO - 'HOME': '/home/cltbld', 21:46:07 INFO - 'LANG': 'en_US.UTF-8', 21:46:07 INFO - 'LANGUAGE': 'en_US:en', 21:46:07 INFO - 'LOGNAME': 'cltbld', 21:46:07 INFO - 'MAIL': '/var/mail/cltbld', 21:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:07 INFO - 'MOZ_NO_REMOTE': '1', 21:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:07 INFO - 'NO_EM_RESTART': '1', 21:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:07 INFO - 'PWD': '/builds/slave/test', 21:46:07 INFO - 'SHELL': '/bin/bash', 21:46:07 INFO - 'SHLVL': '1', 21:46:07 INFO - 'TERM': 'linux', 21:46:07 INFO - 'TMOUT': '86400', 21:46:07 INFO - 'USER': 'cltbld', 21:46:07 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:07 INFO - '_': '/tools/buildbot/bin/python'} 21:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:07 INFO - Downloading/unpacking flake8 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:46:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:46:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:46:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:10 INFO - no previously-included directories found matching 'docs/_build' 21:46:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:46:10 INFO - Running setup.py install for pep8 21:46:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:10 INFO - no previously-included directories found matching 'docs/_build' 21:46:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:46:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:46:10 INFO - Cleaning up... 21:46:10 INFO - Return code: 0 21:46:10 INFO - Running post-action listener: _resource_record_post_action 21:46:10 INFO - Running post-action listener: _start_resource_monitoring 21:46:10 INFO - Starting resource monitoring. 21:46:10 INFO - ##### 21:46:10 INFO - ##### Running install step. 21:46:10 INFO - ##### 21:46:10 INFO - Running pre-action listener: _resource_record_pre_action 21:46:10 INFO - Running main action method: install 21:46:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:11 INFO - Reading from file tmpfile_stdout 21:46:11 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:46:11 INFO - Reading from file tmpfile_stdout 21:46:11 INFO - Output received: 21:46:11 INFO - Usage: mozinstall [options] installer 21:46:11 INFO - Options: 21:46:11 INFO - -h, --help show this help message and exit 21:46:11 INFO - -d DEST, --destination=DEST 21:46:11 INFO - Directory to install application into. [default: 21:46:11 INFO - "/builds/slave/test"] 21:46:11 INFO - --app=APP Application being installed. [default: firefox] 21:46:11 INFO - mkdir: /builds/slave/test/build/application 21:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:46:26 INFO - Reading from file tmpfile_stdout 21:46:26 INFO - Output received: 21:46:26 INFO - /builds/slave/test/build/application/firefox/firefox 21:46:26 INFO - Running post-action listener: _resource_record_post_action 21:46:26 INFO - ##### 21:46:26 INFO - ##### Running run-tests step. 21:46:26 INFO - ##### 21:46:26 INFO - Running pre-action listener: _resource_record_pre_action 21:46:26 INFO - Running main action method: run_tests 21:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:46:26 INFO - Python 2.7.3 21:46:26 INFO - Return code: 0 21:46:26 INFO - grabbing minidump binary from tooltool 21:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1977410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19787a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:46:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:46:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:46:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:46:27 INFO - Return code: 0 21:46:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:46:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:46:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:46:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:46:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:46:28 INFO - Return code: 0 21:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:46:28 INFO - Using env: {'DISPLAY': ':0', 21:46:28 INFO - 'HOME': '/home/cltbld', 21:46:28 INFO - 'LANG': 'en_US.UTF-8', 21:46:28 INFO - 'LANGUAGE': 'en_US:en', 21:46:28 INFO - 'LOGNAME': 'cltbld', 21:46:28 INFO - 'MAIL': '/var/mail/cltbld', 21:46:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:46:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:28 INFO - 'MOZ_NO_REMOTE': '1', 21:46:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:28 INFO - 'NO_EM_RESTART': '1', 21:46:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:28 INFO - 'PWD': '/builds/slave/test', 21:46:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:46:28 INFO - 'SHELL': '/bin/bash', 21:46:28 INFO - 'SHLVL': '1', 21:46:28 INFO - 'TERM': 'linux', 21:46:28 INFO - 'TMOUT': '86400', 21:46:28 INFO - 'USER': 'cltbld', 21:46:28 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814', 21:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:28 INFO - '_': '/tools/buildbot/bin/python'} 21:46:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:46:28 INFO - mozversion application_buildid: 20160416210219 21:46:28 INFO - mozversion application_changeset: 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 21:46:28 INFO - mozversion application_display_name: Nightly 21:46:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:46:28 INFO - mozversion application_name: Firefox 21:46:28 INFO - mozversion application_remotingname: firefox 21:46:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:46:28 INFO - mozversion application_vendor: Mozilla 21:46:28 INFO - mozversion application_version: 48.0a1 21:46:28 INFO - mozversion platform_buildid: 20160416210219 21:46:28 INFO - mozversion platform_changeset: 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 21:46:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:46:28 INFO - mozversion platform_version: 48.0a1 21:46:28 INFO - using testdate: 1460868388 21:46:28 INFO - actual date: 1460868388 21:46:28 INFO - starting webserver on 'localhost:36358' 21:46:28 INFO - SUITE-START | Running 2 tests 21:46:28 INFO - TEST-START | dromaeo_css 21:46:28 INFO - operating with platform_type : linux_ 21:46:28 INFO - Initialising browser for dromaeo_css test... 21:46:28 INFO - TEST-INFO | started process 3317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGP5vfK/profile http://localhost:36358/getInfo.html) 21:46:34 INFO - PROCESS | 3317 | __metrics Screen width/height:1600/1200 21:46:34 INFO - PROCESS | 3317 | colorDepth:24 21:46:34 INFO - PROCESS | 3317 | Browser inner width/height: 1024/697 21:46:34 INFO - PROCESS | 3317 | __metrics 21:46:35 ERROR - PROCESS | 3317 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:46:36 INFO - TEST-INFO | 3317: exit 0 21:46:36 INFO - Browser initialized. 21:46:36 INFO - Running cycle 1/1 for dromaeo_css test... 21:46:36 INFO - TEST-INFO | started process 3399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGP5vfK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:46:48 INFO - PROCESS | 3399 | RSS: Main: 154955776 21:46:48 INFO - PROCESS | 3399 | 21:47:40 INFO - PROCESS | 3399 | 1460868460133 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:49:51 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:36358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36358/tests/dromaeo/cssquery-ext.html) 21:49:52 INFO - PROCESS | 3399 | RSS: Main: 272154624 21:49:52 INFO - PROCESS | 3399 | 21:52:55 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:36358/tests/dromaeo/cssquery-ext.html (next: http://localhost:36358/tests/dromaeo/cssquery-jquery.html) 21:52:56 INFO - PROCESS | 3399 | RSS: Main: 235155456 21:52:56 INFO - PROCESS | 3399 | 21:55:58 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:36358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36358/tests/dromaeo/cssquery-mootools.html) 21:55:58 INFO - PROCESS | 3399 | RSS: Main: 231014400 21:55:58 INFO - PROCESS | 3399 | 21:59:00 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:36358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36358/tests/dromaeo/cssquery-prototype.html) 21:59:01 INFO - PROCESS | 3399 | RSS: Main: 230703104 21:59:01 INFO - PROCESS | 3399 | 22:02:04 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:36358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36358/tests/dromaeo/cssquery-yui.html) 22:02:04 INFO - PROCESS | 3399 | RSS: Main: 211935232 22:02:04 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:36358/tests/dromaeo/cssquery-yui.html (next: http://localhost:36358/tests/dromaeo/cssquery-dojo.html) 22:05:07 INFO - PROCESS | 3399 | RSS: Main: 267788288 22:05:07 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | __start_tp_report 22:05:07 INFO - PROCESS | 3399 | _x_x_mozilla_page_load 22:05:07 INFO - PROCESS | 3399 | _x_x_mozilla_page_load_details 22:05:07 INFO - PROCESS | 3399 | |i|pagename|runs| 22:05:07 INFO - PROCESS | 3399 | |0;dojo.html;2627.7897768178545;2664.33391652087;2672.5991101334803;2702.2838947678856;2716.6875809281937;4481.126180394825;4587.334836448713;4662.53374662534;4690.202665546861;4706.670533062683;4669.252919532875;4706.599939005188;4712.892470269492;4739.028499157673;4810.39870016248;4251.723637963538;4298.226319262531;4342.109867477176;4365.563443655641;4448.4439445069365;4372.97813510932;4394.956050439487;4420.46954365475;4428.933565996513;4452.554744525554;4176.644985176248;4244.384564238199;4274.786260686984;4312.482502099737;4331.7617531035785;4223.408722778813;4275.40144379787;4283.378910058055;4284.314509678467;4331.480222373304;4186.455760751113;4190.811413486401;4200.936985945214;4227.978860105711;4231.619154276099;4341.869743907688;4481.708688935241;4531.297648864432;4611.700239484423;4638.744869032202;4946.505349465061;4951.529604687549;4957.058158949824;4963.851084467436;4990.600751939873;4976.178930476503;4991.306433239413;4993;4993.625478089158;5049.924251136236;4503.347014682852;4629.537046295343;4691.296305554194;4737.9052418952115;4744.620430365562;5128.3076784633595;5139.357580302462;5160.561352285023;5161.870953226199;5177.4822517747925;4768.237082066853;4933.260010998307;4945;4947.6536642434685;4994.425641051325;4947.381577302837;4988.176950803149;5008.949910500921;5038.571721403649;5043.293938848564;4939.629527785359;4962.03240368132;4965.230389289666;4969.055879382906;5018.222175562793;4750.8337208197545;4878.146324393217;4927.975360123177;4948.05986862495;5007.8247261346405;4150.626443620028;4155.3766934959995;4215.199112168678;4218.8312467500955;4221.092465120014;3672.761270517408;3676.3933950898336;3676.485292059114;3691.9630803692157;3711.257748450321;4154.937675934863;4256.893577660521;4263.275243208662;4275.230458517497;4306.784660767012;4932.802687892444;4964.553190212898;4993.575546078551;5018.121828679967;5026.29631851541;4219.9789001055415;4251.426057482262;4262.531121576624;4290.034742183047;4295.656347492193;4278.379634952915;4464.866054018385;4464.955350446519;4465.218586747306;4488.865334039984;4745.715257084448;4770.61835053195;4784.995151018186;4786.497417771223;4808.63935204861;5068.873278168076;5075.416327122428;5075.822346217865;5077.441481437113;5077.898442031213;4562.771861406983;4614.861554153381;4734.526547345376;4779.689320194177;4857.489963553776;4864.562189402971;4883.462819089827;4895.265710143507;4931.2849636803185;4935.8025678972435;4932.136876046606;4955.55400013986;4960.627952903475;4966.230234313687;4971.37857767779;4669.229577119737;4817.8313759018265;4866.7079975201605;4901.436334821541;4902.485239049848;4861.295112208781;4862.489438608895;4870.707757534559;4880.755962201804;4933.136701077226;4792.281157826354;4803.903921921612;4804.663673542818;4807.903841923212;4824.638152138534;4675.041616468684;4710.175719249186;4783.06730187624;4844.273358996179;4915.680480768739;4743.501932297059;4759.928601071056;4772;4772.856814295576;4791.305260737243 22:05:07 INFO - PROCESS | 3399 | |1;ext.html;545.7765219326683;584.3192680527186;602.4607975861604;604.320139842677;613.775971770304;26348.868255658745;33536.832315838416;34426.48360274592;34518.13704657385;34622.826885865565;36881.44677829835;37641;37664.62335376645;37710.81144594273;37794.81102594483;7161.713531458736;7375.88936165958;7377.963110184468;7656.655450504741;7832.1776213497615;7219.386352160072;9648.80702385952;10022.59909603615;10045.64840230592;10047.698569042941;9523.57143928525;9585.089416505456;9596.232301415905;9599.664011759589;9601.615935362612;7353.77938661841;7693.807654808675;9726.027397260254;9821.754456138582;9837.360571562896;7483.550986940747;9503.382280151767;9737.561809718509;9737.707868763948;9738.41569505825;34071;34772.30455390878;34854.82572587146;34913.650863491544;34996;3107.456195165837;3228.2575007748114;3260.152360386293;3329.6503867094093;3424.178197232671;29199;29214.853925730236;29674.10977670652;29718.108456746333;30406.84796576025;3555.2000799819834;3574.767640103385;3582.659647333499;3685.262947410502;3747.6627103560536;225057;225705;226988.86505567533;228027.99999999834;229063;56117.42414774035;57186.714066430235;57227.42772572304;57340;57510;59462.40537594655;60789.69605152035;60877.69561152166;60883.39116608866;60888.69555652193;15298.770518442232;15479.84520154784;15550.300236489385;15598.142102184262;15607.765883511756;10154.898451015395;11105.777884442428;11226.66320010401;11258.324500529994;11834.704132396586;18748.531286717942;18838.81161188398;18850.434486965412;18860.15129319184;18864.24543018264;7108.045287545966;7144.142702875584;7407.925920740831;7471.663775130132;7549.7357592483995;867.9175478329548;950.2587981374539;952.4047470331043;960.711786464058;990.2177279948904;27499.86250068777;28144.510487940253;28423.71576284252;28482.572761408595;28821.711782881903;1012.448215722433;1016.8169729448622;1024.6208902705898;1053.8524606555088;1073.5544748929262;14651.853481465261;14688.926555367154;14809.407623695148;14885.851141488663;15294.847051529343;318196;323609;323971;324719;325025;49255.753721231165;49481.25778113331;49541.25688114681;49767.25349119766;49783.751081245086;1126.9042131418757;1235.8640549539723;1263.6398626391435;1282.557517656407;1291.367230057284;24888.875555622108;27438.862805686644;27487.862560687867;27901.441971160868;27966.720332797224;39111.80444097761;39206.411903820896;39606.40590391089;39610.40584391179;39696.404553931134;218438;219080;219367;220650;221042;22714.09143634236;25196;26187.869060654575;26236.60645090287;26448.471030579665;36624.63375366212;36635;37237.81381093077;37475.43786843254;37823.81088094652;33329.50005749867;33616.663833362334;33838.3232335347;34389.484157737155;34416.139596510286;33832.83083584566;34015.829920850236;34080.318393632486;34205.48691769576;34712.479312809824;34247.143821404665;36632;36893.44659830158;37775;38161.80919095498;29925;30806;31205.84397078091;31711.841440792647;31730.88941887023;24337.634935475628;24423;24700.25899223026;24965.87517062403;25085.49829003373 22:05:07 INFO - PROCESS | 3399 | |2;jquery.html;382.60400485497513;383.5972229159382;386.75054589789585;391.2956677979637;400.7675548182051;15093.320800563974;16135.354585816567;16299.837001629994;16312.592185195346;16317.673646527062;16305.347786088572;16616.335346586122;17261.741073883903;17366.392176273832;17376.47870563882;4989.600831933455;5115.053715062725;5156.716380599066;5165.9225111623355;5166.17341225404;3649.908752281201;5473.28847249857;5803.419658034205;5803.520102373889;5805.622634528763;5686.459786320293;5761.567882408815;5764.279465066867;5767.163761254616;5773.422657734235;5565.332160140769;5672.149177623348;5695.515881150107;5704.971475142618;5709.8572535686735;3313.4035873542753;4737.123632128068;5057.772400241961;5082.161443361841;5091.338126043591;18604.720929186074;19242.32651857192;19324.903375483173;19334.903325483425;19371.80628193714;1951.034238052159;1994.7107669387858;2028.5435776950217;2213.701150344699;2300.896459659319;12667.176633518884;12970.610881673565;13129.212247265099;13352.799708004388;13375;1750.3961133408955;1812.2026308424252;1824;1856.7214917762308;1870.5510677437453;66066.33933660698;69713.3028669712;69857;69958.65020674915;71168.64415677889;9262.953685231665;9354.625814967325;9555.808883822285;9596.808063838684;9798;13277.402516886763;13370;13418.731625367633;13448.731025379439;13470.326483675777;7329.706811727578;7349.191588925214;7402.33378995893;7453.329200371993;7474.065741782278;7052.576845389293;7069.363757261871;7095.290470952863;7202.71189152428;7223.422126229889;6038.577299589075;6230.906536401958;6236.906446403307;6252.3122456529745;6267.310595834455;1610.6859162463206;1646.9917650411671;1750.903700296496;1771.2641611221075;1810.7646006019133;783.5024759277786;867.9913200868036;935.2004036548789;980.2648013989508;981.259149342242;15841;16073.435558218325;17309.134543272787;17434.825651743573;17742.911285443748;897.2597606974273;903.742433406476;904.7014485219862;957.0333962697725;971.6064993677572;9710.95144524287;9810.607575697035;9956.452395118193;9979.251556133318;10086.899131008742;359156;361113;374091;375660;376057;65997.67001164964;66778;66876;67915;67999.66000169968;997.6408492942535;1001.4792307999945;1023.5649848814373;1041.4220107840222;1044.6448207609296;14991.2504374783;15080.245987700791;15134;15399.538013859603;15654.9217253913;23934.28197154088;28639.42721145607;31405.528917065807;31971.36057278888;33124.1718957028;42726.78636606797;42846.35730464108;43191.35212971871;43206.783966081224;43241.3513797287;7012.894806578008;7111.395531379891;7137.643117844191;7175.354218120394;7181.138263408425;10722.463876806285;10848.945755271174;10905.563777448813;11057.668269951915;11281.943590281997;9175.954120229357;9555.665551705657;9576.808463830544;9731.805363892825;9794.363366381162;9507.904920950701;9547.665831696135;9597.376170548892;9694.951525242328;9781.462019588991;9207.17135457812;9528.28537859677;9585.137337639368;9813.656522021694;10070;7270.491065625355;7335.963320183365;7338.302861228388;7370.48406611532;7451.329380355577;5261.5264626183825;6496.7726129585235;7339.74310899116;8744.431611945203;9816.312858099864 22:05:07 INFO - PROCESS | 3399 | |3;mootools.html;1182.9885447942015;1422.9857701422982;1454.2437932275218;1591.8487743664355;1765.6645237404891;7624.275693809086;7928.167542408043;7930.167332430098;7933.523988560691;7938.483998540098;7655.617219139049;7900.328472079866;7906.2884340409355;7909.050913890327;7916.089649690287;1949.512621844539;2075.8546901716923;2158.7625361210253;2193.4954960359128;2309.676645269655;2217.833662475313;2226.1095561775337;2227.3652009177385;2241.831862610303;2242.338510139513;2131.8187954023847;2168.3928500019942;2175.282156888231;2176.336217453676;2176.9129234830666;1871.8876867387933;2153.5262242306744;2191.233068426054;2192.6053310404122;2197.033305345643;2133.9466513337134;2146.61360955028;2149.6775483677416;2149.8280137588954;2184.1045171479777;7804.882926756103;7897.328727058207;7900;7906.090799558067;7911.248431399008;4622.422197225347;4784.186688262969;4797.856064318076;4807.326974223612;4881.902361952777;3036.104349216986;3099.7520198384077;3149.4173577888164;3156.7158955693867;3183.3792410479964;997.4264797741255;998.8152191844459;1009.7475631092227;1015.0509273828993;1025.7179275699168;10717.678469645924;10730.839037414446;10748.086412655011;10760.73098172544;10765.51555180011;4083.1221287423346;4475.977620111944;4482.327650852399;4482.8655140345845;4488.685791994529;9531.571079301448;9542.666006689733;9565.091316324939;9580.856287155559;9584.424934503952;4212.831486740496;4855.757212139379;4861.951380486221;4867.537583929521;4896.559309662148;3732.9813350933614;3942.211557688474;3950;4305.612494875413;4349.826006959686;3726.124360775216;3815.389537673959;3818.6181381861593;3890.902727431837;3908;1233.1860971758776;1237.4740735187509;1239.7644447554935;1242.428482897877;1252.273681264864;784.9686012559433;786.6892577431883;787.142015203431;806.9798255043671;810.7081450677751;5387.676739395649;5478.958997790487;5498.285222920995;5506.284183056177;5589.273394458775;887.7336798960287;897.9191872731485;908.9545522723837;914.1498406481903;935.219092058139;3699.093722038118;3700;3782.3569993101237;3806.657400833938;3823.235352929425;9285.907140928504;9454.196393306645;9493.525323733924;9564.808703825884;9597.520123993772;9612.951935240279;9663.178629816404;9749.658761943298;9783.804323913482;9860.06329398706;7237.746678866214;7678.117016543058;7686;7692.269234422721;7693.153753087156;5211.4527974562125;5422.701751403711;5495.862603434946;5591.692456914909;5658.575606829587;9316;9317;9330.95334523323;9390.906090939003;9454.149126578366;9174.724758257264;9491.952540237255;9501.239900808057;9518.190953769008;9532.094451027142;5806.535477161901;6150.600210986271;6274.278457977209;6292.716827742671;6294.0558916162945;7471.514351567131;7492;7504.362129219077;7504.887426688713;7529.736459223901;6527.314631963575;6713.362230588086;6739.258681545124;6763.458923286224;6871.5189936703955;6794.42247408956;6852.109225800813;6856.280090590416;6910.585364878123;6959.304069593;6235.875282494416;6346.619202847844;6347.5239357047485;6382.0745991831855;6433.260175079926;4615.030843522898;4620.907581848412;4670.065986802585;4700.247960326331;4749.596284315872;4497.100579883971;4520.88697782558;4547.704399214041;4555.703879247838;4652.069586082729 22:05:07 INFO - PROCESS | 3399 | |4;prototype.html;305.67598345753504;315.6937770362748;316.3088651296916;323.4678953122114;323.75999920305236;4910.508949105097;4920.360353154094;5086.186210206368;5184.9222261666055;5189.766460509277;4699.2951057341415;5083.491650834914;5110.182370820669;5124.615653825968;5144.279800827887;4048.534418541861;4050.959490405095;4066.8169932352966;4068.430419741224;4073.775942323171;3837.1174629835155;3900.726949113549;4046.4941882264716;4059.776712280823;4069.633732964033;3965.8017099145072;3991.820368083443;3997.900052498682;3998.360262358023;4001.6398524132824;3992.5408578013466;4003.3794761811964;4006.639402453764;4013.2776100301935;4013.7391069580385;3507.719382449398;3561.9643803561894;3577.1951310955087;3578.3380074686006;3585.2829434113282;4873.269009648546;4880.121578115938;4882.292067650206;4889.33993910821;4898.926516102261;4552.931706024412;4571.497135315112;4575.9771201143785;4577.33628623851;4579.4504659440745;5224.50367215114;5315.627906046579;5319.148936170232;5331.760070796823;5341.919871201935;3837.0791010157363;3845.750026248285;3851.364524853424;3853.2293541291856;3861.864834730799;5218.191180367049;5487.890242195173;5551.444855514456;5579.776808927638;5590.301212348457;3830.367989281737;3896.357101078347;3896.9610303896598;3900.5904380039688;3988.6210809973004;4025.255327764314;4028.959710402917;4035.354343305116;4047.6761859051207;4065.4105154752397;4562.133194692998;4564.908701825945;4568.6116680081905;4594.379758732528;4603.355530225771;5093.923591146136;5365.746386517672;5366.114591092504;5366.570674346043;5381.973090134525;1325.3307079924577;1351.5740893357406;1357.382391012087;1358.6127953533196;1360.2654566534159;890.8063195318305;912.1608120529129;932.3659911260409;933.7152168588646;935.2284365398438;4697.929531057037;4703.764811759467;4706.788194531255;4706.835260765857;4721.976390118028;5544.140658197985;5544.889102217933;5547.639403438763;5548.751530905514;5567.164925261243;4592.586667199968;4648.535146485325;4682.180618391836;4684.461286951976;4689.179393606105;2948.2924098216704;2966;2970.138659788637;2982.492976194052;2983.3287510310006;5209.557187639018;5218.556422704037;5222.791088356499;5231.581473482112;5232.424433312332;5401.918971215435;5667.716614169358;5680.403557626472;5721.542276617861;5744.569157313134;5251.501107394792;5274.446183150791;5277.445868183939;5292.311999440049;5295.920561191585;5587.972060139673;5601.579881508822;5606.551475882001;5613.747381367766;5621.241132447068;5274.525292723673;5405.72971351423;5447.836564903059;5452.100403433389;5460.099083651153;4985.656741331569;5139.126348520836;5144;5144.273535026442;5211.661242019257;3717.4609681596557;3742.7005839533317;3864.787436691009;3884.1454879926373;3891.1905963727004;5507.228987941771;5512.200730894078;5515.283013208257;5515.503604675599;5533.391326954113;5122.410922743932;5335.813246536352;5365.78053168096;5382.219578161223;5383.596230282823;5356.839294821161;5360.356757189163;5397.757100930389;5403.594730395314;5406.621536492565;5202.453742357149;5311.167647161723;5318.388385335581;5327.653702509325;5337.066013447554;5329.7068661224;5392.438591668926;5437.592180586393;5443.836684899459;5468.234447177478;5293.232481290268;5296.629235953446;5305.204219367126;5321.813736519203;5322.520973112439 22:05:07 INFO - PROCESS | 3399 | |5;yui.html;741.8219627289452;743.1973468653854;748.7267147491166;781.0393216343897;787.1223585701943;12833.42249598768;13401.396937137828;13402.128861623987;13433.596992090228;13469.191848489098;13945.930270348634;14000.509982150626;14003.929980350109;14080.577582672511;14113;635.2599221906473;804.6419343392164;826.7974346285154;831.4387788242942;833.4874052457725;824.2952275804191;829.8257365953157;829.8755186721979;830.3149901331426;830.4975489828657;858.7681326041965;863.365426411587;863.5854789700948;864.4078806017866;864.5461132905212;663.2770280394393;833.0960907415462;855.8245559660255;863.1799790199273;864.0365991919028;624.7126321891935;625.3746253746253;625.4183609243402;626.9686515674198;627.8116565030473;12078.335691536962;12078.939605302005;12123.33321667308;12174.756504869942;12179.269243845398;11983.400829958468;12297.3236471994;12467.438965246585;12491.875081249162;12497.625071247878;10099.29304948654;10118.89881101187;10139.645112421103;10167.898321016843;10307.381557106522;3301.900942971715;3343.0806528204694;3385.339858727549;3401.1157099154398;3456.1186897341267;44938.77530612326;45195.32207016897;45341.09317813625;45440.77279613614;45760.7711961438;9681;9773.07155820196;9808.313418060667;9889.60441582343;9908.653197138066;17383.73924391135;17434.47696569105;17500.21249043796;17506.12469376526;17506.64986700259;6487.481001519867;6520.445762110179;6543;6566.047923051131;6656.7670131545165;3731.440283957428;3744.1575645480093;3795.886123416302;3819.6180381962135;3876.7480113792512;2901.419716056797;2980.1953472562286;2984.940301193964;2985.477541430241;2985.507391280458;501.95231453011905;514.4289838279507;521.439452588469;527.6728428374432;530.4483337329134;624.9281332646713;659.2418718473793;661.9404253617198;670.5767157565797;691.1015679616479;7909.960450197712;8036.196380362034;8076.3942704297415;8318.792030199173;8363.330933525303;538.265267909301;589.9321578018497;649.5647915896361;650.9609423434514;659.307726886767;3856.421536769507;3906.1015966327336;3948.0919388540224;3996.500437445319;4031.455753473302;49029.50970490249;49192.754036230304;49300.26049609259;50424;50646;43925.341119883225;44158.55841441609;44827.55172448299;44966.77516612396;45451.54548454539;40550.18899621991;40741.185176296305;40951;41659.7917010413;41837.37243941343;7476.028116344841;7541.585212813348;7604.885926710993;7711.305982461606;7748.302652761278;28272.71727282701;28728.425431491672;28738.85630571834;29229;29231.123066308046;36396.27207455783;36840.815795921924;36951.48960848715;37937.48250070077;41638.37542436927;11412.771744564896;11511.30932144074;11526.250793698382;11691.473883675086;11792.469338879942;12006.459709312927;12081.214721043105;12593.307368094842;12619.873801262238;12884.613461595793;10919.454027298762;11066.889331106586;11178.0498657615;11565.653030409101;11614.767704646029;11408.543658253577;11634.70913227176;11665.708357291136;12139.817902731289;12213.816792748294;10844.403557804397;10984.286021408583;11076.667699969013;11205.66383008511;11587.88412115868;9579.521023948913;9591.136797688241;9639.90360096418;9895.851562226428;10047;9737.805243895224;9765.121139097515;9937.155341796028;9992.20062394992;10077.647282345082 22:05:07 INFO - PROCESS | 3399 | __end_tp_report 22:05:07 INFO - PROCESS | 3399 | __start_cc_report 22:05:07 INFO - PROCESS | 3399 | _x_x_mozilla_cycle_collect,1175 22:05:07 INFO - PROCESS | 3399 | __end_cc_report 22:05:07 INFO - PROCESS | 3399 | __startTimestamp1460869507954__endTimestamp 22:05:07 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | ------- Summary: start ------- 22:05:07 INFO - PROCESS | 3399 | Number of tests: 6 22:05:07 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | [#0] dojo.html Cycles:165 Average:4604.40 Median:4750.83 stddev:478.95 (10.1%) stddev-sans-first:454.62 22:05:07 INFO - PROCESS | 3399 | Values: 2627.8 2664.3 2672.6 2702.3 2716.7 4481.1 4587.3 4662.5 4690.2 4706.7 4669.3 4706.6 4712.9 4739.0 4810.4 4251.7 4298.2 4342.1 4365.6 4448.4 4373.0 4395.0 4420.5 4428.9 4452.6 4176.6 4244.4 4274.8 4312.5 4331.8 4223.4 4275.4 4283.4 4284.3 4331.5 4186.5 4190.8 4200.9 4228.0 4231.6 4341.9 4481.7 4531.3 4611.7 4638.7 4946.5 4951.5 4957.1 4963.9 4990.6 4976.2 4991.3 4993.0 4993.6 5049.9 4503.3 4629.5 4691.3 4737.9 4744.6 5128.3 5139.4 5160.6 5161.9 5177.5 4768.2 4933.3 4945.0 4947.7 4994.4 4947.4 4988.2 5008.9 5038.6 5043.3 4939.6 4962.0 4965.2 4969.1 5018.2 4750.8 4878.1 4928.0 4948.1 5007.8 4150.6 4155.4 4215.2 4218.8 4221.1 3672.8 3676.4 3676.5 3692.0 3711.3 4154.9 4256.9 4263.3 4275.2 4306.8 4932.8 4964.6 4993.6 5018.1 5026.3 4220.0 4251.4 4262.5 4290.0 4295.7 4278.4 4464.9 4465.0 4465.2 4488.9 4745.7 4770.6 4785.0 4786.5 4808.6 5068.9 5075.4 5075.8 5077.4 5077.9 4562.8 4614.9 4734.5 4779.7 4857.5 4864.6 4883.5 4895.3 4931.3 4935.8 4932.1 4955.6 4960.6 4966.2 4971.4 4669.2 4817.8 4866.7 4901.4 4902.5 4861.3 4862.5 4870.7 4880.8 4933.1 4792.3 4803.9 4804.7 4807.9 4824.6 4675.0 4710.2 4783.1 4844.3 4915.7 4743.5 4759.9 4772.0 4772.9 4791.3 22:05:07 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | [#1] ext.html Cycles:180 Average:42014.95 Median:34142.90 stddev:68175.52 (199.7%) stddev-sans-first:68295.67 22:05:07 INFO - PROCESS | 3399 | Values: 545.8 584.3 602.5 604.3 613.8 26348.9 33536.8 34426.5 34518.1 34622.8 36881.4 37641.0 37664.6 37710.8 37794.8 7161.7 7375.9 7378.0 7656.7 7832.2 7219.4 9648.8 10022.6 10045.6 10047.7 9523.6 9585.1 9596.2 9599.7 9601.6 7353.8 7693.8 9726.0 9821.8 9837.4 7483.6 9503.4 9737.6 9737.7 9738.4 34071.0 34772.3 34854.8 34913.7 34996.0 3107.5 3228.3 3260.2 3329.7 3424.2 29199.0 29214.9 29674.1 29718.1 30406.8 3555.2 3574.8 3582.7 3685.3 3747.7 225057.0 225705.0 226988.9 228028.0 229063.0 56117.4 57186.7 57227.4 57340.0 57510.0 59462.4 60789.7 60877.7 60883.4 60888.7 15298.8 15479.8 15550.3 15598.1 15607.8 10154.9 11105.8 11226.7 11258.3 11834.7 18748.5 18838.8 18850.4 18860.2 18864.2 7108.0 7144.1 7407.9 7471.7 7549.7 867.9 950.3 952.4 960.7 990.2 27499.9 28144.5 28423.7 28482.6 28821.7 1012.4 1016.8 1024.6 1053.9 1073.6 14651.9 14688.9 14809.4 14885.9 15294.8 318196.0 323609.0 323971.0 324719.0 325025.0 49255.8 49481.3 49541.3 49767.3 49783.8 1126.9 1235.9 1263.6 1282.6 1291.4 24888.9 27438.9 27487.9 27901.4 27966.7 39111.8 39206.4 39606.4 39610.4 39696.4 218438.0 219080.0 219367.0 220650.0 221042.0 22714.1 25196.0 26187.9 26236.6 26448.5 36624.6 36635.0 37237.8 37475.4 37823.8 33329.5 33616.7 33838.3 34389.5 34416.1 33832.8 34015.8 34080.3 34205.5 34712.5 34247.1 36632.0 36893.4 37775.0 38161.8 29925.0 30806.0 31205.8 31711.8 31730.9 24337.6 24423.0 24700.3 24965.9 25085.5 22:05:07 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | [#2] jquery.html Cycles:180 Average:22964.22 Median:5166.05 stddev:60789.64 (1176.7%) stddev-sans-first:60936.53 22:05:07 INFO - PROCESS | 3399 | Values: 382.6 383.6 386.8 391.3 400.8 15093.3 16135.4 16299.8 16312.6 16317.7 16305.3 16616.3 17261.7 17366.4 17376.5 4989.6 5115.1 5156.7 5165.9 5166.2 3649.9 5473.3 5803.4 5803.5 5805.6 5686.5 5761.6 5764.3 5767.2 5773.4 5565.3 5672.1 5695.5 5705.0 5709.9 3313.4 4737.1 5057.8 5082.2 5091.3 18604.7 19242.3 19324.9 19334.9 19371.8 1951.0 1994.7 2028.5 2213.7 2300.9 12667.2 12970.6 13129.2 13352.8 13375.0 1750.4 1812.2 1824.0 1856.7 1870.6 66066.3 69713.3 69857.0 69958.7 71168.6 9263.0 9354.6 9555.8 9596.8 9798.0 13277.4 13370.0 13418.7 13448.7 13470.3 7329.7 7349.2 7402.3 7453.3 7474.1 7052.6 7069.4 7095.3 7202.7 7223.4 6038.6 6230.9 6236.9 6252.3 6267.3 1610.7 1647.0 1750.9 1771.3 1810.8 783.5 868.0 935.2 980.3 981.3 15841.0 16073.4 17309.1 17434.8 17742.9 897.3 903.7 904.7 957.0 971.6 9711.0 9810.6 9956.5 9979.3 10086.9 359156.0 361113.0 374091.0 375660.0 376057.0 65997.7 66778.0 66876.0 67915.0 67999.7 997.6 1001.5 1023.6 1041.4 1044.6 14991.3 15080.2 15134.0 15399.5 15654.9 23934.3 28639.4 31405.5 31971.4 33124.2 42726.8 42846.4 43191.4 43206.8 43241.4 7012.9 7111.4 7137.6 7175.4 7181.1 10722.5 10848.9 10905.6 11057.7 11281.9 9176.0 9555.7 9576.8 9731.8 9794.4 9507.9 9547.7 9597.4 9695.0 9781.5 9207.2 9528.3 9585.1 9813.7 10070.0 7270.5 7336.0 7338.3 7370.5 7451.3 5261.5 6496.8 7339.7 8744.4 9816.3 22:05:07 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | [#3] mootools.html Cycles:180 Average:5230.01 Median:5450.83 stddev:2926.59 (53.7%) stddev-sans-first:2919.00 22:05:07 INFO - PROCESS | 3399 | Values: 1183.0 1423.0 1454.2 1591.8 1765.7 7624.3 7928.2 7930.2 7933.5 7938.5 7655.6 7900.3 7906.3 7909.1 7916.1 1949.5 2075.9 2158.8 2193.5 2309.7 2217.8 2226.1 2227.4 2241.8 2242.3 2131.8 2168.4 2175.3 2176.3 2176.9 1871.9 2153.5 2191.2 2192.6 2197.0 2133.9 2146.6 2149.7 2149.8 2184.1 7804.9 7897.3 7900.0 7906.1 7911.2 4622.4 4784.2 4797.9 4807.3 4881.9 3036.1 3099.8 3149.4 3156.7 3183.4 997.4 998.8 1009.7 1015.1 1025.7 10717.7 10730.8 10748.1 10760.7 10765.5 4083.1 4476.0 4482.3 4482.9 4488.7 9531.6 9542.7 9565.1 9580.9 9584.4 4212.8 4855.8 4862.0 4867.5 4896.6 3733.0 3942.2 3950.0 4305.6 4349.8 3726.1 3815.4 3818.6 3890.9 3908.0 1233.2 1237.5 1239.8 1242.4 1252.3 785.0 786.7 787.1 807.0 810.7 5387.7 5479.0 5498.3 5506.3 5589.3 887.7 897.9 909.0 914.1 935.2 3699.1 3700.0 3782.4 3806.7 3823.2 9285.9 9454.2 9493.5 9564.8 9597.5 9613.0 9663.2 9749.7 9783.8 9860.1 7237.7 7678.1 7686.0 7692.3 7693.2 5211.5 5422.7 5495.9 5591.7 5658.6 9316.0 9317.0 9331.0 9390.9 9454.1 9174.7 9492.0 9501.2 9518.2 9532.1 5806.5 6150.6 6274.3 6292.7 6294.1 7471.5 7492.0 7504.4 7504.9 7529.7 6527.3 6713.4 6739.3 6763.5 6871.5 6794.4 6852.1 6856.3 6910.6 6959.3 6235.9 6346.6 6347.5 6382.1 6433.3 4615.0 4620.9 4670.1 4700.2 4749.6 4497.1 4520.9 4547.7 4555.7 4652.1 22:05:07 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | [#4] prototype.html Cycles:180 Average:4456.95 Median:5090.05 stddev:1290.66 (25.4%) stddev-sans-first:1256.10 22:05:07 INFO - PROCESS | 3399 | Values: 305.7 315.7 316.3 323.5 323.8 4910.5 4920.4 5086.2 5184.9 5189.8 4699.3 5083.5 5110.2 5124.6 5144.3 4048.5 4051.0 4066.8 4068.4 4073.8 3837.1 3900.7 4046.5 4059.8 4069.6 3965.8 3991.8 3997.9 3998.4 4001.6 3992.5 4003.4 4006.6 4013.3 4013.7 3507.7 3562.0 3577.2 3578.3 3585.3 4873.3 4880.1 4882.3 4889.3 4898.9 4552.9 4571.5 4576.0 4577.3 4579.5 5224.5 5315.6 5319.1 5331.8 5341.9 3837.1 3845.8 3851.4 3853.2 3861.9 5218.2 5487.9 5551.4 5579.8 5590.3 3830.4 3896.4 3897.0 3900.6 3988.6 4025.3 4029.0 4035.4 4047.7 4065.4 4562.1 4564.9 4568.6 4594.4 4603.4 5093.9 5365.7 5366.1 5366.6 5382.0 1325.3 1351.6 1357.4 1358.6 1360.3 890.8 912.2 932.4 933.7 935.2 4697.9 4703.8 4706.8 4706.8 4722.0 5544.1 5544.9 5547.6 5548.8 5567.2 4592.6 4648.5 4682.2 4684.5 4689.2 2948.3 2966.0 2970.1 2982.5 2983.3 5209.6 5218.6 5222.8 5231.6 5232.4 5401.9 5667.7 5680.4 5721.5 5744.6 5251.5 5274.4 5277.4 5292.3 5295.9 5588.0 5601.6 5606.6 5613.7 5621.2 5274.5 5405.7 5447.8 5452.1 5460.1 4985.7 5139.1 5144.0 5144.3 5211.7 3717.5 3742.7 3864.8 3884.1 3891.2 5507.2 5512.2 5515.3 5515.5 5533.4 5122.4 5335.8 5365.8 5382.2 5383.6 5356.8 5360.4 5397.8 5403.6 5406.6 5202.5 5311.2 5318.4 5327.7 5337.1 5329.7 5392.4 5437.6 5443.8 5468.2 5293.2 5296.6 5305.2 5321.8 5322.5 22:05:07 INFO - PROCESS | 3399 | 22:05:07 INFO - PROCESS | 3399 | [#5] yui.html Cycles:180 Average:12713.67 Median:41748.58 stddev:13930.36 (33.4%) stddev-sans-first:13940.42 22:05:07 INFO - PROCESS | 3399 | Values: 741.8 743.2 748.7 781.0 787.1 12833.4 13401.4 13402.1 13433.6 13469.2 13945.9 14000.5 14003.9 14080.6 14113.0 635.3 804.6 826.8 831.4 833.5 824.3 829.8 829.9 830.3 830.5 858.8 863.4 863.6 864.4 864.5 663.3 833.1 855.8 863.2 864.0 624.7 625.4 625.4 627.0 627.8 12078.3 12078.9 12123.3 12174.8 12179.3 11983.4 12297.3 12467.4 12491.9 12497.6 10099.3 10118.9 10139.6 10167.9 10307.4 3301.9 3343.1 3385.3 3401.1 3456.1 44938.8 45195.3 45341.1 45440.8 45760.8 9681.0 9773.1 9808.3 9889.6 9908.7 17383.7 17434.5 17500.2 17506.1 17506.6 6487.5 6520.4 6543.0 6566.0 6656.8 3731.4 3744.2 3795.9 3819.6 3876.7 2901.4 2980.2 2984.9 2985.5 2985.5 502.0 514.4 521.4 527.7 530.4 624.9 659.2 661.9 670.6 691.1 7910.0 8036.2 8076.4 8318.8 8363.3 538.3 589.9 649.6 651.0 659.3 3856.4 3906.1 3948.1 3996.5 4031.5 49029.5 49192.8 49300.3 50424.0 50646.0 43925.3 44158.6 44827.6 44966.8 45451.5 40550.2 40741.2 40951.0 41659.8 41837.4 7476.0 7541.6 7604.9 7711.3 7748.3 28272.7 28728.4 28738.9 29229.0 29231.1 36396.3 36840.8 36951.5 37937.5 41638.4 11412.8 11511.3 11526.3 11691.5 11792.5 12006.5 12081.2 12593.3 12619.9 12884.6 10919.5 11066.9 11178.0 11565.7 11614.8 11408.5 11634.7 11665.7 12139.8 12213.8 10844.4 10984.3 11076.7 11205.7 11587.9 9579.5 9591.1 9639.9 9895.9 10047.0 9737.8 9765.1 9937.2 9992.2 10077.6 22:05:07 INFO - PROCESS | 3399 | -------- Summary: end -------- 22:05:07 INFO - PROCESS | 3399 | 22:05:08 INFO - TEST-INFO | 3399: exit 0 22:05:08 INFO - TEST-OK | dromaeo_css | took 1120358ms 22:05:08 INFO - TEST-START | kraken 22:05:08 INFO - operating with platform_type : linux_ 22:05:08 INFO - Initialising browser for kraken test... 22:05:08 INFO - TEST-INFO | started process 3578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY9s0xq/profile http://localhost:36358/getInfo.html) 22:05:12 INFO - PROCESS | 3578 | __metrics Screen width/height:1600/1200 22:05:12 INFO - PROCESS | 3578 | colorDepth:24 22:05:12 INFO - PROCESS | 3578 | Browser inner width/height: 1024/697 22:05:12 INFO - PROCESS | 3578 | __metrics 22:05:13 ERROR - PROCESS | 3578 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:05:14 INFO - TEST-INFO | 3578: exit 0 22:05:14 INFO - Browser initialized. 22:05:14 INFO - Running cycle 1/1 for kraken test... 22:05:14 INFO - TEST-INFO | started process 3659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY9s0xq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:26 INFO - PROCESS | 3659 | RSS: Main: 155082752 22:05:26 INFO - PROCESS | 3659 | 22:05:29 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36358/tests/kraken/driver.html?testName=audio-beat-detection) 22:05:30 INFO - PROCESS | 3659 | RSS: Main: 210071552 22:05:30 INFO - PROCESS | 3659 | 22:05:33 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36358/tests/kraken/driver.html?testName=audio-dft) 22:05:33 INFO - PROCESS | 3659 | RSS: Main: 195383296 22:05:33 INFO - PROCESS | 3659 | 22:05:37 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36358/tests/kraken/driver.html?testName=audio-fft) 22:05:37 INFO - PROCESS | 3659 | RSS: Main: 264916992 22:05:37 INFO - PROCESS | 3659 | 22:05:39 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36358/tests/kraken/driver.html?testName=audio-oscillator) 22:05:40 INFO - PROCESS | 3659 | RSS: Main: 174850048 22:05:40 INFO - PROCESS | 3659 | 22:05:42 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:05:43 INFO - PROCESS | 3659 | RSS: Main: 179044352 22:05:43 INFO - PROCESS | 3659 | 22:05:46 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36358/tests/kraken/driver.html?testName=imaging-darkroom) 22:05:46 INFO - PROCESS | 3659 | RSS: Main: 214417408 22:05:46 INFO - PROCESS | 3659 | 22:05:50 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36358/tests/kraken/driver.html?testName=imaging-desaturate) 22:05:50 INFO - PROCESS | 3659 | RSS: Main: 215543808 22:05:50 INFO - PROCESS | 3659 | 22:05:53 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36358/tests/kraken/driver.html?testName=json-parse-financial) 22:05:54 INFO - PROCESS | 3659 | RSS: Main: 215351296 22:05:54 INFO - PROCESS | 3659 | 22:05:56 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:05:56 INFO - PROCESS | 3659 | RSS: Main: 200273920 22:05:56 INFO - PROCESS | 3659 | 22:05:58 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36358/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:05:59 INFO - PROCESS | 3659 | RSS: Main: 202719232 22:05:59 INFO - PROCESS | 3659 | 22:06:01 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:02 INFO - PROCESS | 3659 | RSS: Main: 219586560 22:06:02 INFO - PROCESS | 3659 | 22:06:04 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:05 INFO - PROCESS | 3659 | RSS: Main: 224268288 22:06:05 INFO - PROCESS | 3659 | 22:06:08 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:08 INFO - PROCESS | 3659 | RSS: Main: 220504064 22:06:08 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | Cycle 1(1): loaded http://localhost:36358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36358/tests/kraken/driver.html?testName=ai-astar) 22:06:10 INFO - PROCESS | 3659 | RSS: Main: 282910720 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | __start_tp_report 22:06:10 INFO - PROCESS | 3659 | _x_x_mozilla_page_load 22:06:10 INFO - PROCESS | 3659 | _x_x_mozilla_page_load_details 22:06:10 INFO - PROCESS | 3659 | |i|pagename|runs| 22:06:10 INFO - PROCESS | 3659 | |0;ai-astar;111;114;110;111;115;114;103;114;113;113 22:06:10 INFO - PROCESS | 3659 | |1;audio-beat-detection;163;133;160;193;141;156;153;141;195;135 22:06:10 INFO - PROCESS | 3659 | |2;audio-dft;163;161;163;163;162;162;170;164;161;163 22:06:10 INFO - PROCESS | 3659 | |3;audio-fft;77;73;95;115;74;77;72;113;99;73 22:06:10 INFO - PROCESS | 3659 | |4;audio-oscillator;93;95;136;94;93;95;142;94;95;148 22:06:10 INFO - PROCESS | 3659 | |5;imaging-gaussian-blur;117;117;117;118;117;117;116;117;117;117 22:06:10 INFO - PROCESS | 3659 | |6;imaging-darkroom;148;146;147;146;147;147;147;148;146;146 22:06:10 INFO - PROCESS | 3659 | |7;imaging-desaturate;94;94;94;95;95;95;95;94;94;95 22:06:10 INFO - PROCESS | 3659 | |8;json-parse-financial;65;65;65;64;65;65;65;93;64;64 22:06:10 INFO - PROCESS | 3659 | |9;json-stringify-tinderbox;65;64;64;70;65;67;65;64;65;64 22:06:10 INFO - PROCESS | 3659 | |10;stanford-crypto-aes;78;79;78;78;81;77;79;80;79;79 22:06:10 INFO - PROCESS | 3659 | |11;stanford-crypto-ccm;137;140;139;132;134;133;137;131;166;135 22:06:10 INFO - PROCESS | 3659 | |12;stanford-crypto-pbkdf2;175;173;182;181;175;183;180;179;173;174 22:06:10 INFO - PROCESS | 3659 | |13;stanford-crypto-sha256-iterative;75;73;74;74;71;71;74;70;72;70 22:06:10 INFO - PROCESS | 3659 | __end_tp_report 22:06:10 INFO - PROCESS | 3659 | __start_cc_report 22:06:10 INFO - PROCESS | 3659 | _x_x_mozilla_cycle_collect,1896 22:06:10 INFO - PROCESS | 3659 | __end_cc_report 22:06:10 INFO - PROCESS | 3659 | __startTimestamp1460869570952__endTimestamp 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | ------- Summary: start ------- 22:06:10 INFO - PROCESS | 3659 | Number of tests: 14 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:3.49 (3.1%) stddev-sans-first:3.69 22:06:10 INFO - PROCESS | 3659 | Values: 111.0 114.0 110.0 111.0 115.0 114.0 103.0 114.0 113.0 113.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:158.00 stddev:22.05 (14.0%) stddev-sans-first:23.28 22:06:10 INFO - PROCESS | 3659 | Values: 163.0 133.0 160.0 193.0 141.0 156.0 153.0 141.0 195.0 135.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.57 (1.6%) stddev-sans-first:2.73 22:06:10 INFO - PROCESS | 3659 | Values: 163.0 161.0 163.0 163.0 162.0 162.0 170.0 164.0 161.0 163.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#3] audio-fft Cycles:10 Average:86.80 Median:75.50 stddev:17.17 (22.7%) stddev-sans-first:17.84 22:06:10 INFO - PROCESS | 3659 | Values: 77.0 73.0 95.0 115.0 74.0 77.0 72.0 113.0 99.0 73.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:94.00 stddev:23.30 (24.8%) stddev-sans-first:24.03 22:06:10 INFO - PROCESS | 3659 | Values: 93.0 95.0 136.0 94.0 93.0 95.0 142.0 94.0 95.0 148.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 22:06:10 INFO - PROCESS | 3659 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 22:06:10 INFO - PROCESS | 3659 | Values: 148.0 146.0 147.0 146.0 147.0 147.0 147.0 148.0 146.0 146.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 22:06:10 INFO - PROCESS | 3659 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:65.00 stddev:8.97 (13.8%) stddev-sans-first:9.47 22:06:10 INFO - PROCESS | 3659 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 65.0 93.0 64.0 64.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.89 (2.9%) stddev-sans-first:2.00 22:06:10 INFO - PROCESS | 3659 | Values: 65.0 64.0 64.0 70.0 65.0 67.0 65.0 64.0 65.0 64.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:1.14 (1.4%) stddev-sans-first:1.17 22:06:10 INFO - PROCESS | 3659 | Values: 78.0 79.0 78.0 78.0 81.0 77.0 79.0 80.0 79.0 79.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:137.00 stddev:10.13 (7.4%) stddev-sans-first:10.74 22:06:10 INFO - PROCESS | 3659 | Values: 137.0 140.0 139.0 132.0 134.0 133.0 137.0 131.0 166.0 135.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:179.50 stddev:3.89 (2.2%) stddev-sans-first:4.02 22:06:10 INFO - PROCESS | 3659 | Values: 175.0 173.0 182.0 181.0 175.0 183.0 180.0 179.0 173.0 174.0 22:06:10 INFO - PROCESS | 3659 | 22:06:10 INFO - PROCESS | 3659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.50 stddev:1.84 (2.5%) stddev-sans-first:1.69 22:06:10 INFO - PROCESS | 3659 | Values: 75.0 73.0 74.0 74.0 71.0 71.0 74.0 70.0 72.0 70.0 22:06:10 INFO - PROCESS | 3659 | -------- Summary: end -------- 22:06:10 INFO - PROCESS | 3659 | 22:06:11 INFO - TEST-INFO | 3659: exit 0 22:06:12 INFO - TEST-OK | kraken | took 63270ms 22:06:12 INFO - SUITE-END | took 1183s 22:06:12 INFO - Completed test suite (00:19:43) 22:06:12 INFO - javascript benchmark 22:06:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.7897768178545, 2664.33391652087, 2672.5991101334803, 2702.2838947678856, 2716.6875809281937, 4481.126180394825, 4587.334836448713, 4662.53374662534, 4690.202665546861, 4706.670533062683, 4669.252919532875, 4706.599939005188, 4712.892470269492, 4739.028499157673, 4810.39870016248, 4251.723637963538, 4298.226319262531, 4342.109867477176, 4365.563443655641, 4448.4439445069365, 4372.97813510932, 4394.956050439487, 4420.46954365475, 4428.933565996513, 4452.554744525554, 4176.644985176248, 4244.384564238199, 4274.786260686984, 4312.482502099737, 4331.7617531035785, 4223.408722778813, 4275.40144379787, 4283.378910058055, 4284.314509678467, 4331.480222373304, 4186.455760751113, 4190.811413486401, 4200.936985945214, 4227.978860105711, 4231.619154276099, 4341.869743907688, 4481.708688935241, 4531.297648864432, 4611.700239484423, 4638.744869032202, 4946.505349465061, 4951.529604687549, 4957.058158949824, 4963.851084467436, 4990.600751939873, 4976.178930476503, 4991.306433239413, 4993.0, 4993.625478089158, 5049.924251136236, 4503.347014682852, 4629.537046295343, 4691.296305554194, 4737.9052418952115, 4744.620430365562, 5128.3076784633595, 5139.357580302462, 5160.561352285023, 5161.870953226199, 5177.4822517747925, 4768.237082066853, 4933.260010998307, 4945.0, 4947.6536642434685, 4994.425641051325, 4947.381577302837, 4988.176950803149, 5008.949910500921, 5038.571721403649, 5043.293938848564, 4939.629527785359, 4962.03240368132, 4965.230389289666, 4969.055879382906, 5018.222175562793, 4750.8337208197545, 4878.146324393217, 4927.975360123177, 4948.05986862495, 5007.8247261346405, 4150.626443620028, 4155.3766934959995, 4215.199112168678, 4218.8312467500955, 4221.092465120014, 3672.761270517408, 3676.3933950898336, 3676.485292059114, 3691.9630803692157, 3711.257748450321, 4154.937675934863, 4256.893577660521, 4263.275243208662, 4275.230458517497, 4306.784660767012, 4932.802687892444, 4964.553190212898, 4993.575546078551, 5018.121828679967, 5026.29631851541, 4219.9789001055415, 4251.426057482262, 4262.531121576624, 4290.034742183047, 4295.656347492193, 4278.379634952915, 4464.866054018385, 4464.955350446519, 4465.218586747306, 4488.865334039984, 4745.715257084448, 4770.61835053195, 4784.995151018186, 4786.497417771223, 4808.63935204861, 5068.873278168076, 5075.416327122428, 5075.822346217865, 5077.441481437113, 5077.898442031213, 4562.771861406983, 4614.861554153381, 4734.526547345376, 4779.689320194177, 4857.489963553776, 4864.562189402971, 4883.462819089827, 4895.265710143507, 4931.2849636803185, 4935.8025678972435, 4932.136876046606, 4955.55400013986, 4960.627952903475, 4966.230234313687, 4971.37857767779, 4669.229577119737, 4817.8313759018265, 4866.7079975201605, 4901.436334821541, 4902.485239049848, 4861.295112208781, 4862.489438608895, 4870.707757534559, 4880.755962201804, 4933.136701077226, 4792.281157826354, 4803.903921921612, 4804.663673542818, 4807.903841923212, 4824.638152138534, 4675.041616468684, 4710.175719249186, 4783.06730187624, 4844.273358996179, 4915.680480768739, 4743.501932297059, 4759.928601071056, 4772.0, 4772.856814295576, 4791.305260737243], "value": 4574.754406577908, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.7765219326683, 584.3192680527186, 602.4607975861604, 604.320139842677, 613.775971770304, 26348.868255658745, 33536.832315838416, 34426.48360274592, 34518.13704657385, 34622.826885865565, 36881.44677829835, 37641.0, 37664.62335376645, 37710.81144594273, 37794.81102594483, 7161.713531458736, 7375.88936165958, 7377.963110184468, 7656.655450504741, 7832.1776213497615, 7219.386352160072, 9648.80702385952, 10022.59909603615, 10045.64840230592, 10047.698569042941, 9523.57143928525, 9585.089416505456, 9596.232301415905, 9599.664011759589, 9601.615935362612, 7353.77938661841, 7693.807654808675, 9726.027397260254, 9821.754456138582, 9837.360571562896, 7483.550986940747, 9503.382280151767, 9737.561809718509, 9737.707868763948, 9738.41569505825, 34071.0, 34772.30455390878, 34854.82572587146, 34913.650863491544, 34996.0, 3107.456195165837, 3228.2575007748114, 3260.152360386293, 3329.6503867094093, 3424.178197232671, 29199.0, 29214.853925730236, 29674.10977670652, 29718.108456746333, 30406.84796576025, 3555.2000799819834, 3574.767640103385, 3582.659647333499, 3685.262947410502, 3747.6627103560536, 225057.0, 225705.0, 226988.86505567533, 228027.99999999834, 229063.0, 56117.42414774035, 57186.714066430235, 57227.42772572304, 57340.0, 57510.0, 59462.40537594655, 60789.69605152035, 60877.69561152166, 60883.39116608866, 60888.69555652193, 15298.770518442232, 15479.84520154784, 15550.300236489385, 15598.142102184262, 15607.765883511756, 10154.898451015395, 11105.777884442428, 11226.66320010401, 11258.324500529994, 11834.704132396586, 18748.531286717942, 18838.81161188398, 18850.434486965412, 18860.15129319184, 18864.24543018264, 7108.045287545966, 7144.142702875584, 7407.925920740831, 7471.663775130132, 7549.7357592483995, 867.9175478329548, 950.2587981374539, 952.4047470331043, 960.711786464058, 990.2177279948904, 27499.86250068777, 28144.510487940253, 28423.71576284252, 28482.572761408595, 28821.711782881903, 1012.448215722433, 1016.8169729448622, 1024.6208902705898, 1053.8524606555088, 1073.5544748929262, 14651.853481465261, 14688.926555367154, 14809.407623695148, 14885.851141488663, 15294.847051529343, 318196.0, 323609.0, 323971.0, 324719.0, 325025.0, 49255.753721231165, 49481.25778113331, 49541.25688114681, 49767.25349119766, 49783.751081245086, 1126.9042131418757, 1235.8640549539723, 1263.6398626391435, 1282.557517656407, 1291.367230057284, 24888.875555622108, 27438.862805686644, 27487.862560687867, 27901.441971160868, 27966.720332797224, 39111.80444097761, 39206.411903820896, 39606.40590391089, 39610.40584391179, 39696.404553931134, 218438.0, 219080.0, 219367.0, 220650.0, 221042.0, 22714.09143634236, 25196.0, 26187.869060654575, 26236.60645090287, 26448.471030579665, 36624.63375366212, 36635.0, 37237.81381093077, 37475.43786843254, 37823.81088094652, 33329.50005749867, 33616.663833362334, 33838.3232335347, 34389.484157737155, 34416.139596510286, 33832.83083584566, 34015.829920850236, 34080.318393632486, 34205.48691769576, 34712.479312809824, 34247.143821404665, 36632.0, 36893.44659830158, 37775.0, 38161.80919095498, 29925.0, 30806.0, 31205.84397078091, 31711.841440792647, 31730.88941887023, 24337.634935475628, 24423.0, 24700.25899223026, 24965.87517062403, 25085.49829003373], "value": 17484.11537811713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.60400485497513, 383.5972229159382, 386.75054589789585, 391.2956677979637, 400.7675548182051, 15093.320800563974, 16135.354585816567, 16299.837001629994, 16312.592185195346, 16317.673646527062, 16305.347786088572, 16616.335346586122, 17261.741073883903, 17366.392176273832, 17376.47870563882, 4989.600831933455, 5115.053715062725, 5156.716380599066, 5165.9225111623355, 5166.17341225404, 3649.908752281201, 5473.28847249857, 5803.419658034205, 5803.520102373889, 5805.622634528763, 5686.459786320293, 5761.567882408815, 5764.279465066867, 5767.163761254616, 5773.422657734235, 5565.332160140769, 5672.149177623348, 5695.515881150107, 5704.971475142618, 5709.8572535686735, 3313.4035873542753, 4737.123632128068, 5057.772400241961, 5082.161443361841, 5091.338126043591, 18604.720929186074, 19242.32651857192, 19324.903375483173, 19334.903325483425, 19371.80628193714, 1951.034238052159, 1994.7107669387858, 2028.5435776950217, 2213.701150344699, 2300.896459659319, 12667.176633518884, 12970.610881673565, 13129.212247265099, 13352.799708004388, 13375.0, 1750.3961133408955, 1812.2026308424252, 1824.0, 1856.7214917762308, 1870.5510677437453, 66066.33933660698, 69713.3028669712, 69857.0, 69958.65020674915, 71168.64415677889, 9262.953685231665, 9354.625814967325, 9555.808883822285, 9596.808063838684, 9798.0, 13277.402516886763, 13370.0, 13418.731625367633, 13448.731025379439, 13470.326483675777, 7329.706811727578, 7349.191588925214, 7402.33378995893, 7453.329200371993, 7474.065741782278, 7052.576845389293, 7069.363757261871, 7095.290470952863, 7202.71189152428, 7223.422126229889, 6038.577299589075, 6230.906536401958, 6236.906446403307, 6252.3122456529745, 6267.310595834455, 1610.6859162463206, 1646.9917650411671, 1750.903700296496, 1771.2641611221075, 1810.7646006019133, 783.5024759277786, 867.9913200868036, 935.2004036548789, 980.2648013989508, 981.259149342242, 15841.0, 16073.435558218325, 17309.134543272787, 17434.825651743573, 17742.911285443748, 897.2597606974273, 903.742433406476, 904.7014485219862, 957.0333962697725, 971.6064993677572, 9710.95144524287, 9810.607575697035, 9956.452395118193, 9979.251556133318, 10086.899131008742, 359156.0, 361113.0, 374091.0, 375660.0, 376057.0, 65997.67001164964, 66778.0, 66876.0, 67915.0, 67999.66000169968, 997.6408492942535, 1001.4792307999945, 1023.5649848814373, 1041.4220107840222, 1044.6448207609296, 14991.2504374783, 15080.245987700791, 15134.0, 15399.538013859603, 15654.9217253913, 23934.28197154088, 28639.42721145607, 31405.528917065807, 31971.36057278888, 33124.1718957028, 42726.78636606797, 42846.35730464108, 43191.35212971871, 43206.783966081224, 43241.3513797287, 7012.894806578008, 7111.395531379891, 7137.643117844191, 7175.354218120394, 7181.138263408425, 10722.463876806285, 10848.945755271174, 10905.563777448813, 11057.668269951915, 11281.943590281997, 9175.954120229357, 9555.665551705657, 9576.808463830544, 9731.805363892825, 9794.363366381162, 9507.904920950701, 9547.665831696135, 9597.376170548892, 9694.951525242328, 9781.462019588991, 9207.17135457812, 9528.28537859677, 9585.137337639368, 9813.656522021694, 10070.0, 7270.491065625355, 7335.963320183365, 7338.302861228388, 7370.48406611532, 7451.329380355577, 5261.5264626183825, 6496.7726129585235, 7339.74310899116, 8744.431611945203, 9816.312858099864], "value": 8123.450421709685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1182.9885447942015, 1422.9857701422982, 1454.2437932275218, 1591.8487743664355, 1765.6645237404891, 7624.275693809086, 7928.167542408043, 7930.167332430098, 7933.523988560691, 7938.483998540098, 7655.617219139049, 7900.328472079866, 7906.2884340409355, 7909.050913890327, 7916.089649690287, 1949.512621844539, 2075.8546901716923, 2158.7625361210253, 2193.4954960359128, 2309.676645269655, 2217.833662475313, 2226.1095561775337, 2227.3652009177385, 2241.831862610303, 2242.338510139513, 2131.8187954023847, 2168.3928500019942, 2175.282156888231, 2176.336217453676, 2176.9129234830666, 1871.8876867387933, 2153.5262242306744, 2191.233068426054, 2192.6053310404122, 2197.033305345643, 2133.9466513337134, 2146.61360955028, 2149.6775483677416, 2149.8280137588954, 2184.1045171479777, 7804.882926756103, 7897.328727058207, 7900.0, 7906.090799558067, 7911.248431399008, 4622.422197225347, 4784.186688262969, 4797.856064318076, 4807.326974223612, 4881.902361952777, 3036.104349216986, 3099.7520198384077, 3149.4173577888164, 3156.7158955693867, 3183.3792410479964, 997.4264797741255, 998.8152191844459, 1009.7475631092227, 1015.0509273828993, 1025.7179275699168, 10717.678469645924, 10730.839037414446, 10748.086412655011, 10760.73098172544, 10765.51555180011, 4083.1221287423346, 4475.977620111944, 4482.327650852399, 4482.8655140345845, 4488.685791994529, 9531.571079301448, 9542.666006689733, 9565.091316324939, 9580.856287155559, 9584.424934503952, 4212.831486740496, 4855.757212139379, 4861.951380486221, 4867.537583929521, 4896.559309662148, 3732.9813350933614, 3942.211557688474, 3950.0, 4305.612494875413, 4349.826006959686, 3726.124360775216, 3815.389537673959, 3818.6181381861593, 3890.902727431837, 3908.0, 1233.1860971758776, 1237.4740735187509, 1239.7644447554935, 1242.428482897877, 1252.273681264864, 784.9686012559433, 786.6892577431883, 787.142015203431, 806.9798255043671, 810.7081450677751, 5387.676739395649, 5478.958997790487, 5498.285222920995, 5506.284183056177, 5589.273394458775, 887.7336798960287, 897.9191872731485, 908.9545522723837, 914.1498406481903, 935.219092058139, 3699.093722038118, 3700.0, 3782.3569993101237, 3806.657400833938, 3823.235352929425, 9285.907140928504, 9454.196393306645, 9493.525323733924, 9564.808703825884, 9597.520123993772, 9612.951935240279, 9663.178629816404, 9749.658761943298, 9783.804323913482, 9860.06329398706, 7237.746678866214, 7678.117016543058, 7686.0, 7692.269234422721, 7693.153753087156, 5211.4527974562125, 5422.701751403711, 5495.862603434946, 5591.692456914909, 5658.575606829587, 9316.0, 9317.0, 9330.95334523323, 9390.906090939003, 9454.149126578366, 9174.724758257264, 9491.952540237255, 9501.239900808057, 9518.190953769008, 9532.094451027142, 5806.535477161901, 6150.600210986271, 6274.278457977209, 6292.716827742671, 6294.0558916162945, 7471.514351567131, 7492.0, 7504.362129219077, 7504.887426688713, 7529.736459223901, 6527.314631963575, 6713.362230588086, 6739.258681545124, 6763.458923286224, 6871.5189936703955, 6794.42247408956, 6852.109225800813, 6856.280090590416, 6910.585364878123, 6959.304069593, 6235.875282494416, 6346.619202847844, 6347.5239357047485, 6382.0745991831855, 6433.260175079926, 4615.030843522898, 4620.907581848412, 4670.065986802585, 4700.247960326331, 4749.596284315872, 4497.100579883971, 4520.88697782558, 4547.704399214041, 4555.703879247838, 4652.069586082729], "value": 4215.37012958264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.67598345753504, 315.6937770362748, 316.3088651296916, 323.4678953122114, 323.75999920305236, 4910.508949105097, 4920.360353154094, 5086.186210206368, 5184.9222261666055, 5189.766460509277, 4699.2951057341415, 5083.491650834914, 5110.182370820669, 5124.615653825968, 5144.279800827887, 4048.534418541861, 4050.959490405095, 4066.8169932352966, 4068.430419741224, 4073.775942323171, 3837.1174629835155, 3900.726949113549, 4046.4941882264716, 4059.776712280823, 4069.633732964033, 3965.8017099145072, 3991.820368083443, 3997.900052498682, 3998.360262358023, 4001.6398524132824, 3992.5408578013466, 4003.3794761811964, 4006.639402453764, 4013.2776100301935, 4013.7391069580385, 3507.719382449398, 3561.9643803561894, 3577.1951310955087, 3578.3380074686006, 3585.2829434113282, 4873.269009648546, 4880.121578115938, 4882.292067650206, 4889.33993910821, 4898.926516102261, 4552.931706024412, 4571.497135315112, 4575.9771201143785, 4577.33628623851, 4579.4504659440745, 5224.50367215114, 5315.627906046579, 5319.148936170232, 5331.760070796823, 5341.919871201935, 3837.0791010157363, 3845.750026248285, 3851.364524853424, 3853.2293541291856, 3861.864834730799, 5218.191180367049, 5487.890242195173, 5551.444855514456, 5579.776808927638, 5590.301212348457, 3830.367989281737, 3896.357101078347, 3896.9610303896598, 3900.5904380039688, 3988.6210809973004, 4025.255327764314, 4028.959710402917, 4035.354343305116, 4047.6761859051207, 4065.4105154752397, 4562.133194692998, 4564.908701825945, 4568.6116680081905, 4594.379758732528, 4603.355530225771, 5093.923591146136, 5365.746386517672, 5366.114591092504, 5366.570674346043, 5381.973090134525, 1325.3307079924577, 1351.5740893357406, 1357.382391012087, 1358.6127953533196, 1360.2654566534159, 890.8063195318305, 912.1608120529129, 932.3659911260409, 933.7152168588646, 935.2284365398438, 4697.929531057037, 4703.764811759467, 4706.788194531255, 4706.835260765857, 4721.976390118028, 5544.140658197985, 5544.889102217933, 5547.639403438763, 5548.751530905514, 5567.164925261243, 4592.586667199968, 4648.535146485325, 4682.180618391836, 4684.461286951976, 4689.179393606105, 2948.2924098216704, 2966.0, 2970.138659788637, 2982.492976194052, 2983.3287510310006, 5209.557187639018, 5218.556422704037, 5222.791088356499, 5231.581473482112, 5232.424433312332, 5401.918971215435, 5667.716614169358, 5680.403557626472, 5721.542276617861, 5744.569157313134, 5251.501107394792, 5274.446183150791, 5277.445868183939, 5292.311999440049, 5295.920561191585, 5587.972060139673, 5601.579881508822, 5606.551475882001, 5613.747381367766, 5621.241132447068, 5274.525292723673, 5405.72971351423, 5447.836564903059, 5452.100403433389, 5460.099083651153, 4985.656741331569, 5139.126348520836, 5144.0, 5144.273535026442, 5211.661242019257, 3717.4609681596557, 3742.7005839533317, 3864.787436691009, 3884.1454879926373, 3891.1905963727004, 5507.228987941771, 5512.200730894078, 5515.283013208257, 5515.503604675599, 5533.391326954113, 5122.410922743932, 5335.813246536352, 5365.78053168096, 5382.219578161223, 5383.596230282823, 5356.839294821161, 5360.356757189163, 5397.757100930389, 5403.594730395314, 5406.621536492565, 5202.453742357149, 5311.167647161723, 5318.388385335581, 5327.653702509325, 5337.066013447554, 5329.7068661224, 5392.438591668926, 5437.592180586393, 5443.836684899459, 5468.234447177478, 5293.232481290268, 5296.629235953446, 5305.204219367126, 5321.813736519203, 5322.520973112439], "value": 4046.441570603073, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.8219627289452, 743.1973468653854, 748.7267147491166, 781.0393216343897, 787.1223585701943, 12833.42249598768, 13401.396937137828, 13402.128861623987, 13433.596992090228, 13469.191848489098, 13945.930270348634, 14000.509982150626, 14003.929980350109, 14080.577582672511, 14113.0, 635.2599221906473, 804.6419343392164, 826.7974346285154, 831.4387788242942, 833.4874052457725, 824.2952275804191, 829.8257365953157, 829.8755186721979, 830.3149901331426, 830.4975489828657, 858.7681326041965, 863.365426411587, 863.5854789700948, 864.4078806017866, 864.5461132905212, 663.2770280394393, 833.0960907415462, 855.8245559660255, 863.1799790199273, 864.0365991919028, 624.7126321891935, 625.3746253746253, 625.4183609243402, 626.9686515674198, 627.8116565030473, 12078.335691536962, 12078.939605302005, 12123.33321667308, 12174.756504869942, 12179.269243845398, 11983.400829958468, 12297.3236471994, 12467.438965246585, 12491.875081249162, 12497.625071247878, 10099.29304948654, 10118.89881101187, 10139.645112421103, 10167.898321016843, 10307.381557106522, 3301.900942971715, 3343.0806528204694, 3385.339858727549, 3401.1157099154398, 3456.1186897341267, 44938.77530612326, 45195.32207016897, 45341.09317813625, 45440.77279613614, 45760.7711961438, 9681.0, 9773.07155820196, 9808.313418060667, 9889.60441582343, 9908.653197138066, 17383.73924391135, 17434.47696569105, 17500.21249043796, 17506.12469376526, 17506.64986700259, 6487.481001519867, 6520.445762110179, 6543.0, 6566.047923051131, 6656.7670131545165, 3731.440283957428, 3744.1575645480093, 3795.886123416302, 3819.6180381962135, 3876.7480113792512, 2901.419716056797, 2980.1953472562286, 2984.940301193964, 2985.477541430241, 2985.507391280458, 501.95231453011905, 514.4289838279507, 521.439452588469, 527.6728428374432, 530.4483337329134, 624.9281332646713, 659.2418718473793, 661.9404253617198, 670.5767157565797, 691.1015679616479, 7909.960450197712, 8036.196380362034, 8076.3942704297415, 8318.792030199173, 8363.330933525303, 538.265267909301, 589.9321578018497, 649.5647915896361, 650.9609423434514, 659.307726886767, 3856.421536769507, 3906.1015966327336, 3948.0919388540224, 3996.500437445319, 4031.455753473302, 49029.50970490249, 49192.754036230304, 49300.26049609259, 50424.0, 50646.0, 43925.341119883225, 44158.55841441609, 44827.55172448299, 44966.77516612396, 45451.54548454539, 40550.18899621991, 40741.185176296305, 40951.0, 41659.7917010413, 41837.37243941343, 7476.028116344841, 7541.585212813348, 7604.885926710993, 7711.305982461606, 7748.302652761278, 28272.71727282701, 28728.425431491672, 28738.85630571834, 29229.0, 29231.123066308046, 36396.27207455783, 36840.815795921924, 36951.48960848715, 37937.48250070077, 41638.37542436927, 11412.771744564896, 11511.30932144074, 11526.250793698382, 11691.473883675086, 11792.469338879942, 12006.459709312927, 12081.214721043105, 12593.307368094842, 12619.873801262238, 12884.613461595793, 10919.454027298762, 11066.889331106586, 11178.0498657615, 11565.653030409101, 11614.767704646029, 11408.543658253577, 11634.70913227176, 11665.708357291136, 12139.817902731289, 12213.816792748294, 10844.403557804397, 10984.286021408583, 11076.667699969013, 11205.66383008511, 11587.88412115868, 9579.521023948913, 9591.136797688241, 9639.90360096418, 9895.851562226428, 10047.0, 9737.805243895224, 9765.121139097515, 9937.155341796028, 9992.20062394992, 10077.647282345082], "value": 6038.816075208835, "unit": "score"}], "name": "dromaeo_css", "value": 6372.011545119422, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 110.0, 111.0, 115.0, 114.0, 103.0, 114.0, 113.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 160.0, 193.0, 141.0, 156.0, 153.0, 141.0, 195.0, 135.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 163.0, 162.0, 162.0, 170.0, 164.0, 161.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 95.0, 115.0, 74.0, 77.0, 72.0, 113.0, 99.0, 73.0], "value": 86.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 136.0, 94.0, 93.0, 95.0, 142.0, 94.0, 95.0, 148.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 93.0, 64.0, 64.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 70.0, 65.0, 67.0, 65.0, 64.0, 65.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 81.0, 77.0, 79.0, 80.0, 79.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 139.0, 132.0, 134.0, 133.0, 137.0, 131.0, 166.0, 135.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 182.0, 181.0, 175.0, 183.0, 180.0, 179.0, 173.0, 174.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 74.0, 71.0, 71.0, 74.0, 70.0, 72.0, 70.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1585.5, "alertThreshold": 2.0}]} 22:06:12 INFO - Return code: 0 22:06:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:06:12 ERROR - # TBPL SUCCESS # 22:06:12 INFO - Running post-action listener: _resource_record_post_action 22:06:12 INFO - Running post-run listener: _resource_record_post_run 22:06:13 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7938048; Write bytes: 438759424; Read time: 2132; Write time: 489880 22:06:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8888320; Read time: 0; Write time: 19392 22:06:13 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 7933952; Write bytes: 380469248; Read time: 2084; Write time: 411144 22:06:13 INFO - Running post-run listener: _upload_blobber_files 22:06:13 INFO - Blob upload gear active. 22:06:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:06:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:06:13 INFO - (blobuploader) - INFO - Open directory for files ... 22:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:14 INFO - (blobuploader) - INFO - Done attempting. 22:06:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:06:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:06:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:15 INFO - (blobuploader) - INFO - Done attempting. 22:06:15 INFO - (blobuploader) - INFO - Iteration through files over. 22:06:15 INFO - Return code: 0 22:06:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:06:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:06:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52e50c8974c120e0082505d5af4b74d295b9b2028599b89487204d067eb32b4337cf962a64f5d63fd044c3659189fe80b47302bed532a273f649679e6254a6dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88ac66679bf64f098d28a70a7b7174a2eee4b5a00c757cc6a8dd409d5adfb1405871074569f2bc0281e756c1b40789a418d879694626308cfa90e845536dfa77"} 22:06:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:06:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:06:15 INFO - Contents: 22:06:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52e50c8974c120e0082505d5af4b74d295b9b2028599b89487204d067eb32b4337cf962a64f5d63fd044c3659189fe80b47302bed532a273f649679e6254a6dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88ac66679bf64f098d28a70a7b7174a2eee4b5a00c757cc6a8dd409d5adfb1405871074569f2bc0281e756c1b40789a418d879694626308cfa90e845536dfa77"} 22:06:15 INFO - Running post-run listener: copy_logs_to_upload_dir 22:06:15 INFO - Copying logs to upload dir... 22:06:15 INFO - mkdir: /builds/slave/test/build/upload/logs 22:06:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.632879 ========= master_lag: 61.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-04-16 22:07:17.051176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 22:07:17.054680) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52e50c8974c120e0082505d5af4b74d295b9b2028599b89487204d067eb32b4337cf962a64f5d63fd044c3659189fe80b47302bed532a273f649679e6254a6dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88ac66679bf64f098d28a70a7b7174a2eee4b5a00c757cc6a8dd409d5adfb1405871074569f2bc0281e756c1b40789a418d879694626308cfa90e845536dfa77"} build_url:https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010384 build_url: 'https://queue.taskcluster.net/v1/task/fddFlZSdQdGWwoGTxIZ2Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52e50c8974c120e0082505d5af4b74d295b9b2028599b89487204d067eb32b4337cf962a64f5d63fd044c3659189fe80b47302bed532a273f649679e6254a6dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88ac66679bf64f098d28a70a7b7174a2eee4b5a00c757cc6a8dd409d5adfb1405871074569f2bc0281e756c1b40789a418d879694626308cfa90e845536dfa77"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 22:07:17.247689) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 22:07:17.248051) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1460854190.468519-1860874814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 22:07:17.387301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 22:07:17.387679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 22:07:17.389777) ========= ========= Total master_lag: 62.10 =========