builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1462990011.05 results: success (0) buildid: 20160511083011 builduid: 786dd399228846839a4ac8f8fbb9a1f1 revision: a67f6710c37cce1c11882eceefceaaef0b5a9076 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.049114) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.049556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.049841) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.067353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.067725) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 11:06:51-- 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.3M=0s 2016-05-11 11:06:51 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078628 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.159652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.159980) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.210804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.211208) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a67f6710c37cce1c11882eceefceaaef0b5a9076 --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 a67f6710c37cce1c11882eceefceaaef0b5a9076 --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=e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 11:06:51,457 truncating revision to first 12 chars 2016-05-11 11:06:51,457 Setting DEBUG logging. 2016-05-11 11:06:51,457 attempt 1/10 2016-05-11 11:06:51,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a67f6710c37c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 11:06:51,724 unpacking tar archive at: fx-team-a67f6710c37c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585092 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.809579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.809930) ========= script_repo_revision: a67f6710c37cce1c11882eceefceaaef0b5a9076 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.810390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.810692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:51.820638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-11 11:06:51.821018) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:52 INFO - MultiFileLogger online at 20160511 11:06:52 in /builds/slave/test 11:06:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:06:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:52 INFO - {'append_to_log': False, 11:06:52 INFO - 'base_work_dir': '/builds/slave/test', 11:06:52 INFO - 'blob_upload_branch': 'Fx-Team', 11:06:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:52 INFO - 'branch': 'Fx-Team', 11:06:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:52 INFO - 'config_files': ('talos/linux_config.py',), 11:06:52 INFO - 'default_actions': ('clobber', 11:06:52 INFO - 'read-buildbot-config', 11:06:52 INFO - 'download-and-extract', 11:06:52 INFO - 'populate-webroot', 11:06:52 INFO - 'create-virtualenv', 11:06:52 INFO - 'install', 11:06:52 INFO - 'run-tests'), 11:06:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:52 INFO - 'download_minidump_stackwalk': True, 11:06:52 INFO - 'download_symbols': 'ondemand', 11:06:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:52 INFO - 'installer_path': 'installer.exe', 11:06:52 INFO - 'log_level': 'info', 11:06:52 INFO - 'log_name': 'talos', 11:06:52 INFO - 'log_to_console': True, 11:06:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:52 INFO - 'opt_config_files': (), 11:06:52 INFO - 'pip_index': False, 11:06:52 INFO - 'sps_profile': False, 11:06:52 INFO - 'sps_profile_interval': 0, 11:06:52 INFO - 'suite': 'dromaeojs', 11:06:52 INFO - 'system_bits': '32', 11:06:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:52 INFO - 'title': 'talos-linux64-ix-006', 11:06:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:52 INFO - 'use_talos_json': True, 11:06:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:52 INFO - 'work_dir': 'build'} 11:06:52 INFO - ##### 11:06:52 INFO - ##### Running clobber step. 11:06:52 INFO - ##### 11:06:52 INFO - Running pre-action listener: _resource_record_pre_action 11:06:52 INFO - Running main action method: clobber 11:06:52 INFO - rmtree: /builds/slave/test/build 11:06:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:52 INFO - Running post-action listener: _resource_record_post_action 11:06:52 INFO - ##### 11:06:52 INFO - ##### Finished clobber step (success) 11:06:52 INFO - ##### 11:06:52 INFO - ##### 11:06:52 INFO - ##### Running read-buildbot-config step. 11:06:52 INFO - ##### 11:06:52 INFO - Running pre-action listener: _resource_record_pre_action 11:06:52 INFO - Running main action method: read_buildbot_config 11:06:52 INFO - Using buildbot properties: 11:06:52 INFO - { 11:06:52 INFO - "project": "", 11:06:52 INFO - "product": "firefox", 11:06:52 INFO - "script_repo_revision": "production", 11:06:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:06:52 INFO - "repository": "", 11:06:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:06:52 INFO - "buildid": "20160511083011", 11:06:52 INFO - "pgo_build": "True", 11:06:52 INFO - "basedir": "/builds/slave/test", 11:06:52 INFO - "buildnumber": 76, 11:06:52 INFO - "slavename": "talos-linux64-ix-006", 11:06:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:06:52 INFO - "platform": "ubuntu64_hw", 11:06:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:06:52 INFO - "branch": "fx-team", 11:06:52 INFO - "repo_path": "integration/fx-team", 11:06:52 INFO - "revision": "a67f6710c37cce1c11882eceefceaaef0b5a9076", 11:06:52 INFO - "stage_platform": "linux64-pgo", 11:06:52 INFO - "builduid": "786dd399228846839a4ac8f8fbb9a1f1", 11:06:52 INFO - "slavebuilddir": "test" 11:06:52 INFO - } 11:06:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:06:52 INFO - Running post-action listener: _resource_record_post_action 11:06:52 INFO - ##### 11:06:52 INFO - ##### Finished read-buildbot-config step (success) 11:06:52 INFO - ##### 11:06:52 INFO - ##### 11:06:52 INFO - ##### Running download-and-extract step. 11:06:52 INFO - ##### 11:06:52 INFO - Running pre-action listener: _resource_record_pre_action 11:06:52 INFO - Running main action method: download_and_extract 11:06:52 INFO - mkdir: /builds/slave/test/build/tests 11:06: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')]} 11:06:52 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:06:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:06:58 INFO - Downloaded 1361 bytes. 11:06:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:58 INFO - Using the following test package requirements: 11:06:58 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:06:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:06:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:58 INFO - u'jsshell-linux-x86_64.zip'], 11:06:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:06:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:06:58 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:06:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:06:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:06:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:06:58 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')]} 11:06:58 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:11 INFO - Downloaded 23903031 bytes. 11:07:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:07:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:07:13 INFO - Return code: 0 11:07:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:07:13 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')]} 11:07:13 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:14 INFO - Downloaded 23903031 bytes. 11:07:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:07:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:07:15 INFO - Return code: 0 11:07: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')]} 11:07:15 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:07:16 INFO - Downloaded 10840152 bytes. 11:07:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:07:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:07:16 INFO - Return code: 0 11:07:16 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')]} 11:07:16 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:07:18 INFO - Downloaded 58333367 bytes. 11:07:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:18 INFO - mkdir: /builds/slave/test/properties 11:07:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:18 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:18 INFO - Contents: 11:07:18 INFO - build_url:https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:19 INFO - Running post-action listener: _resource_record_post_action 11:07:19 INFO - Running post-action listener: set_extra_try_arguments 11:07:19 INFO - ##### 11:07:19 INFO - ##### Finished download-and-extract step (success) 11:07:19 INFO - ##### 11:07:19 INFO - ##### 11:07:19 INFO - ##### Running populate-webroot step. 11:07:19 INFO - ##### 11:07:19 INFO - Running pre-action listener: _resource_record_pre_action 11:07:19 INFO - Running main action method: populate_webroot 11:07:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:19 INFO - '--tppagecycles', 11:07:19 INFO - '7'], 11:07:19 INFO - 'tests': ['tsvgm']}}, 11:07:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:19 INFO - 'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:19 INFO - 'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['damp', 'tps']}, 11:07:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:19 INFO - 'tests': ['damp', 'tps']}, 11:07:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['dromaeo_dom']}, 11:07:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['a11yr', 11:07:19 INFO - 'ts_paint', 11:07:19 INFO - 'tpaint', 11:07:19 INFO - 'sessionrestore', 11:07:19 INFO - 'sessionrestore_no_auto_restore', 11:07:19 INFO - 'tabpaint']}, 11:07:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:19 INFO - 'ts_paint', 11:07:19 INFO - 'tpaint', 11:07:19 INFO - 'sessionrestore', 11:07:19 INFO - 'sessionrestore_no_auto_restore', 11:07:19 INFO - 'tabpaint']}, 11:07:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:19 INFO - 'ts_paint', 11:07:19 INFO - 'tpaint', 11:07:19 INFO - 'sessionrestore', 11:07:19 INFO - 'sessionrestore_no_auto_restore', 11:07:19 INFO - 'tabpaint']}, 11:07:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:19 INFO - 'ts_paint', 11:07:19 INFO - 'tpaint', 11:07:19 INFO - 'sessionrestore', 11:07:19 INFO - 'sessionrestore_no_auto_restore', 11:07:19 INFO - 'tabpaint']}, 11:07:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['a11yr', 11:07:19 INFO - 'ts_paint', 11:07:19 INFO - 'tpaint', 11:07:19 INFO - 'sessionrestore', 11:07:19 INFO - 'sessionrestore_no_auto_restore', 11:07:19 INFO - 'tabpaint']}, 11:07:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['a11yr', 11:07:19 INFO - 'ts_paint', 11:07:19 INFO - 'tpaint', 11:07:19 INFO - 'sessionrestore', 11:07:19 INFO - 'sessionrestore_no_auto_restore', 11:07:19 INFO - 'tabpaint']}, 11:07:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['tsvgx', 11:07:19 INFO - 'tsvgr_opacity', 11:07:19 INFO - 'tart', 11:07:19 INFO - 'tscrollx', 11:07:19 INFO - 'cart']}, 11:07:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:19 INFO - 'tsvgr_opacity', 11:07:19 INFO - 'tart', 11:07:19 INFO - 'tscrollx', 11:07:19 INFO - 'cart']}, 11:07:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:19 INFO - 'talos_options': ['--disable-e10s'], 11:07:19 INFO - 'tests': ['tp5o']}, 11:07:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:19 INFO - 'tests': ['tp5o']}, 11:07:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:19 INFO - 'talos_options': ['--disable-e10s', 11:07:19 INFO - '--xperf_path', 11:07:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:19 INFO - 'tests': ['tp5n']}, 11:07:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:19 INFO - 'talos_options': ['--xperf_path', 11:07:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:19 INFO - 'tests': ['tp5n']}}, 11:07:19 INFO - 'talos.zip': {'path': '', 11:07:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:19 INFO - Running post-action listener: _resource_record_post_action 11:07:19 INFO - ##### 11:07:19 INFO - ##### Finished populate-webroot step (success) 11:07:19 INFO - ##### 11:07:19 INFO - ##### 11:07:19 INFO - ##### Running create-virtualenv step. 11:07:19 INFO - ##### 11:07:19 INFO - Running pre-action listener: _resource_record_pre_action 11:07:19 INFO - Running main action method: create_virtualenv 11:07:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:19 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 11:07:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:19 INFO - Using real prefix '/usr' 11:07:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:21 INFO - Installing pip.................done. 11:07:21 INFO - Return code: 0 11:07:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:21 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')]} 11:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:21 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')]} 11:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:21 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:21 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 11:07:21 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 11:07:21 INFO - Using env: {'DISPLAY': ':0', 11:07:21 INFO - 'HOME': '/home/cltbld', 11:07:21 INFO - 'LANG': 'en_US.UTF-8', 11:07:21 INFO - 'LANGUAGE': 'en_US:en', 11:07:21 INFO - 'LOGNAME': 'cltbld', 11:07:21 INFO - 'MAIL': '/var/mail/cltbld', 11:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:21 INFO - 'MOZ_NO_REMOTE': '1', 11:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:21 INFO - 'NO_EM_RESTART': '1', 11:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:21 INFO - 'PWD': '/builds/slave/test', 11:07:21 INFO - 'SHELL': '/bin/bash', 11:07:21 INFO - 'SHLVL': '1', 11:07:21 INFO - 'TERM': 'linux', 11:07:21 INFO - 'TMOUT': '86400', 11:07:21 INFO - 'USER': 'cltbld', 11:07:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:21 INFO - '_': '/tools/buildbot/bin/python'} 11:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:21 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 11:07:21 INFO - Cleaning up... 11:07:21 INFO - Return code: 0 11:07:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:07:21 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')]} 11:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:21 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')]} 11:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:21 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:21 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 11:07:21 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 11:07:21 INFO - Using env: {'DISPLAY': ':0', 11:07:21 INFO - 'HOME': '/home/cltbld', 11:07:21 INFO - 'LANG': 'en_US.UTF-8', 11:07:21 INFO - 'LANGUAGE': 'en_US:en', 11:07:21 INFO - 'LOGNAME': 'cltbld', 11:07:21 INFO - 'MAIL': '/var/mail/cltbld', 11:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:21 INFO - 'MOZ_NO_REMOTE': '1', 11:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:21 INFO - 'NO_EM_RESTART': '1', 11:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:21 INFO - 'PWD': '/builds/slave/test', 11:07:21 INFO - 'SHELL': '/bin/bash', 11:07:21 INFO - 'SHLVL': '1', 11:07:21 INFO - 'TERM': 'linux', 11:07:21 INFO - 'TMOUT': '86400', 11:07:21 INFO - 'USER': 'cltbld', 11:07:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:21 INFO - '_': '/tools/buildbot/bin/python'} 11:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:22 INFO - Downloading/unpacking psutil>=0.7.1 11:07:22 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 11:07:22 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 11:07:22 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 11:07:22 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 11:07:22 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 11:07:22 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 11:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:24 INFO - Installing collected packages: psutil 11:07:24 INFO - Running setup.py install for psutil 11:07:24 INFO - building 'psutil._psutil_linux' extension 11:07:24 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 11:07:24 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 11:07:24 INFO - building 'psutil._psutil_posix' extension 11:07:24 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 11:07:24 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 11:07:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:24 INFO - Successfully installed psutil 11:07:24 INFO - Cleaning up... 11:07:24 INFO - Return code: 0 11:07:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:24 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:24 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 11:07:24 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 11:07:24 INFO - Using env: {'DISPLAY': ':0', 11:07:24 INFO - 'HOME': '/home/cltbld', 11:07:24 INFO - 'LANG': 'en_US.UTF-8', 11:07:24 INFO - 'LANGUAGE': 'en_US:en', 11:07:24 INFO - 'LOGNAME': 'cltbld', 11:07:24 INFO - 'MAIL': '/var/mail/cltbld', 11:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:24 INFO - 'MOZ_NO_REMOTE': '1', 11:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:24 INFO - 'NO_EM_RESTART': '1', 11:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:24 INFO - 'PWD': '/builds/slave/test', 11:07:24 INFO - 'SHELL': '/bin/bash', 11:07:24 INFO - 'SHLVL': '1', 11:07:24 INFO - 'TERM': 'linux', 11:07:24 INFO - 'TMOUT': '86400', 11:07:24 INFO - 'USER': 'cltbld', 11:07:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:24 INFO - '_': '/tools/buildbot/bin/python'} 11:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:07:24 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 11:07:24 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 11:07:24 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 11:07:24 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 11:07:24 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 11:07:24 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 11:07:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:07:26 INFO - Installing collected packages: mozsystemmonitor 11:07:26 INFO - Running setup.py install for mozsystemmonitor 11:07:27 INFO - Successfully installed mozsystemmonitor 11:07:27 INFO - Cleaning up... 11:07:27 INFO - Return code: 0 11:07:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07:27 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')]} 11:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:27 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')]} 11:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:27 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:27 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 11:07:27 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 11:07:27 INFO - Using env: {'DISPLAY': ':0', 11:07:27 INFO - 'HOME': '/home/cltbld', 11:07:27 INFO - 'LANG': 'en_US.UTF-8', 11:07:27 INFO - 'LANGUAGE': 'en_US:en', 11:07:27 INFO - 'LOGNAME': 'cltbld', 11:07:27 INFO - 'MAIL': '/var/mail/cltbld', 11:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:27 INFO - 'MOZ_NO_REMOTE': '1', 11:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:27 INFO - 'NO_EM_RESTART': '1', 11:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:27 INFO - 'PWD': '/builds/slave/test', 11:07:27 INFO - 'SHELL': '/bin/bash', 11:07:27 INFO - 'SHLVL': '1', 11:07:27 INFO - 'TERM': 'linux', 11:07:27 INFO - 'TMOUT': '86400', 11:07:27 INFO - 'USER': 'cltbld', 11:07:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:27 INFO - '_': '/tools/buildbot/bin/python'} 11:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:27 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:29 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 INFO - Downloading docopt-0.6.1.tar.gz 11:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:29 INFO - Running setup.py install for blobuploader 11:07:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:30 INFO - Running setup.py install for requests 11:07:30 INFO - Running setup.py install for docopt 11:07:30 INFO - Successfully installed blobuploader requests docopt 11:07:30 INFO - Cleaning up... 11:07:30 INFO - Return code: 0 11:07:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:30 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')]} 11:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:30 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')]} 11:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:30 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:30 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 11:07:30 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 11:07:30 INFO - Using env: {'DISPLAY': ':0', 11:07:30 INFO - 'HOME': '/home/cltbld', 11:07:30 INFO - 'LANG': 'en_US.UTF-8', 11:07:30 INFO - 'LANGUAGE': 'en_US:en', 11:07:30 INFO - 'LOGNAME': 'cltbld', 11:07:30 INFO - 'MAIL': '/var/mail/cltbld', 11:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:30 INFO - 'MOZ_NO_REMOTE': '1', 11:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:30 INFO - 'NO_EM_RESTART': '1', 11:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:30 INFO - 'PWD': '/builds/slave/test', 11:07:30 INFO - 'SHELL': '/bin/bash', 11:07:30 INFO - 'SHLVL': '1', 11:07:30 INFO - 'TERM': 'linux', 11:07:30 INFO - 'TMOUT': '86400', 11:07:30 INFO - 'USER': 'cltbld', 11:07:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:30 INFO - '_': '/tools/buildbot/bin/python'} 11:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:30 INFO - Running setup.py (path:/tmp/pip-MCW9h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:30 INFO - Running setup.py (path:/tmp/pip-YbLHYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:30 INFO - Running setup.py (path:/tmp/pip-3xg0Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:30 INFO - Running setup.py (path:/tmp/pip-gWLn90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:31 INFO - Running setup.py (path:/tmp/pip-eaNzhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:31 INFO - Running setup.py (path:/tmp/pip-5Tcvks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:31 INFO - Running setup.py (path:/tmp/pip-n020DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:31 INFO - Running setup.py (path:/tmp/pip-pePsK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:31 INFO - Running setup.py (path:/tmp/pip-U9FXhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:31 INFO - Running setup.py (path:/tmp/pip-Q4CpfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:31 INFO - Running setup.py (path:/tmp/pip-WrHIa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:31 INFO - Running setup.py (path:/tmp/pip-bjwHz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:31 INFO - Running setup.py (path:/tmp/pip-Mj90vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:31 INFO - Running setup.py (path:/tmp/pip-J36cTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:31 INFO - Running setup.py (path:/tmp/pip-Zi2Znt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:31 INFO - Running setup.py (path:/tmp/pip-hNt6XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:31 INFO - Running setup.py (path:/tmp/pip-TaNXeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:31 INFO - Running setup.py install for manifestparser 11:07:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Running setup.py install for mozcrash 11:07:32 INFO - Running setup.py install for mozdebug 11:07:32 INFO - Running setup.py install for mozdevice 11:07:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Running setup.py install for mozfile 11:07:32 INFO - Running setup.py install for mozhttpd 11:07:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Running setup.py install for mozinfo 11:07:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Running setup.py install for mozInstall 11:07:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Running setup.py install for mozleak 11:07:32 INFO - Running setup.py install for mozlog 11:07:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:32 INFO - Running setup.py install for moznetwork 11:07:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozprocess 11:07:33 INFO - Running setup.py install for mozprofile 11:07:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozrunner 11:07:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozscreenshot 11:07:33 INFO - Running setup.py install for moztest 11:07:33 INFO - Running setup.py install for mozversion 11:07:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:33 INFO - Cleaning up... 11:07:33 INFO - Return code: 0 11:07:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:33 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')]} 11:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:33 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')]} 11:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:33 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:33 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 11:07:33 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 11:07:33 INFO - Using env: {'DISPLAY': ':0', 11:07:33 INFO - 'HOME': '/home/cltbld', 11:07:33 INFO - 'LANG': 'en_US.UTF-8', 11:07:33 INFO - 'LANGUAGE': 'en_US:en', 11:07:33 INFO - 'LOGNAME': 'cltbld', 11:07:33 INFO - 'MAIL': '/var/mail/cltbld', 11:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:33 INFO - 'MOZ_NO_REMOTE': '1', 11:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:33 INFO - 'NO_EM_RESTART': '1', 11:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:33 INFO - 'PWD': '/builds/slave/test', 11:07:33 INFO - 'SHELL': '/bin/bash', 11:07:33 INFO - 'SHLVL': '1', 11:07:33 INFO - 'TERM': 'linux', 11:07:33 INFO - 'TMOUT': '86400', 11:07:33 INFO - 'USER': 'cltbld', 11:07:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:33 INFO - '_': '/tools/buildbot/bin/python'} 11:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:33 INFO - Running setup.py (path:/tmp/pip-58_XrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:34 INFO - Running setup.py (path:/tmp/pip-2A7OlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:34 INFO - Running setup.py (path:/tmp/pip-HrtqjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:34 INFO - Running setup.py (path:/tmp/pip-UobxZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:34 INFO - Running setup.py (path:/tmp/pip-FqCKij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:34 INFO - Running setup.py (path:/tmp/pip-FO4iTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:34 INFO - Running setup.py (path:/tmp/pip-klwDYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:34 INFO - Running setup.py (path:/tmp/pip-_lvSZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:34 INFO - Running setup.py (path:/tmp/pip-yO3kCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:34 INFO - Running setup.py (path:/tmp/pip-J6xFFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:34 INFO - Running setup.py (path:/tmp/pip-04Ly5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:34 INFO - Running setup.py (path:/tmp/pip-8fwGy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:34 INFO - Running setup.py (path:/tmp/pip-J35dFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:34 INFO - Running setup.py (path:/tmp/pip-Brqoqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:34 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)) 11:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:34 INFO - Running setup.py (path:/tmp/pip-7xRUrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:35 INFO - Running setup.py (path:/tmp/pip-6hHKFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:35 INFO - Running setup.py (path:/tmp/pip-y23GQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 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)) 11:07:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:35 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 11:07:35 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 11:07:35 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 11:07:35 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 11:07:35 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 11:07:35 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 11:07:37 INFO - Downloading blessings-1.6.tar.gz 11:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:37 INFO - Installing collected packages: blessings 11:07:37 INFO - Running setup.py install for blessings 11:07:37 INFO - Successfully installed blessings 11:07:37 INFO - Cleaning up... 11:07:37 INFO - Return code: 0 11:07:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:37 INFO - Reading from file tmpfile_stdout 11:07:37 INFO - Current package versions: 11:07:37 INFO - argparse == 1.2.1 11:07:37 INFO - blessings == 1.6 11:07:37 INFO - blobuploader == 1.2.4 11:07:37 INFO - docopt == 0.6.1 11:07:37 INFO - manifestparser == 1.1 11:07:37 INFO - mozInstall == 1.12 11:07:37 INFO - mozcrash == 0.17 11:07:37 INFO - mozdebug == 0.1 11:07:37 INFO - mozdevice == 0.48 11:07:37 INFO - mozfile == 1.2 11:07:37 INFO - mozhttpd == 0.7 11:07:37 INFO - mozinfo == 0.9 11:07:37 INFO - mozleak == 0.1 11:07:37 INFO - mozlog == 3.1 11:07:37 INFO - moznetwork == 0.27 11:07:37 INFO - mozprocess == 0.22 11:07:37 INFO - mozprofile == 0.28 11:07:37 INFO - mozrunner == 6.11 11:07:37 INFO - mozscreenshot == 0.1 11:07:37 INFO - mozsystemmonitor == 0.0 11:07:37 INFO - moztest == 0.7 11:07:37 INFO - mozversion == 1.4 11:07:37 INFO - psutil == 3.1.1 11:07:37 INFO - requests == 1.2.3 11:07:37 INFO - wsgiref == 0.1.2 11:07:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:37 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')]} 11:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:37 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')]} 11:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:37 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:37 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 11:07:37 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 11:07:37 INFO - Using env: {'DISPLAY': ':0', 11:07:37 INFO - 'HOME': '/home/cltbld', 11:07:37 INFO - 'LANG': 'en_US.UTF-8', 11:07:37 INFO - 'LANGUAGE': 'en_US:en', 11:07:37 INFO - 'LOGNAME': 'cltbld', 11:07:37 INFO - 'MAIL': '/var/mail/cltbld', 11:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:37 INFO - 'MOZ_NO_REMOTE': '1', 11:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:37 INFO - 'NO_EM_RESTART': '1', 11:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:37 INFO - 'PWD': '/builds/slave/test', 11:07:37 INFO - 'SHELL': '/bin/bash', 11:07:37 INFO - 'SHLVL': '1', 11:07:37 INFO - 'TERM': 'linux', 11:07:37 INFO - 'TMOUT': '86400', 11:07:37 INFO - 'USER': 'cltbld', 11:07:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:37 INFO - '_': '/tools/buildbot/bin/python'} 11:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 INFO - Cleaning up... 11:07:37 INFO - Return code: 0 11:07:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:37 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')]} 11:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:37 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')]} 11:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:37 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:37 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 11:07:37 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 11:07:37 INFO - Using env: {'DISPLAY': ':0', 11:07:37 INFO - 'HOME': '/home/cltbld', 11:07:37 INFO - 'LANG': 'en_US.UTF-8', 11:07:37 INFO - 'LANGUAGE': 'en_US:en', 11:07:37 INFO - 'LOGNAME': 'cltbld', 11:07:37 INFO - 'MAIL': '/var/mail/cltbld', 11:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:37 INFO - 'MOZ_NO_REMOTE': '1', 11:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:37 INFO - 'NO_EM_RESTART': '1', 11:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:37 INFO - 'PWD': '/builds/slave/test', 11:07:37 INFO - 'SHELL': '/bin/bash', 11:07:37 INFO - 'SHLVL': '1', 11:07:37 INFO - 'TERM': 'linux', 11:07:37 INFO - 'TMOUT': '86400', 11:07:37 INFO - 'USER': 'cltbld', 11:07:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:37 INFO - '_': '/tools/buildbot/bin/python'} 11:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:37 INFO - Downloading/unpacking jsonschema 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:39 INFO - Downloading/unpacking functools32 (from jsonschema) 11:07:39 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 11:07:39 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 11:07:39 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 11:07:39 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 11:07:39 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 11:07:39 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 11:07:40 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:40 INFO - warning: no files found matching '*.txt' 11:07:40 INFO - no previously-included directories found matching 'build' 11:07:40 INFO - no previously-included directories found matching 'dist' 11:07:40 INFO - no previously-included directories found matching '.git*' 11:07:40 INFO - Installing collected packages: jsonschema, functools32 11:07:40 INFO - Running setup.py install for functools32 11:07:40 INFO - warning: no files found matching '*.txt' 11:07:40 INFO - no previously-included directories found matching 'build' 11:07:40 INFO - no previously-included directories found matching 'dist' 11:07:40 INFO - no previously-included directories found matching '.git*' 11:07:40 INFO - Successfully installed jsonschema functools32 11:07:40 INFO - Cleaning up... 11:07:40 INFO - Return code: 0 11:07:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:40 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 0x7f86dc5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', '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 11:07:40 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 11:07:40 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 11:07:40 INFO - Using env: {'DISPLAY': ':0', 11:07:40 INFO - 'HOME': '/home/cltbld', 11:07:40 INFO - 'LANG': 'en_US.UTF-8', 11:07:40 INFO - 'LANGUAGE': 'en_US:en', 11:07:40 INFO - 'LOGNAME': 'cltbld', 11:07:40 INFO - 'MAIL': '/var/mail/cltbld', 11:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:40 INFO - 'MOZ_NO_REMOTE': '1', 11:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:40 INFO - 'NO_EM_RESTART': '1', 11:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:40 INFO - 'PWD': '/builds/slave/test', 11:07:40 INFO - 'SHELL': '/bin/bash', 11:07:40 INFO - 'SHLVL': '1', 11:07:40 INFO - 'TERM': 'linux', 11:07:40 INFO - 'TMOUT': '86400', 11:07:40 INFO - 'USER': 'cltbld', 11:07:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:40 INFO - '_': '/tools/buildbot/bin/python'} 11:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:40 INFO - Downloading/unpacking flake8 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:40 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 11:07:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:07:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:07:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:42 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 11:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:07:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:43 INFO - no previously-included directories found matching 'docs/_build' 11:07:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:07:43 INFO - Running setup.py install for pep8 11:07:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:43 INFO - no previously-included directories found matching 'docs/_build' 11:07:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:07:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:07:43 INFO - Cleaning up... 11:07:43 INFO - Return code: 0 11:07:43 INFO - Running post-action listener: _resource_record_post_action 11:07:43 INFO - Running post-action listener: _start_resource_monitoring 11:07:43 INFO - Starting resource monitoring. 11:07:43 INFO - ##### 11:07:43 INFO - ##### Finished create-virtualenv step (success) 11:07:43 INFO - ##### 11:07:43 INFO - ##### 11:07:43 INFO - ##### Running install step. 11:07:43 INFO - ##### 11:07:43 INFO - Running pre-action listener: _resource_record_pre_action 11:07:43 INFO - Running main action method: install 11:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:43 INFO - Reading from file tmpfile_stdout 11:07:43 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:43 INFO - Reading from file tmpfile_stdout 11:07:43 INFO - Output received: 11:07:43 INFO - Usage: mozinstall [options] installer 11:07:43 INFO - Options: 11:07:43 INFO - -h, --help show this help message and exit 11:07:43 INFO - -d DEST, --destination=DEST 11:07:43 INFO - Directory to install application into. [default: 11:07:43 INFO - "/builds/slave/test"] 11:07:43 INFO - --app=APP Application being installed. [default: firefox] 11:07:43 INFO - mkdir: /builds/slave/test/build/application 11:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:08:00 INFO - Reading from file tmpfile_stdout 11:08:00 INFO - Output received: 11:08:00 INFO - /builds/slave/test/build/application/firefox/firefox 11:08:00 INFO - Running post-action listener: _resource_record_post_action 11:08:00 INFO - ##### 11:08:00 INFO - ##### Finished install step (success) 11:08:00 INFO - ##### 11:08:00 INFO - ##### 11:08:00 INFO - ##### Running run-tests step. 11:08:00 INFO - ##### 11:08:00 INFO - Running pre-action listener: _resource_record_pre_action 11:08:00 INFO - Running main action method: run_tests 11:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:08:00 INFO - Python 2.7.3 11:08:00 INFO - Return code: 0 11:08:00 INFO - grabbing minidump binary from tooltool 11:08:00 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')]} 11:08:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef1b20>, '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 0xef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef2eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:08:00 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 11:08:00 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 11:08:00 INFO - Calling ['/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'] with output_timeout 600 11:08:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:00 INFO - Return code: 0 11:08:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:08:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:08:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:08:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:08:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:08:01 INFO - Return code: 0 11:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 11:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 11:08:01 INFO - Using env: {'DISPLAY': ':0', 11:08:01 INFO - 'HOME': '/home/cltbld', 11:08:01 INFO - 'LANG': 'en_US.UTF-8', 11:08:01 INFO - 'LANGUAGE': 'en_US:en', 11:08:01 INFO - 'LOGNAME': 'cltbld', 11:08:01 INFO - 'MAIL': '/var/mail/cltbld', 11:08:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:01 INFO - 'MOZ_NO_REMOTE': '1', 11:08:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:01 INFO - 'NO_EM_RESTART': '1', 11:08:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:01 INFO - 'PWD': '/builds/slave/test', 11:08:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:01 INFO - 'SHELL': '/bin/bash', 11:08:01 INFO - 'SHLVL': '1', 11:08:01 INFO - 'TERM': 'linux', 11:08:01 INFO - 'TMOUT': '86400', 11:08:01 INFO - 'USER': 'cltbld', 11:08:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779', 11:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:01 INFO - '_': '/tools/buildbot/bin/python'} 11:08:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 11:08:01 INFO - mozversion application_buildid: 20160511083011 11:08:01 INFO - mozversion application_changeset: a67f6710c37cce1c11882eceefceaaef0b5a9076 11:08:01 INFO - mozversion application_display_name: Nightly 11:08:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:01 INFO - mozversion application_name: Firefox 11:08:01 INFO - mozversion application_remotingname: firefox 11:08:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:08:01 INFO - mozversion application_vendor: Mozilla 11:08:01 INFO - mozversion application_version: 49.0a1 11:08:01 INFO - mozversion platform_buildid: 20160511083011 11:08:01 INFO - mozversion platform_changeset: a67f6710c37cce1c11882eceefceaaef0b5a9076 11:08:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:08:01 INFO - mozversion platform_version: 49.0a1 11:08:01 INFO - using testdate: 1462990081 11:08:01 INFO - actual date: 1462990081 11:08:01 INFO - starting webserver on 'localhost:38333' 11:08:01 INFO - SUITE-START | Running 2 tests 11:08:01 INFO - TEST-START | dromaeo_css 11:08:01 INFO - operating with platform_type : linux_ 11:08:01 INFO - Initialising browser for dromaeo_css test... 11:08:01 INFO - TEST-INFO | started process 15566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj1CUk4/profile http://localhost:38333/getInfo.html) 11:08:05 INFO - PROCESS | 15566 | __metrics Screen width/height:1600/1200 11:08:05 INFO - PROCESS | 15566 | colorDepth:24 11:08:05 INFO - PROCESS | 15566 | Browser inner width/height: 1024/697 11:08:05 INFO - PROCESS | 15566 | __metrics 11:08:06 ERROR - PROCESS | 15566 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:08:07 INFO - TEST-INFO | 15566: exit 0 11:08:07 INFO - Browser initialized. 11:08:07 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:07 INFO - TEST-INFO | started process 15647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj1CUk4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:19 INFO - PROCESS | 15647 | RSS: Main: 151633920 11:08:19 INFO - PROCESS | 15647 | 11:09:10 INFO - PROCESS | 15647 | 1462990150688 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] 11:11:18 INFO - PROCESS | 15647 | Cycle 1(1): loaded http://localhost:38333/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38333/tests/dromaeo/cssquery-ext.html) 11:11:19 INFO - PROCESS | 15647 | RSS: Main: 253927424 11:11:19 INFO - PROCESS | 15647 | 11:14:21 INFO - PROCESS | 15647 | Cycle 1(1): loaded http://localhost:38333/tests/dromaeo/cssquery-ext.html (next: http://localhost:38333/tests/dromaeo/cssquery-jquery.html) 11:14:22 INFO - PROCESS | 15647 | RSS: Main: 237420544 11:14:22 INFO - PROCESS | 15647 | 11:17:24 INFO - PROCESS | 15647 | Cycle 1(1): loaded http://localhost:38333/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38333/tests/dromaeo/cssquery-mootools.html) 11:17:24 INFO - PROCESS | 15647 | RSS: Main: 234901504 11:17:24 INFO - PROCESS | 15647 | 11:20:26 INFO - PROCESS | 15647 | Cycle 1(1): loaded http://localhost:38333/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38333/tests/dromaeo/cssquery-prototype.html) 11:20:27 INFO - PROCESS | 15647 | RSS: Main: 226418688 11:20:27 INFO - PROCESS | 15647 | 11:23:30 INFO - PROCESS | 15647 | Cycle 1(1): loaded http://localhost:38333/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38333/tests/dromaeo/cssquery-yui.html) 11:23:30 INFO - PROCESS | 15647 | RSS: Main: 220315648 11:23:30 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | Cycle 1(1): loaded http://localhost:38333/tests/dromaeo/cssquery-yui.html (next: http://localhost:38333/tests/dromaeo/cssquery-dojo.html) 11:26:33 INFO - PROCESS | 15647 | RSS: Main: 267194368 11:26:33 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | __start_tp_report 11:26:33 INFO - PROCESS | 15647 | _x_x_mozilla_page_load 11:26:33 INFO - PROCESS | 15647 | _x_x_mozilla_page_load_details 11:26:33 INFO - PROCESS | 15647 | |i|pagename|runs| 11:26:33 INFO - PROCESS | 15647 | |0;dojo.html;3155.605549306337;3171.825549594773;3203.2312245061185;3209.502527108296;3238.31995280991;5300.840974770754;5340.839774806757;5346.492083252085;5426.2674538937235;5440.5919556033305;5413.052715774744;5416.972915135419;5418.106012507931;5456.454354564542;5501.752421141048;4857.854264372066;4935.851924442272;4951.529604687567;4972.2044472884345;5085.110105731501;4983.202687569971;4996.875078123057;5028.044671512419;5045.369328833895;5050.090983622947;4816.7350795706225;4834.274858771178;4838.588719958808;4869.293952376903;4900.093482705711;4812.278158276252;4824.975875120602;4868.732219727914;4892.804287828482;4931.161702510582;4784.473707892129;4840.540148685905;4847.709137451764;4852.2479015752615;4896.632752543574;5204.843854684365;5288.788448462095;5305.920411193835;5321.361436627591;5338.065838478289;5696.344920334173;5740.1102829061565;5762.74067666956;5766.135079738073;5768.019436695772;5639.6334238274385;5761.481466667978;5810.448007439287;5812.767489300423;5819.418058194189;5438.673679579238;5517.751701173457;5533.833984980457;5537.141743029837;5546.611737178399;6016.879662406727;6023.969880150571;6027.9095813562835;6030.306514750772;6030.698465076729;5536.916946245809;5606.971965140148;5617.185508101303;5762.7694892203845;5771.971140144273;5794.855128621818;5796.5072968797285;5798.333191682926;5800.100984347433;5842.328132264844;5765.509931655856;5773.797917072882;5774.335951365562;5779.566532510079;5787.1319302104175;5537.252470916455;5682;5702.201691763156;5712.028955077647;5787.07406814916;4367.082912588392;4367.62875155609;4368.694191406571;4369.169857727085;4404.427424434803;3864.401017842239;3872.1481274119647;3892.377219644843;3930.744501607386;3944.9211015779524;5182.352205974254;5324.254604355393;5406.216098665672;5495.258140151029;5509;5842.036064049385;5857.7949771757785;5902.2622172228475;5922.674252916131;5962.40375962409;5456.345238571397;5462.371827239918;5464.480874316933;5468.043092458804;5471.37079235885;4819.108464933998;4897.069556784199;4988.176950803149;4988.251762235694;5016.247562865527;6021.036634138517;6024.126501657235;6032;6032.366601506867;6033.245844269466;5707.0583353747825;5839.970800145972;5856.180134781049;5867.647941123546;5873.970630146822;5936.525077993837;5977.073553599199;5992.730327135202;6038.154658347747;6056.424639659225;5728.770849165987;5775.364709881994;5775.6823374714795;5780.248567686174;5782.190493330853;5691.032524470767;5794.188813566188;5829.679367634821;5871.178035075008;5875.764969401347;5656.321241450888;5733.31200255972;5745.166950792028;5749.741261643152;5798.652080875161;5630.296212973379;5713.971430142823;5725.370209276893;5730.054541000688;5736.053551164011;5416.322959630046;5556.16657501378;5570.025245582088;5621.831345059655;5634.802781902614;5777.3933736957015;5806.332271788799;5812.970935145467;5819.738111784895;5823.5923485355615;5593.664380137205;5634.859128521656;5635.605507614428;5643.717814109196;5679.204911312337 11:26:33 INFO - PROCESS | 15647 | |1;ext.html;617.6973283091287;629.7890206780728;665.2449469851717;665.7370338716206;667.8664267146565;34772.65227347726;35390.469142962844;35462.468062979045;43482;44917;45546.316805247945;45859.0828183437;45942.54057459433;45954.31068533966;46060.769696151554;8859;9014;9018.639254429814;9090.318226133033;9108.22580080694;8996.370254082216;9099.499527525983;9100.317476189311;9102.089791020879;9107.225885799715;9021.413608115485;9035.954820225923;9044.14080662336;9076.682316118937;9127.497987610679;9059;9094.090590940854;9103.408278461911;9115.99724030356;9116.635334586641;8827.426217295919;8908.688195913177;8909.376343655947;8910.128872936692;8910.86633700495;42134.154572223975;42358.57641423577;42424.575754242374;42444;42475.36286955698;3684.291736972815;3758.229562939591;4140.648044916185;4191.97904010481;4255.5318914919335;32245;32582.837085814655;32890.01329960105;33174;33396.33207335864;4315.136972605492;4394.340848872663;4412.05140894706;4416.2713152329825;4438.068005718803;319193;319519.4024029888;321550;323338;323711;35543;36344.81827590845;58174.709126454945;59357.40642593519;59387;38072.61927380746;38093.428598571045;38146;38165.618343816765;38176.427353589715;14151.71696566063;14301.28493575317;14319.78520322196;14326.426942922375;14330.426782928565;11604.129690273263;11654.88345116538;11683.591074312359;11694.356810375511;11695;8601.13988601135;8604.182602652738;8610.913890861137;8645.827083458296;8691.130886911258;3298.274379636524;3304.3556506481004;3340.231746698273;3341.4653655415505;3378.442556978071;1069.1340014588052;1088.7223757941833;1119.7704470583674;1140.3123377401491;1178.664080737003;31761.841190793897;32273;32511.674883251337;33140.668593313756;33409;1095.6055819904827;1130.7681925205313;1179.1451197881638;1186.7211205366732;1276.4638851682316;16950.830491694924;17435;17768.555786105193;17818.376356827448;17887.552811179823;468580;534349;543146;545756;883455;60028;60188;60489;60531;60598;1331.9134256273505;1390.874821266091;1425.1306702911215;1445;1464.7143806957754;30192.396152076395;31792.36415271728;32190.678093219703;32460.513092304107;32465.675343246265;52467;58027.4197258022;58132.41867581439;58161;58220.70889645694;438983;443480;443916;444879;445844;38481.4227786589;38872.805635971636;43882.734071911575;44581;46761;48269.5173048265;48516.272255915486;49452.752736236085;49674.254886177456;50020.74989625174;40817.1836563273;41150;41368.586314137676;41404.79297603493;42397.364039538814;40142.598574013886;40913.79543102384;41241;41431.585684142774;41620.375694364004;41269.58730412657;42055.7897210512;42177.78911105425;42215.57784422117;42400.78799605982;35441;36612.0846978817;36629.63370366369;37047;37260.254794903405;28170.15489535317;28215.43569128647;28220.382051358738;28259;28360.48294844327 11:26:33 INFO - PROCESS | 15647 | |2;jquery.html;397.83489851711533;398.631266078877;400.82163437270424;402.62756949821414;417.9540250572438;13097.559792364047;18029.188686509107;19872.900635496837;19940.60118797625;20059.699104513445;15092.773608395855;18350;19208.903955480204;19703.5074123147;19705.70441443376;5669.688167150805;5795.536357091443;5799.449052340042;5812.505936995361;5826.15520749491;5728.398518155596;5751.712414379285;5776.740046697888;5790.507806836424;5805.854853628651;4212.073343864345;5968.224130863004;6304.148939893124;6312.905306420407;6420.678966051702;6180.721867515973;6358.968205158991;6370.872582548323;6399.456046236076;6467.288598254188;5704.486596206361;5714.285714285715;5723.51350135239;5733.684647344395;5745.683987380692;22460.43848903774;22723.431914202276;22770.7229277071;23277;23563.646545301835;2309.3880121767743;2343.250159948817;2363.279199844047;2401.03958416633;2868.899588514392;12292.938535307356;13653.590392288248;14646.121232726071;14868.934635731328;15258.237088145548;1891.9810801892081;1945.4163750874823;1976.24902537035;2000.5598768270956;2050.794920507952;80001.59999200025;80923;82438;82835;84018;10289.845652315222;10331.380117192992;10379.96200379956;10664.41345725977;10708.411037392862;14381.424743010162;14381.568552943429;14391.85608143926;14406.639834004023;14415.351309191112;7723.691052357843;7913.248241417056;7922.524648521107;7940.6029698515995;8078.35373170145;7521.435892308099;7573.659185336673;7766.145723970359;7817.413693972861;7932.524048557105;5681.914771278434;6147.692615369214;6564.638944857983;6675;6717.328267173243;1841.272697284565;1868.8131186881476;1924.7112933060152;1927.5084853362303;1976.8319692825983;1003.8845532763679;1020.5713600287897;1046.9685909422728;1068.4444089073638;1110.7851570463245;19039.90480047591;19683.212671493267;19747.40757777269;19873.60252794936;19969.400917972485;1062.4103622489438;1062.9734256643492;1071.6356438810842;1075.4891426572315;1112.6884472347756;10817.891821081847;11432.199746017699;11509.25189862673;11519.769604607862;11527.538898444136;461576;499293;504142;512687;514445;82353.58823205845;83227.16772832315;83946.58026709827;84099.57950210333;85772;1051.290378994191;1054.1260866316256;1060.2419270221674;1069.2248120112856;1076.7954088723118;17167.828321716624;17230.95556007799;17462.47612571625;17550.38573649916;17592.56018599545;35083.824580876935;35349.1162720934;35402.46896296506;35509;35814;49342.50657493379;51403.74298128486;51932;54514.45485545094;58847.41152588419;8464.541508140594;8692.261157801659;8768.912310876809;8800;8883.333749968908;8029;8477.957610212155;13982.650433739238;14169.716605668034;14515.564533064025;11747.236429632047;12102.93948530287;12360.690982725504;12511.311877846441;12564.057695673044;11708.590199342982;12082.33547154915;12114.454849531969;12365.690857728629;12635.494580216688;12326.445309960895;12403.937980310402;12650;12729;12828.358582071045;7370.852582948418;7544.358729508053;7641.808954776175;7673.34776544;8062.39532035088;9817.705468835946;11912.940435297767;11924.165308428326;12132.636020919386;12175.634730958085 11:26:33 INFO - PROCESS | 15647 | |3;mootools.html;1356.2269506381367;1488.025343400073;1542.7068856917185;1724.689555879941;1856.2853301478926;8322.625481853316;8788.868166977492;8791.032986371501;8965.91034089659;8978.191962723353;8606.182412670802;8772.824543509141;8784.868226976601;8784.91215087849;8796.69211577595;1999.9600007999832;2039.1843262694892;2234.72065991751;2256.311824893403;2305.3314538783816;2331.73185083715;2345.7419683834764;2347.2840783561005;2350.048230466664;2351.764823517643;2280.486890449644;2296.334063121693;2304.2396009316885;2308.4575124845646;2309.099451214028;1961.1861077652757;2199.065397206181;2241.428435748882;2271.3867255840833;2271.704678391815;2224.443889027743;2235.910563577455;2246.2811900191946;2249.325202439262;2253.1325439705665;8749.737507874774;8800.163984421533;8805.119488051208;8806.427582207136;8810.38327317088;5240.973795131038;5346.465353464661;5347.278117454132;5369.087255166592;5373.435789242151;3266.477363621833;3324.1523411530147;3381.9492707609406;3406.914827129317;3414.23179784549;1055.709679838043;1109.2013750099916;1118.401655114518;1184.224333061846;1195.6532605544382;12402.503899843996;12410.5656302029;12413.813792793115;12424.192427492275;12460.563880264148;4624.213883639789;4669.322948172564;4773.880652983703;4809.2305231162845;4824.638152138604;10288.537015834305;10302.381857088598;10308;10324.845127323097;10344.172466202686;5327.653702509325;5404.351477822686;5421.132618781055;5426.9185962210595;5427.782888684487;4328.415663885398;4788.23388257884;4882.389701287339;4890.266460030953;4976.925346119811;4025.7181997260495;4031.5162180538523;4041.4522990165283;4078.7144899857317;4182.519010313853;1293.7865252233275;1317.3347459533065;1319.6107148391247;1322.9801552976712;1325.4035683942266;949.8765160529088;951.7715748220515;953.0279115302492;955.9044095590385;985.1724551376734;5591.804286850022;5645.435456454322;5709.371969083398;5734.455226753452;5832.1834943108;429.60261757873843;431.1893639956861;433.80695590461943;438.6863392674253;444.2093074327702;3985.143194213258;3997.4603428537357;4003.4395184673585;4055.756654600674;4155.085881106152;10719.517621707042;11083.279586826831;11168.106551475863;11171.776564468664;11177;10754.300970436896;10759.085477734323;10853.457327133612;11014.779704405866;11028.889711102785;8266.380021498411;8433.367497437594;8434.198751118634;8452.57737113142;8482.703105391405;5727.341355744143;5797.304323481209;5803.419658034163;5811.883762324815;5903.970480147572;10160.187185025032;10241.231907607109;10334.689959301233;10368.792624147625;10400.947995259976;10253.692389228336;10329.070383665507;10505.947470262905;10513.474326283502;10547.736306592396;7066.858662826818;7319.597422141834;7512.737054203077;7863;7940.801479963047;8434.072252052147;8464.703735369232;8476.745697629081;8515.787105322168;8515.957420212859;7522.962385188039;7741.651625676971;7745.302922736981;7758.806029849073;7940.483868548526;7566.810829729301;7694.653740581799;7737.535747854921;7863.370930325675;7864.252895974873;6968.223103108675;6993.4754893384215;7019;7022.929770702228;7033.472489563201;4702.482726900107;4774.761261936958;4870.342503761947;4880.097182021337;4884.413870335582;4838.612910967044;4869.147899117569;4886.95113048865;4958.975205123951;5001.8749531260555 11:26:33 INFO - PROCESS | 15647 | |4;prototype.html;313.96860313968597;317.40328183015924;318.3442109254936;320.4728222074689;322.1109737125534;5362.946370536293;5373.328333958255;5420.617742475663;5439.156930675752;5449.128139497676;5298.947010529893;5300.337457817773;5331.733413329328;5350.170723537848;5354.41101478838;3961.227560625679;4019.9799001004953;4100.548939616655;4137.875863724078;4161.167766446708;4072.552019277877;4084.8978775530554;4097.569755175708;4098.364753463218;4136.9864383226;3979.343408337621;4083.530394004698;4083.612056854594;4094.222097801423;4096.242195193899;4015.31739604268;4137.77242251676;4138.565450627701;4155.210510003105;4168.458100446953;3638.1263649220673;3653.104989277644;3653.853845846163;3654.945175822365;3659.6157403472785;5149.201873709581;5161.509656582619;5185.170372740344;5189.221616757479;5210;4452.332150177467;4633.675642705012;4638.397008388922;4646.210144275447;4673.322368256618;5515;5542.334919809648;5544.722763861791;5546.306711661043;5563.916541251844;3866;3897.2400381925536;3897.7661340319673;3917.9822391468415;3921.509811273591;5653.349864765563;5782.797602083949;5811.4479124483105;5834.183214349994;5846.795362162304;3976.304146774303;3983.402489626579;3985.9202815943518;3989.5412027616617;3996.1208534122447;4038.757674539537;4040.9797951010646;4074.8573799916862;4077.1845630873945;4079.673626109904;4539.795709193094;4613.861584152481;4635.907281854344;4698.694584851974;4735.715857048588;5542.501174894279;5561.915426491876;5604.299462567179;5611.37270191648;5680.687562184037;1393.7700279453777;1394.2053029773135;1398.4196558428341;1398.4755716606273;1412.4703236286393;877.9692710755093;889.3088955758426;905.6151135767273;914.1133100892124;929.8419268724333;5301.5493683037375;5306.92039619406;5323.707196104251;5330.841943284167;5386.272853164773;5661;5696.544276457874;5698.6580805151;5709.545724836497;5711.428857114255;5221.198686453167;5324.387695414999;5325.707086110224;5366.356037275474;5377.892442151213;2975.9256018599276;3028.530577760451;3036.529337952621;3057.801242919203;3081.8613162407296;5610.831675049755;5799.246098007232;5851.180834683148;5908.961408314125;5947;5746.540276777848;5765.990951583456;5779.971100144472;5785.942140578624;5794.913076303858;5827.3007239131575;5835.328937172195;5836;5841.357450680422;5848.64908105515;5417.51242388187;5654.692005177018;5682.204491371294;5776.277965254343;5821.79623713168;5728.140778883201;5751.252337196138;5759.798407055733;5759.884802304015;5778.393268706725;5749.987504373603;6012.939870601238;6029.879402412015;6042.939570604238;6064.151018857452;4043.575424580494;4051.655609273245;4060.4570263299756;4060.837566497307;4070.2266569351727;5853.09277062056;5871.7651293947765;5880.529557635465;5895.410458954242;5912.763489460373;5496.148097044965;5650.039493286234;5691.2032315475035;5748.103125968337;5752.654840709571;5647.3505546861;5651.350094738993;5656.236408084856;5664.291963504562;5673.971630141988;5344.438833922538;5355.357357117171;5455.863603409946;5492.5605951524585;5630.23991761107;5597.552195824405;5620;5651.180578816131;5660.179274005329;5674.092145256739;5504.394516603251;5517.558595312285;5573.581981351496;5611.887762244651;5634.408387119457 11:26:33 INFO - PROCESS | 15647 | |5;yui.html;747.5850902748972;763.0576238345642;767.3515879082178;837.5602808525523;847.8092429203429;14502.5649230523;15288;15377;15410.69178616427;15691.764623530657;15031.398744050251;15528.689426211497;15685.84314156858;15698.37206511741;15722.528324150266;708.6669265445258;805.2108933245423;849.6813694864426;852.5098068610542;856.6316483911916;822.6133717152959;823.27551754456;823.6458322921142;824.1140773668301;834.8664213725805;870.2950610005884;874.0909454167689;874.2743522876029;874.567089290802;875.1511034296722;735.7608777147449;848.0925409811442;867.6616119713317;868.8957325120995;874.9956250218709;640.1965533255781;640.942315191635;641.6470940982488;642.6497558830449;642.958207716497;14624.634384140481;14650.853491465163;14665.633359165999;14690.338934747962;14712.48506302285;12761.425735841909;13025.283609401478;13099.738005239842;13222.933885330513;13259.403326850315;11122.443877806078;11696.12279079064;12057.819132713017;12209.389530523438;12434.316112613802;3810.085579460937;3845.8269377878064;3889.144388234612;3963.3064213762477;3968.0476685595536;52651.21023184617;54865.451345486836;54868.17697734537;55061.174082388796;55079.173812392844;10962.397068161328;11285.266457680389;11558.768824623628;11628.825567616492;11677.591284305008;18729;18858.528536786416;18874;18879.43361699151;19023.904880475508;6778.2205046420295;7292.8176795579475;7744.109427415807;8192.744787765358;8443.197896199852;4658.394408726844;4750.406199225097;4764.737939413296;4846.466888642247;4883.072216278895;3294.258791771832;3364.915877103092;3384.2047118927035;3393.983030084834;3394.321135772855;572.619208226533;630.2562975688639;647.5758378262245;665.8335416145964;670.5105273150627;664.3688495928886;674.5581644023173;694.1947341084318;712.975045873392;725.329070609684;8676.262517686067;8793.604287807064;8836.248918841842;8839.823203535892;8937;693.4902846407887;719.1811481035613;753.5591678867814;761.3908872901767;765.8276887700223;4356.49900261474;4475.48531918827;4598.356230127785;4815.3258543803895;4868.78090485929;64392.356076438635;67807.3219267811;67840.66079669668;68078;68096.6595167021;61638;62392.37607623866;62946.68526657429;63240.68379658072;64559.354406456274;55293.723531382086;55812.72093639587;55883.441165588636;56478.43521564896;57480.42519574834;8895.377323587287;9041.367104302635;9076.863847042168;9230.815383692154;9235.953820230856;32729.836350818092;32747.508787368686;33656;35293.294134117685;35592;43074.13851723011;45792.313115303965;47079.76460117677;47128.528714713786;49352.75323623359;13024.8046279304;13251.13867598603;13270.071095023255;13448.596542103753;13533.255670938193;13519.662008449868;13830.308484575933;14190.60091371678;14278.928605356907;14465.204413757345;9872.654457093968;12515;12569.811452828031;12668.936655316664;12867.549635762703;11013.779724405627;11132.332060076422;11156;11468.94265528667;11664.950154485798;11449.885501145216;11589.130815188726;11853.881461185278;11900.702482438008;11981.700457488283;11069.391183484664;11173.385463799244;11416.257943233662;11494.252873563191;11563.768724625292;11236.325820450798;11266.155038372319;11376.146788991024;11566.363849988331;11692.123090768397 11:26:33 INFO - PROCESS | 15647 | __end_tp_report 11:26:33 INFO - PROCESS | 15647 | __start_cc_report 11:26:33 INFO - PROCESS | 15647 | _x_x_mozilla_cycle_collect,853 11:26:33 INFO - PROCESS | 15647 | __end_cc_report 11:26:33 INFO - PROCESS | 15647 | __startTimestamp1462991193560__endTimestamp 11:26:33 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | ------- Summary: start ------- 11:26:33 INFO - PROCESS | 15647 | Number of tests: 6 11:26:33 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | [#0] dojo.html Cycles:165 Average:5384.12 Median:5617.19 stddev:623.63 (11.1%) stddev-sans-first:600.53 11:26:33 INFO - PROCESS | 15647 | Values: 3155.6 3171.8 3203.2 3209.5 3238.3 5300.8 5340.8 5346.5 5426.3 5440.6 5413.1 5417.0 5418.1 5456.5 5501.8 4857.9 4935.9 4951.5 4972.2 5085.1 4983.2 4996.9 5028.0 5045.4 5050.1 4816.7 4834.3 4838.6 4869.3 4900.1 4812.3 4825.0 4868.7 4892.8 4931.2 4784.5 4840.5 4847.7 4852.2 4896.6 5204.8 5288.8 5305.9 5321.4 5338.1 5696.3 5740.1 5762.7 5766.1 5768.0 5639.6 5761.5 5810.4 5812.8 5819.4 5438.7 5517.8 5533.8 5537.1 5546.6 6016.9 6024.0 6027.9 6030.3 6030.7 5536.9 5607.0 5617.2 5762.8 5772.0 5794.9 5796.5 5798.3 5800.1 5842.3 5765.5 5773.8 5774.3 5779.6 5787.1 5537.3 5682.0 5702.2 5712.0 5787.1 4367.1 4367.6 4368.7 4369.2 4404.4 3864.4 3872.1 3892.4 3930.7 3944.9 5182.4 5324.3 5406.2 5495.3 5509.0 5842.0 5857.8 5902.3 5922.7 5962.4 5456.3 5462.4 5464.5 5468.0 5471.4 4819.1 4897.1 4988.2 4988.3 5016.2 6021.0 6024.1 6032.0 6032.4 6033.2 5707.1 5840.0 5856.2 5867.6 5874.0 5936.5 5977.1 5992.7 6038.2 6056.4 5728.8 5775.4 5775.7 5780.2 5782.2 5691.0 5794.2 5829.7 5871.2 5875.8 5656.3 5733.3 5745.2 5749.7 5798.7 5630.3 5714.0 5725.4 5730.1 5736.1 5416.3 5556.2 5570.0 5621.8 5634.8 5777.4 5806.3 5813.0 5819.7 5823.6 5593.7 5634.9 5635.6 5643.7 5679.2 11:26:33 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | [#1] ext.html Cycles:180 Average:60666.77 Median:23123.88 stddev:126780.98 (548.3%) stddev-sans-first:127056.47 11:26:33 INFO - PROCESS | 15647 | Values: 617.7 629.8 665.2 665.7 667.9 34772.7 35390.5 35462.5 43482.0 44917.0 45546.3 45859.1 45942.5 45954.3 46060.8 8859.0 9014.0 9018.6 9090.3 9108.2 8996.4 9099.5 9100.3 9102.1 9107.2 9021.4 9036.0 9044.1 9076.7 9127.5 9059.0 9094.1 9103.4 9116.0 9116.6 8827.4 8908.7 8909.4 8910.1 8910.9 42134.2 42358.6 42424.6 42444.0 42475.4 3684.3 3758.2 4140.6 4192.0 4255.5 32245.0 32582.8 32890.0 33174.0 33396.3 4315.1 4394.3 4412.1 4416.3 4438.1 319193.0 319519.4 321550.0 323338.0 323711.0 35543.0 36344.8 58174.7 59357.4 59387.0 38072.6 38093.4 38146.0 38165.6 38176.4 14151.7 14301.3 14319.8 14326.4 14330.4 11604.1 11654.9 11683.6 11694.4 11695.0 8601.1 8604.2 8610.9 8645.8 8691.1 3298.3 3304.4 3340.2 3341.5 3378.4 1069.1 1088.7 1119.8 1140.3 1178.7 31761.8 32273.0 32511.7 33140.7 33409.0 1095.6 1130.8 1179.1 1186.7 1276.5 16950.8 17435.0 17768.6 17818.4 17887.6 468580.0 534349.0 543146.0 545756.0 883455.0 60028.0 60188.0 60489.0 60531.0 60598.0 1331.9 1390.9 1425.1 1445.0 1464.7 30192.4 31792.4 32190.7 32460.5 32465.7 52467.0 58027.4 58132.4 58161.0 58220.7 438983.0 443480.0 443916.0 444879.0 445844.0 38481.4 38872.8 43882.7 44581.0 46761.0 48269.5 48516.3 49452.8 49674.3 50020.7 40817.2 41150.0 41368.6 41404.8 42397.4 40142.6 40913.8 41241.0 41431.6 41620.4 41269.6 42055.8 42177.8 42215.6 42400.8 35441.0 36612.1 36629.6 37047.0 37260.3 28170.2 28215.4 28220.4 28259.0 28360.5 11:26:33 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | [#2] jquery.html Cycles:180 Average:28839.90 Median:12793.19 stddev:81962.88 (640.7%) stddev-sans-first:82164.99 11:26:33 INFO - PROCESS | 15647 | Values: 397.8 398.6 400.8 402.6 418.0 13097.6 18029.2 19872.9 19940.6 20059.7 15092.8 18350.0 19208.9 19703.5 19705.7 5669.7 5795.5 5799.4 5812.5 5826.2 5728.4 5751.7 5776.7 5790.5 5805.9 4212.1 5968.2 6304.1 6312.9 6420.7 6180.7 6359.0 6370.9 6399.5 6467.3 5704.5 5714.3 5723.5 5733.7 5745.7 22460.4 22723.4 22770.7 23277.0 23563.6 2309.4 2343.3 2363.3 2401.0 2868.9 12292.9 13653.6 14646.1 14868.9 15258.2 1892.0 1945.4 1976.2 2000.6 2050.8 80001.6 80923.0 82438.0 82835.0 84018.0 10289.8 10331.4 10380.0 10664.4 10708.4 14381.4 14381.6 14391.9 14406.6 14415.4 7723.7 7913.2 7922.5 7940.6 8078.4 7521.4 7573.7 7766.1 7817.4 7932.5 5681.9 6147.7 6564.6 6675.0 6717.3 1841.3 1868.8 1924.7 1927.5 1976.8 1003.9 1020.6 1047.0 1068.4 1110.8 19039.9 19683.2 19747.4 19873.6 19969.4 1062.4 1063.0 1071.6 1075.5 1112.7 10817.9 11432.2 11509.3 11519.8 11527.5 461576.0 499293.0 504142.0 512687.0 514445.0 82353.6 83227.2 83946.6 84099.6 85772.0 1051.3 1054.1 1060.2 1069.2 1076.8 17167.8 17231.0 17462.5 17550.4 17592.6 35083.8 35349.1 35402.5 35509.0 35814.0 49342.5 51403.7 51932.0 54514.5 58847.4 8464.5 8692.3 8768.9 8800.0 8883.3 8029.0 8478.0 13982.7 14169.7 14515.6 11747.2 12102.9 12360.7 12511.3 12564.1 11708.6 12082.3 12114.5 12365.7 12635.5 12326.4 12403.9 12650.0 12729.0 12828.4 7370.9 7544.4 7641.8 7673.3 8062.4 9817.7 11912.9 11924.2 12132.6 12175.6 11:26:33 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | [#3] mootools.html Cycles:180 Average:5786.16 Median:2534.21 stddev:3357.91 (132.5%) stddev-sans-first:3350.83 11:26:33 INFO - PROCESS | 15647 | Values: 1356.2 1488.0 1542.7 1724.7 1856.3 8322.6 8788.9 8791.0 8965.9 8978.2 8606.2 8772.8 8784.9 8784.9 8796.7 2000.0 2039.2 2234.7 2256.3 2305.3 2331.7 2345.7 2347.3 2350.0 2351.8 2280.5 2296.3 2304.2 2308.5 2309.1 1961.2 2199.1 2241.4 2271.4 2271.7 2224.4 2235.9 2246.3 2249.3 2253.1 8749.7 8800.2 8805.1 8806.4 8810.4 5241.0 5346.5 5347.3 5369.1 5373.4 3266.5 3324.2 3381.9 3406.9 3414.2 1055.7 1109.2 1118.4 1184.2 1195.7 12402.5 12410.6 12413.8 12424.2 12460.6 4624.2 4669.3 4773.9 4809.2 4824.6 10288.5 10302.4 10308.0 10324.8 10344.2 5327.7 5404.4 5421.1 5426.9 5427.8 4328.4 4788.2 4882.4 4890.3 4976.9 4025.7 4031.5 4041.5 4078.7 4182.5 1293.8 1317.3 1319.6 1323.0 1325.4 949.9 951.8 953.0 955.9 985.2 5591.8 5645.4 5709.4 5734.5 5832.2 429.6 431.2 433.8 438.7 444.2 3985.1 3997.5 4003.4 4055.8 4155.1 10719.5 11083.3 11168.1 11171.8 11177.0 10754.3 10759.1 10853.5 11014.8 11028.9 8266.4 8433.4 8434.2 8452.6 8482.7 5727.3 5797.3 5803.4 5811.9 5904.0 10160.2 10241.2 10334.7 10368.8 10400.9 10253.7 10329.1 10505.9 10513.5 10547.7 7066.9 7319.6 7512.7 7863.0 7940.8 8434.1 8464.7 8476.7 8515.8 8516.0 7523.0 7741.7 7745.3 7758.8 7940.5 7566.8 7694.7 7737.5 7863.4 7864.3 6968.2 6993.5 7019.0 7022.9 7033.5 4702.5 4774.8 4870.3 4880.1 4884.4 4838.6 4869.1 4887.0 4959.0 5001.9 11:26:33 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | [#4] prototype.html Cycles:180 Average:4690.03 Median:5369.84 stddev:1402.45 (26.1%) stddev-sans-first:1367.38 11:26:33 INFO - PROCESS | 15647 | Values: 314.0 317.4 318.3 320.5 322.1 5362.9 5373.3 5420.6 5439.2 5449.1 5298.9 5300.3 5331.7 5350.2 5354.4 3961.2 4020.0 4100.5 4137.9 4161.2 4072.6 4084.9 4097.6 4098.4 4137.0 3979.3 4083.5 4083.6 4094.2 4096.2 4015.3 4137.8 4138.6 4155.2 4168.5 3638.1 3653.1 3653.9 3654.9 3659.6 5149.2 5161.5 5185.2 5189.2 5210.0 4452.3 4633.7 4638.4 4646.2 4673.3 5515.0 5542.3 5544.7 5546.3 5563.9 3866.0 3897.2 3897.8 3918.0 3921.5 5653.3 5782.8 5811.4 5834.2 5846.8 3976.3 3983.4 3985.9 3989.5 3996.1 4038.8 4041.0 4074.9 4077.2 4079.7 4539.8 4613.9 4635.9 4698.7 4735.7 5542.5 5561.9 5604.3 5611.4 5680.7 1393.8 1394.2 1398.4 1398.5 1412.5 878.0 889.3 905.6 914.1 929.8 5301.5 5306.9 5323.7 5330.8 5386.3 5661.0 5696.5 5698.7 5709.5 5711.4 5221.2 5324.4 5325.7 5366.4 5377.9 2975.9 3028.5 3036.5 3057.8 3081.9 5610.8 5799.2 5851.2 5909.0 5947.0 5746.5 5766.0 5780.0 5785.9 5794.9 5827.3 5835.3 5836.0 5841.4 5848.6 5417.5 5654.7 5682.2 5776.3 5821.8 5728.1 5751.3 5759.8 5759.9 5778.4 5750.0 6012.9 6029.9 6042.9 6064.2 4043.6 4051.7 4060.5 4060.8 4070.2 5853.1 5871.8 5880.5 5895.4 5912.8 5496.1 5650.0 5691.2 5748.1 5752.7 5647.4 5651.4 5656.2 5664.3 5674.0 5344.4 5355.4 5455.9 5492.6 5630.2 5597.6 5620.0 5651.2 5660.2 5674.1 5504.4 5517.6 5573.6 5611.9 5634.4 11:26:33 INFO - PROCESS | 15647 | 11:26:33 INFO - PROCESS | 15647 | [#5] yui.html Cycles:180 Average:15458.67 Median:47104.15 stddev:18437.52 (39.1%) stddev-sans-first:18456.15 11:26:33 INFO - PROCESS | 15647 | Values: 747.6 763.1 767.4 837.6 847.8 14502.6 15288.0 15377.0 15410.7 15691.8 15031.4 15528.7 15685.8 15698.4 15722.5 708.7 805.2 849.7 852.5 856.6 822.6 823.3 823.6 824.1 834.9 870.3 874.1 874.3 874.6 875.2 735.8 848.1 867.7 868.9 875.0 640.2 640.9 641.6 642.6 643.0 14624.6 14650.9 14665.6 14690.3 14712.5 12761.4 13025.3 13099.7 13222.9 13259.4 11122.4 11696.1 12057.8 12209.4 12434.3 3810.1 3845.8 3889.1 3963.3 3968.0 52651.2 54865.5 54868.2 55061.2 55079.2 10962.4 11285.3 11558.8 11628.8 11677.6 18729.0 18858.5 18874.0 18879.4 19023.9 6778.2 7292.8 7744.1 8192.7 8443.2 4658.4 4750.4 4764.7 4846.5 4883.1 3294.3 3364.9 3384.2 3394.0 3394.3 572.6 630.3 647.6 665.8 670.5 664.4 674.6 694.2 713.0 725.3 8676.3 8793.6 8836.2 8839.8 8937.0 693.5 719.2 753.6 761.4 765.8 4356.5 4475.5 4598.4 4815.3 4868.8 64392.4 67807.3 67840.7 68078.0 68096.7 61638.0 62392.4 62946.7 63240.7 64559.4 55293.7 55812.7 55883.4 56478.4 57480.4 8895.4 9041.4 9076.9 9230.8 9236.0 32729.8 32747.5 33656.0 35293.3 35592.0 43074.1 45792.3 47079.8 47128.5 49352.8 13024.8 13251.1 13270.1 13448.6 13533.3 13519.7 13830.3 14190.6 14278.9 14465.2 9872.7 12515.0 12569.8 12668.9 12867.5 11013.8 11132.3 11156.0 11468.9 11665.0 11449.9 11589.1 11853.9 11900.7 11981.7 11069.4 11173.4 11416.3 11494.3 11563.8 11236.3 11266.2 11376.1 11566.4 11692.1 11:26:33 INFO - PROCESS | 15647 | -------- Summary: end -------- 11:26:33 INFO - PROCESS | 15647 | 11:26:34 INFO - TEST-INFO | 15647: exit 0 11:26:34 INFO - TEST-OK | dromaeo_css | took 1112853ms 11:26:34 INFO - TEST-START | kraken 11:26:34 INFO - operating with platform_type : linux_ 11:26:34 INFO - Initialising browser for kraken test... 11:26:34 INFO - TEST-INFO | started process 15828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVcFK6S/profile http://localhost:38333/getInfo.html) 11:26:38 INFO - PROCESS | 15828 | __metrics Screen width/height:1600/1200 11:26:38 INFO - PROCESS | 15828 | colorDepth:24 11:26:38 INFO - PROCESS | 15828 | Browser inner width/height: 1024/697 11:26:38 INFO - PROCESS | 15828 | __metrics 11:26:39 ERROR - PROCESS | 15828 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:26:40 INFO - TEST-INFO | 15828: exit 0 11:26:40 INFO - Browser initialized. 11:26:40 INFO - Running cycle 1/1 for kraken test... 11:26:40 INFO - TEST-INFO | started process 15910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVcFK6S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:52 INFO - PROCESS | 15910 | RSS: Main: 152002560 11:26:52 INFO - PROCESS | 15910 | 11:26:54 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38333/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:55 INFO - PROCESS | 15910 | RSS: Main: 207683584 11:26:55 INFO - PROCESS | 15910 | 11:26:58 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38333/tests/kraken/driver.html?testName=audio-dft) 11:26:58 INFO - PROCESS | 15910 | RSS: Main: 196935680 11:26:58 INFO - PROCESS | 15910 | 11:27:02 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38333/tests/kraken/driver.html?testName=audio-fft) 11:27:02 INFO - PROCESS | 15910 | RSS: Main: 264069120 11:27:02 INFO - PROCESS | 15910 | 11:27:04 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38333/tests/kraken/driver.html?testName=audio-oscillator) 11:27:05 INFO - PROCESS | 15910 | RSS: Main: 173314048 11:27:05 INFO - PROCESS | 15910 | 11:27:07 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38333/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:08 INFO - PROCESS | 15910 | RSS: Main: 178069504 11:27:08 INFO - PROCESS | 15910 | 11:27:11 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38333/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:12 INFO - PROCESS | 15910 | RSS: Main: 214384640 11:27:12 INFO - PROCESS | 15910 | 11:27:15 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38333/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:16 INFO - PROCESS | 15910 | RSS: Main: 214515712 11:27:16 INFO - PROCESS | 15910 | 11:27:19 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38333/tests/kraken/driver.html?testName=json-parse-financial) 11:27:19 INFO - PROCESS | 15910 | RSS: Main: 214757376 11:27:19 INFO - PROCESS | 15910 | 11:27:21 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38333/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:21 INFO - PROCESS | 15910 | RSS: Main: 205418496 11:27:21 INFO - PROCESS | 15910 | 11:27:23 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38333/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:24 INFO - PROCESS | 15910 | RSS: Main: 206794752 11:27:24 INFO - PROCESS | 15910 | 11:27:26 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38333/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:27 INFO - PROCESS | 15910 | RSS: Main: 216293376 11:27:27 INFO - PROCESS | 15910 | 11:27:29 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:30 INFO - PROCESS | 15910 | RSS: Main: 220516352 11:27:30 INFO - PROCESS | 15910 | 11:27:33 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:33 INFO - PROCESS | 15910 | RSS: Main: 217403392 11:27:33 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38333/tests/kraken/driver.html?testName=ai-astar) 11:27:35 INFO - PROCESS | 15910 | RSS: Main: 263524352 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | __start_tp_report 11:27:35 INFO - PROCESS | 15910 | _x_x_mozilla_page_load 11:27:35 INFO - PROCESS | 15910 | _x_x_mozilla_page_load_details 11:27:35 INFO - PROCESS | 15910 | |i|pagename|runs| 11:27:35 INFO - PROCESS | 15910 | |0;ai-astar;112;105;110;110;109;109;110;109;109;109 11:27:35 INFO - PROCESS | 15910 | |1;audio-beat-detection;157;127;153;200;129;154;147;126;181;124 11:27:35 INFO - PROCESS | 15910 | |2;audio-dft;161;160;160;160;159;160;162;161;163;161 11:27:35 INFO - PROCESS | 15910 | |3;audio-fft;75;76;75;152;75;74;75;75;137;75 11:27:35 INFO - PROCESS | 15910 | |4;audio-oscillator;92;91;156;92;92;91;132;91;91;130 11:27:35 INFO - PROCESS | 15910 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 11:27:35 INFO - PROCESS | 15910 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;146;146 11:27:35 INFO - PROCESS | 15910 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 11:27:35 INFO - PROCESS | 15910 | |8;json-parse-financial;61;58;59;58;58;58;62;119;58;56 11:27:35 INFO - PROCESS | 15910 | |9;json-stringify-tinderbox;59;59;58;58;58;58;58;58;58;58 11:27:35 INFO - PROCESS | 15910 | |10;stanford-crypto-aes;79;79;79;79;78;79;80;80;79;79 11:27:35 INFO - PROCESS | 15910 | |11;stanford-crypto-ccm;123;123;123;120;123;126;122;120;237;136 11:27:35 INFO - PROCESS | 15910 | |12;stanford-crypto-pbkdf2;170;172;165;168;166;168;165;166;165;165 11:27:35 INFO - PROCESS | 15910 | |13;stanford-crypto-sha256-iterative;65;65;65;63;65;64;64;63;63;63 11:27:35 INFO - PROCESS | 15910 | __end_tp_report 11:27:35 INFO - PROCESS | 15910 | __start_cc_report 11:27:35 INFO - PROCESS | 15910 | _x_x_mozilla_cycle_collect,1866 11:27:35 INFO - PROCESS | 15910 | __end_cc_report 11:27:35 INFO - PROCESS | 15910 | __startTimestamp1462991255893__endTimestamp 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | ------- Summary: start ------- 11:27:35 INFO - PROCESS | 15910 | Number of tests: 14 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:1.75 (1.6%) stddev-sans-first:1.54 11:27:35 INFO - PROCESS | 15910 | Values: 112.0 105.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:153.50 stddev:25.31 (16.5%) stddev-sans-first:26.71 11:27:35 INFO - PROCESS | 15910 | Values: 157.0 127.0 153.0 200.0 129.0 154.0 147.0 126.0 181.0 124.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 11:27:35 INFO - PROCESS | 15910 | Values: 161.0 160.0 160.0 160.0 159.0 160.0 162.0 161.0 163.0 161.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.00 stddev:29.52 (39.4%) stddev-sans-first:30.88 11:27:35 INFO - PROCESS | 15910 | Values: 75.0 76.0 75.0 152.0 75.0 74.0 75.0 75.0 137.0 75.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:91.00 stddev:24.13 (26.5%) stddev-sans-first:25.07 11:27:35 INFO - PROCESS | 15910 | Values: 92.0 91.0 156.0 92.0 92.0 91.0 132.0 91.0 91.0 130.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:27:35 INFO - PROCESS | 15910 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 11:27:35 INFO - PROCESS | 15910 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:27:35 INFO - PROCESS | 15910 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:58.00 stddev:19.15 (33.0%) stddev-sans-first:20.27 11:27:35 INFO - PROCESS | 15910 | Values: 61.0 58.0 59.0 58.0 58.0 58.0 62.0 119.0 58.0 56.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 11:27:35 INFO - PROCESS | 15910 | Values: 59.0 59.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 11:27:35 INFO - PROCESS | 15910 | Values: 79.0 79.0 79.0 79.0 78.0 79.0 80.0 80.0 79.0 79.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:123.00 stddev:36.02 (29.3%) stddev-sans-first:37.93 11:27:35 INFO - PROCESS | 15910 | Values: 123.0 123.0 123.0 120.0 123.0 126.0 122.0 120.0 237.0 136.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.00 stddev:2.45 (1.5%) stddev-sans-first:2.35 11:27:35 INFO - PROCESS | 15910 | Values: 170.0 172.0 165.0 168.0 166.0 168.0 165.0 166.0 165.0 165.0 11:27:35 INFO - PROCESS | 15910 | 11:27:35 INFO - PROCESS | 15910 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:0.94 (1.5%) stddev-sans-first:0.93 11:27:35 INFO - PROCESS | 15910 | Values: 65.0 65.0 65.0 63.0 65.0 64.0 64.0 63.0 63.0 63.0 11:27:35 INFO - PROCESS | 15910 | -------- Summary: end -------- 11:27:35 INFO - PROCESS | 15910 | 11:27:36 INFO - TEST-INFO | 15910: exit 0 11:27:36 INFO - TEST-OK | kraken | took 62641ms 11:27:36 INFO - SUITE-END | took 1175s 11:27:37 INFO - Completed test suite (00:19:35) 11:27:37 INFO - javascript benchmark 11:27:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.605549306337, 3171.825549594773, 3203.2312245061185, 3209.502527108296, 3238.31995280991, 5300.840974770754, 5340.839774806757, 5346.492083252085, 5426.2674538937235, 5440.5919556033305, 5413.052715774744, 5416.972915135419, 5418.106012507931, 5456.454354564542, 5501.752421141048, 4857.854264372066, 4935.851924442272, 4951.529604687567, 4972.2044472884345, 5085.110105731501, 4983.202687569971, 4996.875078123057, 5028.044671512419, 5045.369328833895, 5050.090983622947, 4816.7350795706225, 4834.274858771178, 4838.588719958808, 4869.293952376903, 4900.093482705711, 4812.278158276252, 4824.975875120602, 4868.732219727914, 4892.804287828482, 4931.161702510582, 4784.473707892129, 4840.540148685905, 4847.709137451764, 4852.2479015752615, 4896.632752543574, 5204.843854684365, 5288.788448462095, 5305.920411193835, 5321.361436627591, 5338.065838478289, 5696.344920334173, 5740.1102829061565, 5762.74067666956, 5766.135079738073, 5768.019436695772, 5639.6334238274385, 5761.481466667978, 5810.448007439287, 5812.767489300423, 5819.418058194189, 5438.673679579238, 5517.751701173457, 5533.833984980457, 5537.141743029837, 5546.611737178399, 6016.879662406727, 6023.969880150571, 6027.9095813562835, 6030.306514750772, 6030.698465076729, 5536.916946245809, 5606.971965140148, 5617.185508101303, 5762.7694892203845, 5771.971140144273, 5794.855128621818, 5796.5072968797285, 5798.333191682926, 5800.100984347433, 5842.328132264844, 5765.509931655856, 5773.797917072882, 5774.335951365562, 5779.566532510079, 5787.1319302104175, 5537.252470916455, 5682.0, 5702.201691763156, 5712.028955077647, 5787.07406814916, 4367.082912588392, 4367.62875155609, 4368.694191406571, 4369.169857727085, 4404.427424434803, 3864.401017842239, 3872.1481274119647, 3892.377219644843, 3930.744501607386, 3944.9211015779524, 5182.352205974254, 5324.254604355393, 5406.216098665672, 5495.258140151029, 5509.0, 5842.036064049385, 5857.7949771757785, 5902.2622172228475, 5922.674252916131, 5962.40375962409, 5456.345238571397, 5462.371827239918, 5464.480874316933, 5468.043092458804, 5471.37079235885, 4819.108464933998, 4897.069556784199, 4988.176950803149, 4988.251762235694, 5016.247562865527, 6021.036634138517, 6024.126501657235, 6032.0, 6032.366601506867, 6033.245844269466, 5707.0583353747825, 5839.970800145972, 5856.180134781049, 5867.647941123546, 5873.970630146822, 5936.525077993837, 5977.073553599199, 5992.730327135202, 6038.154658347747, 6056.424639659225, 5728.770849165987, 5775.364709881994, 5775.6823374714795, 5780.248567686174, 5782.190493330853, 5691.032524470767, 5794.188813566188, 5829.679367634821, 5871.178035075008, 5875.764969401347, 5656.321241450888, 5733.31200255972, 5745.166950792028, 5749.741261643152, 5798.652080875161, 5630.296212973379, 5713.971430142823, 5725.370209276893, 5730.054541000688, 5736.053551164011, 5416.322959630046, 5556.16657501378, 5570.025245582088, 5621.831345059655, 5634.802781902614, 5777.3933736957015, 5806.332271788799, 5812.970935145467, 5819.738111784895, 5823.5923485355615, 5593.664380137205, 5634.859128521656, 5635.605507614428, 5643.717814109196, 5679.204911312337], "value": 5341.7381668367825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.6973283091287, 629.7890206780728, 665.2449469851717, 665.7370338716206, 667.8664267146565, 34772.65227347726, 35390.469142962844, 35462.468062979045, 43482.0, 44917.0, 45546.316805247945, 45859.0828183437, 45942.54057459433, 45954.31068533966, 46060.769696151554, 8859.0, 9014.0, 9018.639254429814, 9090.318226133033, 9108.22580080694, 8996.370254082216, 9099.499527525983, 9100.317476189311, 9102.089791020879, 9107.225885799715, 9021.413608115485, 9035.954820225923, 9044.14080662336, 9076.682316118937, 9127.497987610679, 9059.0, 9094.090590940854, 9103.408278461911, 9115.99724030356, 9116.635334586641, 8827.426217295919, 8908.688195913177, 8909.376343655947, 8910.128872936692, 8910.86633700495, 42134.154572223975, 42358.57641423577, 42424.575754242374, 42444.0, 42475.36286955698, 3684.291736972815, 3758.229562939591, 4140.648044916185, 4191.97904010481, 4255.5318914919335, 32245.0, 32582.837085814655, 32890.01329960105, 33174.0, 33396.33207335864, 4315.136972605492, 4394.340848872663, 4412.05140894706, 4416.2713152329825, 4438.068005718803, 319193.0, 319519.4024029888, 321550.0, 323338.0, 323711.0, 35543.0, 36344.81827590845, 58174.709126454945, 59357.40642593519, 59387.0, 38072.61927380746, 38093.428598571045, 38146.0, 38165.618343816765, 38176.427353589715, 14151.71696566063, 14301.28493575317, 14319.78520322196, 14326.426942922375, 14330.426782928565, 11604.129690273263, 11654.88345116538, 11683.591074312359, 11694.356810375511, 11695.0, 8601.13988601135, 8604.182602652738, 8610.913890861137, 8645.827083458296, 8691.130886911258, 3298.274379636524, 3304.3556506481004, 3340.231746698273, 3341.4653655415505, 3378.442556978071, 1069.1340014588052, 1088.7223757941833, 1119.7704470583674, 1140.3123377401491, 1178.664080737003, 31761.841190793897, 32273.0, 32511.674883251337, 33140.668593313756, 33409.0, 1095.6055819904827, 1130.7681925205313, 1179.1451197881638, 1186.7211205366732, 1276.4638851682316, 16950.830491694924, 17435.0, 17768.555786105193, 17818.376356827448, 17887.552811179823, 468580.0, 534349.0, 543146.0, 545756.0, 883455.0, 60028.0, 60188.0, 60489.0, 60531.0, 60598.0, 1331.9134256273505, 1390.874821266091, 1425.1306702911215, 1445.0, 1464.7143806957754, 30192.396152076395, 31792.36415271728, 32190.678093219703, 32460.513092304107, 32465.675343246265, 52467.0, 58027.4197258022, 58132.41867581439, 58161.0, 58220.70889645694, 438983.0, 443480.0, 443916.0, 444879.0, 445844.0, 38481.4227786589, 38872.805635971636, 43882.734071911575, 44581.0, 46761.0, 48269.5173048265, 48516.272255915486, 49452.752736236085, 49674.254886177456, 50020.74989625174, 40817.1836563273, 41150.0, 41368.586314137676, 41404.79297603493, 42397.364039538814, 40142.598574013886, 40913.79543102384, 41241.0, 41431.585684142774, 41620.375694364004, 41269.58730412657, 42055.7897210512, 42177.78911105425, 42215.57784422117, 42400.78799605982, 35441.0, 36612.0846978817, 36629.63370366369, 37047.0, 37260.254794903405, 28170.15489535317, 28215.43569128647, 28220.382051358738, 28259.0, 28360.48294844327], "value": 19417.36554352099, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.83489851711533, 398.631266078877, 400.82163437270424, 402.62756949821414, 417.9540250572438, 13097.559792364047, 18029.188686509107, 19872.900635496837, 19940.60118797625, 20059.699104513445, 15092.773608395855, 18350.0, 19208.903955480204, 19703.5074123147, 19705.70441443376, 5669.688167150805, 5795.536357091443, 5799.449052340042, 5812.505936995361, 5826.15520749491, 5728.398518155596, 5751.712414379285, 5776.740046697888, 5790.507806836424, 5805.854853628651, 4212.073343864345, 5968.224130863004, 6304.148939893124, 6312.905306420407, 6420.678966051702, 6180.721867515973, 6358.968205158991, 6370.872582548323, 6399.456046236076, 6467.288598254188, 5704.486596206361, 5714.285714285715, 5723.51350135239, 5733.684647344395, 5745.683987380692, 22460.43848903774, 22723.431914202276, 22770.7229277071, 23277.0, 23563.646545301835, 2309.3880121767743, 2343.250159948817, 2363.279199844047, 2401.03958416633, 2868.899588514392, 12292.938535307356, 13653.590392288248, 14646.121232726071, 14868.934635731328, 15258.237088145548, 1891.9810801892081, 1945.4163750874823, 1976.24902537035, 2000.5598768270956, 2050.794920507952, 80001.59999200025, 80923.0, 82438.0, 82835.0, 84018.0, 10289.845652315222, 10331.380117192992, 10379.96200379956, 10664.41345725977, 10708.411037392862, 14381.424743010162, 14381.568552943429, 14391.85608143926, 14406.639834004023, 14415.351309191112, 7723.691052357843, 7913.248241417056, 7922.524648521107, 7940.6029698515995, 8078.35373170145, 7521.435892308099, 7573.659185336673, 7766.145723970359, 7817.413693972861, 7932.524048557105, 5681.914771278434, 6147.692615369214, 6564.638944857983, 6675.0, 6717.328267173243, 1841.272697284565, 1868.8131186881476, 1924.7112933060152, 1927.5084853362303, 1976.8319692825983, 1003.8845532763679, 1020.5713600287897, 1046.9685909422728, 1068.4444089073638, 1110.7851570463245, 19039.90480047591, 19683.212671493267, 19747.40757777269, 19873.60252794936, 19969.400917972485, 1062.4103622489438, 1062.9734256643492, 1071.6356438810842, 1075.4891426572315, 1112.6884472347756, 10817.891821081847, 11432.199746017699, 11509.25189862673, 11519.769604607862, 11527.538898444136, 461576.0, 499293.0, 504142.0, 512687.0, 514445.0, 82353.58823205845, 83227.16772832315, 83946.58026709827, 84099.57950210333, 85772.0, 1051.290378994191, 1054.1260866316256, 1060.2419270221674, 1069.2248120112856, 1076.7954088723118, 17167.828321716624, 17230.95556007799, 17462.47612571625, 17550.38573649916, 17592.56018599545, 35083.824580876935, 35349.1162720934, 35402.46896296506, 35509.0, 35814.0, 49342.50657493379, 51403.74298128486, 51932.0, 54514.45485545094, 58847.41152588419, 8464.541508140594, 8692.261157801659, 8768.912310876809, 8800.0, 8883.333749968908, 8029.0, 8477.957610212155, 13982.650433739238, 14169.716605668034, 14515.564533064025, 11747.236429632047, 12102.93948530287, 12360.690982725504, 12511.311877846441, 12564.057695673044, 11708.590199342982, 12082.33547154915, 12114.454849531969, 12365.690857728629, 12635.494580216688, 12326.445309960895, 12403.937980310402, 12650.0, 12729.0, 12828.358582071045, 7370.852582948418, 7544.358729508053, 7641.808954776175, 7673.34776544, 8062.39532035088, 9817.705468835946, 11912.940435297767, 11924.165308428326, 12132.636020919386, 12175.634730958085], "value": 9348.020757911514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.2269506381367, 1488.025343400073, 1542.7068856917185, 1724.689555879941, 1856.2853301478926, 8322.625481853316, 8788.868166977492, 8791.032986371501, 8965.91034089659, 8978.191962723353, 8606.182412670802, 8772.824543509141, 8784.868226976601, 8784.91215087849, 8796.69211577595, 1999.9600007999832, 2039.1843262694892, 2234.72065991751, 2256.311824893403, 2305.3314538783816, 2331.73185083715, 2345.7419683834764, 2347.2840783561005, 2350.048230466664, 2351.764823517643, 2280.486890449644, 2296.334063121693, 2304.2396009316885, 2308.4575124845646, 2309.099451214028, 1961.1861077652757, 2199.065397206181, 2241.428435748882, 2271.3867255840833, 2271.704678391815, 2224.443889027743, 2235.910563577455, 2246.2811900191946, 2249.325202439262, 2253.1325439705665, 8749.737507874774, 8800.163984421533, 8805.119488051208, 8806.427582207136, 8810.38327317088, 5240.973795131038, 5346.465353464661, 5347.278117454132, 5369.087255166592, 5373.435789242151, 3266.477363621833, 3324.1523411530147, 3381.9492707609406, 3406.914827129317, 3414.23179784549, 1055.709679838043, 1109.2013750099916, 1118.401655114518, 1184.224333061846, 1195.6532605544382, 12402.503899843996, 12410.5656302029, 12413.813792793115, 12424.192427492275, 12460.563880264148, 4624.213883639789, 4669.322948172564, 4773.880652983703, 4809.2305231162845, 4824.638152138604, 10288.537015834305, 10302.381857088598, 10308.0, 10324.845127323097, 10344.172466202686, 5327.653702509325, 5404.351477822686, 5421.132618781055, 5426.9185962210595, 5427.782888684487, 4328.415663885398, 4788.23388257884, 4882.389701287339, 4890.266460030953, 4976.925346119811, 4025.7181997260495, 4031.5162180538523, 4041.4522990165283, 4078.7144899857317, 4182.519010313853, 1293.7865252233275, 1317.3347459533065, 1319.6107148391247, 1322.9801552976712, 1325.4035683942266, 949.8765160529088, 951.7715748220515, 953.0279115302492, 955.9044095590385, 985.1724551376734, 5591.804286850022, 5645.435456454322, 5709.371969083398, 5734.455226753452, 5832.1834943108, 429.60261757873843, 431.1893639956861, 433.80695590461943, 438.6863392674253, 444.2093074327702, 3985.143194213258, 3997.4603428537357, 4003.4395184673585, 4055.756654600674, 4155.085881106152, 10719.517621707042, 11083.279586826831, 11168.106551475863, 11171.776564468664, 11177.0, 10754.300970436896, 10759.085477734323, 10853.457327133612, 11014.779704405866, 11028.889711102785, 8266.380021498411, 8433.367497437594, 8434.198751118634, 8452.57737113142, 8482.703105391405, 5727.341355744143, 5797.304323481209, 5803.419658034163, 5811.883762324815, 5903.970480147572, 10160.187185025032, 10241.231907607109, 10334.689959301233, 10368.792624147625, 10400.947995259976, 10253.692389228336, 10329.070383665507, 10505.947470262905, 10513.474326283502, 10547.736306592396, 7066.858662826818, 7319.597422141834, 7512.737054203077, 7863.0, 7940.801479963047, 8434.072252052147, 8464.703735369232, 8476.745697629081, 8515.787105322168, 8515.957420212859, 7522.962385188039, 7741.651625676971, 7745.302922736981, 7758.806029849073, 7940.483868548526, 7566.810829729301, 7694.653740581799, 7737.535747854921, 7863.370930325675, 7864.252895974873, 6968.223103108675, 6993.4754893384215, 7019.0, 7022.929770702228, 7033.472489563201, 4702.482726900107, 4774.761261936958, 4870.342503761947, 4880.097182021337, 4884.413870335582, 4838.612910967044, 4869.147899117569, 4886.95113048865, 4958.975205123951, 5001.8749531260555], "value": 4527.493550458724, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.96860313968597, 317.40328183015924, 318.3442109254936, 320.4728222074689, 322.1109737125534, 5362.946370536293, 5373.328333958255, 5420.617742475663, 5439.156930675752, 5449.128139497676, 5298.947010529893, 5300.337457817773, 5331.733413329328, 5350.170723537848, 5354.41101478838, 3961.227560625679, 4019.9799001004953, 4100.548939616655, 4137.875863724078, 4161.167766446708, 4072.552019277877, 4084.8978775530554, 4097.569755175708, 4098.364753463218, 4136.9864383226, 3979.343408337621, 4083.530394004698, 4083.612056854594, 4094.222097801423, 4096.242195193899, 4015.31739604268, 4137.77242251676, 4138.565450627701, 4155.210510003105, 4168.458100446953, 3638.1263649220673, 3653.104989277644, 3653.853845846163, 3654.945175822365, 3659.6157403472785, 5149.201873709581, 5161.509656582619, 5185.170372740344, 5189.221616757479, 5210.0, 4452.332150177467, 4633.675642705012, 4638.397008388922, 4646.210144275447, 4673.322368256618, 5515.0, 5542.334919809648, 5544.722763861791, 5546.306711661043, 5563.916541251844, 3866.0, 3897.2400381925536, 3897.7661340319673, 3917.9822391468415, 3921.509811273591, 5653.349864765563, 5782.797602083949, 5811.4479124483105, 5834.183214349994, 5846.795362162304, 3976.304146774303, 3983.402489626579, 3985.9202815943518, 3989.5412027616617, 3996.1208534122447, 4038.757674539537, 4040.9797951010646, 4074.8573799916862, 4077.1845630873945, 4079.673626109904, 4539.795709193094, 4613.861584152481, 4635.907281854344, 4698.694584851974, 4735.715857048588, 5542.501174894279, 5561.915426491876, 5604.299462567179, 5611.37270191648, 5680.687562184037, 1393.7700279453777, 1394.2053029773135, 1398.4196558428341, 1398.4755716606273, 1412.4703236286393, 877.9692710755093, 889.3088955758426, 905.6151135767273, 914.1133100892124, 929.8419268724333, 5301.5493683037375, 5306.92039619406, 5323.707196104251, 5330.841943284167, 5386.272853164773, 5661.0, 5696.544276457874, 5698.6580805151, 5709.545724836497, 5711.428857114255, 5221.198686453167, 5324.387695414999, 5325.707086110224, 5366.356037275474, 5377.892442151213, 2975.9256018599276, 3028.530577760451, 3036.529337952621, 3057.801242919203, 3081.8613162407296, 5610.831675049755, 5799.246098007232, 5851.180834683148, 5908.961408314125, 5947.0, 5746.540276777848, 5765.990951583456, 5779.971100144472, 5785.942140578624, 5794.913076303858, 5827.3007239131575, 5835.328937172195, 5836.0, 5841.357450680422, 5848.64908105515, 5417.51242388187, 5654.692005177018, 5682.204491371294, 5776.277965254343, 5821.79623713168, 5728.140778883201, 5751.252337196138, 5759.798407055733, 5759.884802304015, 5778.393268706725, 5749.987504373603, 6012.939870601238, 6029.879402412015, 6042.939570604238, 6064.151018857452, 4043.575424580494, 4051.655609273245, 4060.4570263299756, 4060.837566497307, 4070.2266569351727, 5853.09277062056, 5871.7651293947765, 5880.529557635465, 5895.410458954242, 5912.763489460373, 5496.148097044965, 5650.039493286234, 5691.2032315475035, 5748.103125968337, 5752.654840709571, 5647.3505546861, 5651.350094738993, 5656.236408084856, 5664.291963504562, 5673.971630141988, 5344.438833922538, 5355.357357117171, 5455.863603409946, 5492.5605951524585, 5630.23991761107, 5597.552195824405, 5620.0, 5651.180578816131, 5660.179274005329, 5674.092145256739, 5504.394516603251, 5517.558595312285, 5573.581981351496, 5611.887762244651, 5634.408387119457], "value": 4235.12181211459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.5850902748972, 763.0576238345642, 767.3515879082178, 837.5602808525523, 847.8092429203429, 14502.5649230523, 15288.0, 15377.0, 15410.69178616427, 15691.764623530657, 15031.398744050251, 15528.689426211497, 15685.84314156858, 15698.37206511741, 15722.528324150266, 708.6669265445258, 805.2108933245423, 849.6813694864426, 852.5098068610542, 856.6316483911916, 822.6133717152959, 823.27551754456, 823.6458322921142, 824.1140773668301, 834.8664213725805, 870.2950610005884, 874.0909454167689, 874.2743522876029, 874.567089290802, 875.1511034296722, 735.7608777147449, 848.0925409811442, 867.6616119713317, 868.8957325120995, 874.9956250218709, 640.1965533255781, 640.942315191635, 641.6470940982488, 642.6497558830449, 642.958207716497, 14624.634384140481, 14650.853491465163, 14665.633359165999, 14690.338934747962, 14712.48506302285, 12761.425735841909, 13025.283609401478, 13099.738005239842, 13222.933885330513, 13259.403326850315, 11122.443877806078, 11696.12279079064, 12057.819132713017, 12209.389530523438, 12434.316112613802, 3810.085579460937, 3845.8269377878064, 3889.144388234612, 3963.3064213762477, 3968.0476685595536, 52651.21023184617, 54865.451345486836, 54868.17697734537, 55061.174082388796, 55079.173812392844, 10962.397068161328, 11285.266457680389, 11558.768824623628, 11628.825567616492, 11677.591284305008, 18729.0, 18858.528536786416, 18874.0, 18879.43361699151, 19023.904880475508, 6778.2205046420295, 7292.8176795579475, 7744.109427415807, 8192.744787765358, 8443.197896199852, 4658.394408726844, 4750.406199225097, 4764.737939413296, 4846.466888642247, 4883.072216278895, 3294.258791771832, 3364.915877103092, 3384.2047118927035, 3393.983030084834, 3394.321135772855, 572.619208226533, 630.2562975688639, 647.5758378262245, 665.8335416145964, 670.5105273150627, 664.3688495928886, 674.5581644023173, 694.1947341084318, 712.975045873392, 725.329070609684, 8676.262517686067, 8793.604287807064, 8836.248918841842, 8839.823203535892, 8937.0, 693.4902846407887, 719.1811481035613, 753.5591678867814, 761.3908872901767, 765.8276887700223, 4356.49900261474, 4475.48531918827, 4598.356230127785, 4815.3258543803895, 4868.78090485929, 64392.356076438635, 67807.3219267811, 67840.66079669668, 68078.0, 68096.6595167021, 61638.0, 62392.37607623866, 62946.68526657429, 63240.68379658072, 64559.354406456274, 55293.723531382086, 55812.72093639587, 55883.441165588636, 56478.43521564896, 57480.42519574834, 8895.377323587287, 9041.367104302635, 9076.863847042168, 9230.815383692154, 9235.953820230856, 32729.836350818092, 32747.508787368686, 33656.0, 35293.294134117685, 35592.0, 43074.13851723011, 45792.313115303965, 47079.76460117677, 47128.528714713786, 49352.75323623359, 13024.8046279304, 13251.13867598603, 13270.071095023255, 13448.596542103753, 13533.255670938193, 13519.662008449868, 13830.308484575933, 14190.60091371678, 14278.928605356907, 14465.204413757345, 9872.654457093968, 12515.0, 12569.811452828031, 12668.936655316664, 12867.549635762703, 11013.779724405627, 11132.332060076422, 11156.0, 11468.94265528667, 11664.950154485798, 11449.885501145216, 11589.130815188726, 11853.881461185278, 11900.702482438008, 11981.700457488283, 11069.391183484664, 11173.385463799244, 11416.257943233662, 11494.252873563191, 11563.768724625292, 11236.325820450798, 11266.155038372319, 11376.146788991024, 11566.363849988331, 11692.123090768397], "value": 6873.504513958528, "unit": "score"}], "name": "dromaeo_css", "value": 7097.24601140043, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 153.0, 200.0, 129.0, 154.0, 147.0, 126.0, 181.0, 124.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 159.0, 160.0, 162.0, 161.0, 163.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 152.0, 75.0, 74.0, 75.0, 75.0, 137.0, 75.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 156.0, 92.0, 92.0, 91.0, 132.0, 91.0, 91.0, 130.0], "value": 105.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 59.0, 58.0, 58.0, 58.0, 62.0, 119.0, 58.0, 56.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 78.0, 79.0, 80.0, 80.0, 79.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 123.0, 120.0, 123.0, 126.0, 122.0, 120.0, 237.0, 136.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 165.0, 168.0, 166.0, 168.0, 165.0, 166.0, 165.0, 165.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 65.0, 64.0, 64.0, 63.0, 63.0, 63.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1540.3999999999999, "alertThreshold": 2.0}]} 11:27:37 INFO - Return code: 0 11:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:27:37 ERROR - # TBPL SUCCESS # 11:27:37 INFO - Running post-action listener: _resource_record_post_action 11:27:37 INFO - ##### 11:27:37 INFO - ##### Finished run-tests step (success) 11:27:37 INFO - ##### 11:27:37 INFO - Running post-run listener: _resource_record_post_run 11:27:38 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534343680; Read time: 8; Write time: 544288 11:27:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244883456; Read time: 0; Write time: 244356 11:27:38 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289460224; Read time: 8; Write time: 299932 11:27:38 INFO - Running post-run listener: _upload_blobber_files 11:27:38 INFO - Blob upload gear active. 11:27:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:38 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 11:27:38 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:38 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:39 INFO - (blobuploader) - INFO - Done attempting. 11:27:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:27:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:27:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:40 INFO - (blobuploader) - INFO - Done attempting. 11:27:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:40 INFO - Return code: 0 11:27:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec4010a69f25c136284798d3d5a6cae8eee512353374a5d0c247793ec1d1c44172f3d4938d5bf148a8234686a5542a38fe94bed3065a675fc64b709e8b4113ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e48fa334d7115c824185cecc9e38fa3a7ebc5dea43345b8bbb0c794b151783e22559044f71fc69d915c6ef99563226d4e915f2a0fdb343057b9028ead855ac5"} 11:27:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:40 INFO - Contents: 11:27:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec4010a69f25c136284798d3d5a6cae8eee512353374a5d0c247793ec1d1c44172f3d4938d5bf148a8234686a5542a38fe94bed3065a675fc64b709e8b4113ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e48fa334d7115c824185cecc9e38fa3a7ebc5dea43345b8bbb0c794b151783e22559044f71fc69d915c6ef99563226d4e915f2a0fdb343057b9028ead855ac5"} 11:27:40 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:40 INFO - Copying logs to upload dir... 11:27:40 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.326513 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-11 11:27:40.171376) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 11:27:40.175130) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779 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/sha512/ec4010a69f25c136284798d3d5a6cae8eee512353374a5d0c247793ec1d1c44172f3d4938d5bf148a8234686a5542a38fe94bed3065a675fc64b709e8b4113ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e48fa334d7115c824185cecc9e38fa3a7ebc5dea43345b8bbb0c794b151783e22559044f71fc69d915c6ef99563226d4e915f2a0fdb343057b9028ead855ac5"} build_url:https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec4010a69f25c136284798d3d5a6cae8eee512353374a5d0c247793ec1d1c44172f3d4938d5bf148a8234686a5542a38fe94bed3065a675fc64b709e8b4113ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e48fa334d7115c824185cecc9e38fa3a7ebc5dea43345b8bbb0c794b151783e22559044f71fc69d915c6ef99563226d4e915f2a0fdb343057b9028ead855ac5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 11:27:40.202557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:27:40.203033) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1462987853.31369-234809779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:27:40.286645) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 11:27:40.286995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 11:27:40.287305) ========= ========= Total master_lag: 0.18 =========