builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1462838766.56 results: success (0) buildid: 20160509143013 builduid: 52be771c603a49889f6b933fa2f26b99 revision: a3033ed384eb846bf37d9a4bf59a3728f15e9f74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.557963) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.558508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.558795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.587004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.587288) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 17:06:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-09 17:06:07 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.703051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.703354) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015437 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.758993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:06.759311) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3033ed384eb846bf37d9a4bf59a3728f15e9f74 --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 a3033ed384eb846bf37d9a4bf59a3728f15e9f74 --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=82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 17:06:07,633 truncating revision to first 12 chars 2016-05-09 17:06:07,633 Setting DEBUG logging. 2016-05-09 17:06:07,633 attempt 1/10 2016-05-09 17:06:07,633 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3033ed384eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 17:06:07,911 unpacking tar archive at: fx-team-a3033ed384eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557079 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:07.342392) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:07.342760) ========= script_repo_revision: a3033ed384eb846bf37d9a4bf59a3728f15e9f74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:07.343227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:07.343516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 17:06:07.353911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-09 17:06:07.354326) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:08 INFO - MultiFileLogger online at 20160509 17:06:08 in /builds/slave/test 17:06:08 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 17:06:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:08 INFO - {'append_to_log': False, 17:06:08 INFO - 'base_work_dir': '/builds/slave/test', 17:06:08 INFO - 'blob_upload_branch': 'Fx-Team', 17:06:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:08 INFO - 'branch': 'Fx-Team', 17:06:08 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:08 INFO - 'config_files': ('talos/linux_config.py',), 17:06:08 INFO - 'default_actions': ('clobber', 17:06:08 INFO - 'read-buildbot-config', 17:06:08 INFO - 'download-and-extract', 17:06:08 INFO - 'populate-webroot', 17:06:08 INFO - 'create-virtualenv', 17:06:08 INFO - 'install', 17:06:08 INFO - 'run-tests'), 17:06:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:08 INFO - 'download_minidump_stackwalk': True, 17:06:08 INFO - 'download_symbols': 'ondemand', 17:06:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:08 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:08 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:08 INFO - 'installer_path': 'installer.exe', 17:06:08 INFO - 'log_level': 'info', 17:06:08 INFO - 'log_name': 'talos', 17:06:08 INFO - 'log_to_console': True, 17:06:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:08 INFO - 'opt_config_files': (), 17:06:08 INFO - 'pip_index': False, 17:06:08 INFO - 'sps_profile': False, 17:06:08 INFO - 'sps_profile_interval': 0, 17:06:08 INFO - 'suite': 'dromaeojs', 17:06:08 INFO - 'system_bits': '32', 17:06:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:08 INFO - 'title': 'talos-linux64-ix-066', 17:06:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:08 INFO - 'use_talos_json': True, 17:06:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:08 INFO - 'work_dir': 'build'} 17:06:08 INFO - ##### 17:06:08 INFO - ##### Running clobber step. 17:06:08 INFO - ##### 17:06:08 INFO - Running pre-action listener: _resource_record_pre_action 17:06:08 INFO - Running main action method: clobber 17:06:08 INFO - rmtree: /builds/slave/test/build 17:06:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:08 INFO - Running post-action listener: _resource_record_post_action 17:06:08 INFO - ##### 17:06:08 INFO - ##### Finished clobber step (success) 17:06:08 INFO - ##### 17:06:08 INFO - ##### 17:06:08 INFO - ##### Running read-buildbot-config step. 17:06:08 INFO - ##### 17:06:08 INFO - Running pre-action listener: _resource_record_pre_action 17:06:08 INFO - Running main action method: read_buildbot_config 17:06:08 INFO - Using buildbot properties: 17:06:08 INFO - { 17:06:08 INFO - "project": "", 17:06:08 INFO - "product": "firefox", 17:06:08 INFO - "script_repo_revision": "production", 17:06:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:06:08 INFO - "repository": "", 17:06:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:06:08 INFO - "buildid": "20160509143013", 17:06:08 INFO - "pgo_build": "True", 17:06:08 INFO - "basedir": "/builds/slave/test", 17:06:08 INFO - "buildnumber": 72, 17:06:08 INFO - "slavename": "talos-linux64-ix-066", 17:06:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:06:08 INFO - "platform": "ubuntu64_hw", 17:06:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:06:08 INFO - "branch": "fx-team", 17:06:08 INFO - "repo_path": "integration/fx-team", 17:06:08 INFO - "revision": "a3033ed384eb846bf37d9a4bf59a3728f15e9f74", 17:06:08 INFO - "stage_platform": "linux64-pgo", 17:06:08 INFO - "builduid": "52be771c603a49889f6b933fa2f26b99", 17:06:08 INFO - "slavebuilddir": "test" 17:06:08 INFO - } 17:06:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:06:08 INFO - Running post-action listener: _resource_record_post_action 17:06:08 INFO - ##### 17:06:08 INFO - ##### Finished read-buildbot-config step (success) 17:06:08 INFO - ##### 17:06:08 INFO - ##### 17:06:08 INFO - ##### Running download-and-extract step. 17:06:08 INFO - ##### 17:06:08 INFO - Running pre-action listener: _resource_record_pre_action 17:06:08 INFO - Running main action method: download_and_extract 17:06:08 INFO - mkdir: /builds/slave/test/build/tests 17:06:08 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')]} 17:06:08 INFO - https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:06:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:15 INFO - Downloaded 1361 bytes. 17:06:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:15 INFO - Using the following test package requirements: 17:06:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:06:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:15 INFO - u'jsshell-linux-x86_64.zip'], 17:06:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06: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')]} 17:06:15 INFO - https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:19 INFO - Downloaded 23895585 bytes. 17:06:19 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'] 17:06:19 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 17:06:20 INFO - Return code: 0 17:06:20 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 17:06:20 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')]} 17:06:20 INFO - https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:25 INFO - Downloaded 23895585 bytes. 17:06:25 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'] 17:06:25 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 17:06:27 INFO - Return code: 0 17:06: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')]} 17:06:27 INFO - https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:28 INFO - Downloaded 10840152 bytes. 17:06:28 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'] 17:06:28 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 17:06:28 INFO - Return code: 0 17:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:28 INFO - https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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 17:06:32 INFO - Downloaded 58433671 bytes. 17:06:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:32 INFO - mkdir: /builds/slave/test/properties 17:06:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:32 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:32 INFO - Contents: 17:06:32 INFO - build_url:https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:33 INFO - Running post-action listener: _resource_record_post_action 17:06:33 INFO - Running post-action listener: set_extra_try_arguments 17:06:33 INFO - ##### 17:06:33 INFO - ##### Finished download-and-extract step (success) 17:06:33 INFO - ##### 17:06:33 INFO - ##### 17:06:33 INFO - ##### Running populate-webroot step. 17:06:33 INFO - ##### 17:06:33 INFO - Running pre-action listener: _resource_record_pre_action 17:06:33 INFO - Running main action method: populate_webroot 17:06:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:33 INFO - '--tppagecycles', 17:06:33 INFO - '7'], 17:06:33 INFO - 'tests': ['tsvgm']}}, 17:06:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:06:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:06:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:06:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:33 INFO - 'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:33 INFO - 'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['damp', 'tps']}, 17:06:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:33 INFO - 'tests': ['damp', 'tps']}, 17:06:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['dromaeo_dom']}, 17:06:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['a11yr', 17:06:33 INFO - 'ts_paint', 17:06:33 INFO - 'tpaint', 17:06:33 INFO - 'sessionrestore', 17:06:33 INFO - 'sessionrestore_no_auto_restore', 17:06:33 INFO - 'tabpaint']}, 17:06:33 INFO - 'other-e10s': {'tests': ['a11yr', 17:06:33 INFO - 'ts_paint', 17:06:33 INFO - 'tpaint', 17:06:33 INFO - 'sessionrestore', 17:06:33 INFO - 'sessionrestore_no_auto_restore', 17:06:33 INFO - 'tabpaint']}, 17:06:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:06:33 INFO - 'ts_paint', 17:06:33 INFO - 'tpaint', 17:06:33 INFO - 'sessionrestore', 17:06:33 INFO - 'sessionrestore_no_auto_restore', 17:06:33 INFO - 'tabpaint']}, 17:06:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:06:33 INFO - 'ts_paint', 17:06:33 INFO - 'tpaint', 17:06:33 INFO - 'sessionrestore', 17:06:33 INFO - 'sessionrestore_no_auto_restore', 17:06:33 INFO - 'tabpaint']}, 17:06:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['a11yr', 17:06:33 INFO - 'ts_paint', 17:06:33 INFO - 'tpaint', 17:06:33 INFO - 'sessionrestore', 17:06:33 INFO - 'sessionrestore_no_auto_restore', 17:06:33 INFO - 'tabpaint']}, 17:06:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['a11yr', 17:06:33 INFO - 'ts_paint', 17:06:33 INFO - 'tpaint', 17:06:33 INFO - 'sessionrestore', 17:06:33 INFO - 'sessionrestore_no_auto_restore', 17:06:33 INFO - 'tabpaint']}, 17:06:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['tsvgx', 17:06:33 INFO - 'tsvgr_opacity', 17:06:33 INFO - 'tart', 17:06:33 INFO - 'tscrollx', 17:06:33 INFO - 'cart']}, 17:06:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:06:33 INFO - 'tsvgr_opacity', 17:06:33 INFO - 'tart', 17:06:33 INFO - 'tscrollx', 17:06:33 INFO - 'cart']}, 17:06:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:33 INFO - 'talos_options': ['--disable-e10s'], 17:06:33 INFO - 'tests': ['tp5o']}, 17:06:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:33 INFO - 'tests': ['tp5o']}, 17:06:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:33 INFO - 'talos_options': ['--disable-e10s', 17:06:33 INFO - '--xperf_path', 17:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:33 INFO - 'tests': ['tp5n']}, 17:06:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:33 INFO - 'talos_options': ['--xperf_path', 17:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:33 INFO - 'tests': ['tp5n']}}, 17:06:33 INFO - 'talos.zip': {'path': '', 17:06:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:33 INFO - Running post-action listener: _resource_record_post_action 17:06:33 INFO - ##### 17:06:33 INFO - ##### Finished populate-webroot step (success) 17:06:33 INFO - ##### 17:06:33 INFO - ##### 17:06:33 INFO - ##### Running create-virtualenv step. 17:06:33 INFO - ##### 17:06:33 INFO - Running pre-action listener: _resource_record_pre_action 17:06:33 INFO - Running main action method: create_virtualenv 17:06:33 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:33 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 17:06:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:33 INFO - Using real prefix '/usr' 17:06:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:33 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:35 INFO - Installing pip.................done. 17:06:35 INFO - Return code: 0 17:06:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06:35 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')]} 17:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:35 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')]} 17:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:35 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 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:35 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 17:06:35 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 17:06:35 INFO - Using env: {'DISPLAY': ':0', 17:06:35 INFO - 'HOME': '/home/cltbld', 17:06:35 INFO - 'LANG': 'en_US.UTF-8', 17:06:35 INFO - 'LANGUAGE': 'en_US:en', 17:06:35 INFO - 'LOGNAME': 'cltbld', 17:06:35 INFO - 'MAIL': '/var/mail/cltbld', 17:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:35 INFO - 'MOZ_NO_REMOTE': '1', 17:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:35 INFO - 'NO_EM_RESTART': '1', 17:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:35 INFO - 'PWD': '/builds/slave/test', 17:06:35 INFO - 'SHELL': '/bin/bash', 17:06:35 INFO - 'SHLVL': '1', 17:06:35 INFO - 'TERM': 'linux', 17:06:35 INFO - 'TMOUT': '86400', 17:06:35 INFO - 'USER': 'cltbld', 17:06:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:35 INFO - '_': '/tools/buildbot/bin/python'} 17:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:36 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 17:06:36 INFO - Cleaning up... 17:06:36 INFO - Return code: 0 17:06:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:06:36 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')]} 17:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:36 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')]} 17:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:36 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 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:36 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 17:06:36 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 17:06:36 INFO - Using env: {'DISPLAY': ':0', 17:06:36 INFO - 'HOME': '/home/cltbld', 17:06:36 INFO - 'LANG': 'en_US.UTF-8', 17:06:36 INFO - 'LANGUAGE': 'en_US:en', 17:06:36 INFO - 'LOGNAME': 'cltbld', 17:06:36 INFO - 'MAIL': '/var/mail/cltbld', 17:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:36 INFO - 'MOZ_NO_REMOTE': '1', 17:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:36 INFO - 'NO_EM_RESTART': '1', 17:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:36 INFO - 'PWD': '/builds/slave/test', 17:06:36 INFO - 'SHELL': '/bin/bash', 17:06:36 INFO - 'SHLVL': '1', 17:06:36 INFO - 'TERM': 'linux', 17:06:36 INFO - 'TMOUT': '86400', 17:06:36 INFO - 'USER': 'cltbld', 17:06:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:36 INFO - '_': '/tools/buildbot/bin/python'} 17:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:36 INFO - Downloading/unpacking psutil>=0.7.1 17:06:36 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 17:06:36 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 17:06:36 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 17:06:36 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 17:06:36 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 17:06:36 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 17:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:38 INFO - Installing collected packages: psutil 17:06:38 INFO - Running setup.py install for psutil 17:06:38 INFO - building 'psutil._psutil_linux' extension 17:06:38 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 17:06:38 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 17:06:38 INFO - building 'psutil._psutil_posix' extension 17:06:38 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 17:06:38 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 17:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:38 INFO - Successfully installed psutil 17:06:38 INFO - Cleaning up... 17:06:38 INFO - Return code: 0 17:06:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:06:38 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')]} 17:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:38 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')]} 17:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:38 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 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:38 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 17:06:38 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 17:06:38 INFO - Using env: {'DISPLAY': ':0', 17:06:38 INFO - 'HOME': '/home/cltbld', 17:06:38 INFO - 'LANG': 'en_US.UTF-8', 17:06:38 INFO - 'LANGUAGE': 'en_US:en', 17:06:38 INFO - 'LOGNAME': 'cltbld', 17:06:38 INFO - 'MAIL': '/var/mail/cltbld', 17:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:38 INFO - 'MOZ_NO_REMOTE': '1', 17:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:38 INFO - 'NO_EM_RESTART': '1', 17:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:38 INFO - 'PWD': '/builds/slave/test', 17:06:38 INFO - 'SHELL': '/bin/bash', 17:06:38 INFO - 'SHLVL': '1', 17:06:38 INFO - 'TERM': 'linux', 17:06:38 INFO - 'TMOUT': '86400', 17:06:38 INFO - 'USER': 'cltbld', 17:06:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:38 INFO - '_': '/tools/buildbot/bin/python'} 17:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:06:40 INFO - Installing collected packages: mozsystemmonitor 17:06:40 INFO - Running setup.py install for mozsystemmonitor 17:06:41 INFO - Successfully installed mozsystemmonitor 17:06:41 INFO - Cleaning up... 17:06:41 INFO - Return code: 0 17:06:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:41 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 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:41 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 17:06:41 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 17:06:41 INFO - Using env: {'DISPLAY': ':0', 17:06:41 INFO - 'HOME': '/home/cltbld', 17:06:41 INFO - 'LANG': 'en_US.UTF-8', 17:06:41 INFO - 'LANGUAGE': 'en_US:en', 17:06:41 INFO - 'LOGNAME': 'cltbld', 17:06:41 INFO - 'MAIL': '/var/mail/cltbld', 17:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:41 INFO - 'MOZ_NO_REMOTE': '1', 17:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:41 INFO - 'NO_EM_RESTART': '1', 17:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:41 INFO - 'PWD': '/builds/slave/test', 17:06:41 INFO - 'SHELL': '/bin/bash', 17:06:41 INFO - 'SHLVL': '1', 17:06:41 INFO - 'TERM': 'linux', 17:06:41 INFO - 'TMOUT': '86400', 17:06:41 INFO - 'USER': 'cltbld', 17:06:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:41 INFO - '_': '/tools/buildbot/bin/python'} 17:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:41 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:41 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 17:06:41 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 17:06:41 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 17:06:41 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 17:06:41 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 17:06:41 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 17:06:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 INFO - Downloading docopt-0.6.1.tar.gz 17:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:43 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:43 INFO - Running setup.py install for blobuploader 17:06:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:43 INFO - Running setup.py install for requests 17:06:44 INFO - Running setup.py install for docopt 17:06:44 INFO - Successfully installed blobuploader requests docopt 17:06:44 INFO - Cleaning up... 17:06:44 INFO - Return code: 0 17:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:44 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')]} 17:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:44 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')]} 17:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:44 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 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:44 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 17:06:44 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 17:06:44 INFO - Using env: {'DISPLAY': ':0', 17:06:44 INFO - 'HOME': '/home/cltbld', 17:06:44 INFO - 'LANG': 'en_US.UTF-8', 17:06:44 INFO - 'LANGUAGE': 'en_US:en', 17:06:44 INFO - 'LOGNAME': 'cltbld', 17:06:44 INFO - 'MAIL': '/var/mail/cltbld', 17:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:44 INFO - 'MOZ_NO_REMOTE': '1', 17:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:44 INFO - 'NO_EM_RESTART': '1', 17:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:44 INFO - 'PWD': '/builds/slave/test', 17:06:44 INFO - 'SHELL': '/bin/bash', 17:06:44 INFO - 'SHLVL': '1', 17:06:44 INFO - 'TERM': 'linux', 17:06:44 INFO - 'TMOUT': '86400', 17:06:44 INFO - 'USER': 'cltbld', 17:06:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:44 INFO - '_': '/tools/buildbot/bin/python'} 17:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:44 INFO - Running setup.py (path:/tmp/pip-s01yPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:44 INFO - Running setup.py (path:/tmp/pip-0dUgvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:44 INFO - Running setup.py (path:/tmp/pip-9C3jX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:44 INFO - Running setup.py (path:/tmp/pip-neF_wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:45 INFO - Running setup.py (path:/tmp/pip-bxB4HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:45 INFO - Running setup.py (path:/tmp/pip-Ecd6PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:45 INFO - Running setup.py (path:/tmp/pip-meyidP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:45 INFO - Running setup.py (path:/tmp/pip-Ya1Chl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:45 INFO - Running setup.py (path:/tmp/pip-Zp7qsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:45 INFO - Running setup.py (path:/tmp/pip-DQaqpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:45 INFO - Running setup.py (path:/tmp/pip-VIDSzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:45 INFO - Running setup.py (path:/tmp/pip-40u6cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:45 INFO - Running setup.py (path:/tmp/pip-3bz8w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:45 INFO - Running setup.py (path:/tmp/pip-QPsRHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:45 INFO - Running setup.py (path:/tmp/pip-kYzOnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:45 INFO - Running setup.py (path:/tmp/pip-7Qkp_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:45 INFO - Running setup.py (path:/tmp/pip-PitkU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:45 INFO - Running setup.py install for manifestparser 17:06:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Running setup.py install for mozcrash 17:06:46 INFO - Running setup.py install for mozdebug 17:06:46 INFO - Running setup.py install for mozdevice 17:06:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Running setup.py install for mozfile 17:06:46 INFO - Running setup.py install for mozhttpd 17:06:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Running setup.py install for mozinfo 17:06:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Running setup.py install for mozInstall 17:06:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Running setup.py install for mozleak 17:06:46 INFO - Running setup.py install for mozlog 17:06:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Running setup.py install for moznetwork 17:06:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:47 INFO - Running setup.py install for mozprocess 17:06:47 INFO - Running setup.py install for mozprofile 17:06:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:47 INFO - Running setup.py install for mozrunner 17:06:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:47 INFO - Running setup.py install for mozscreenshot 17:06:47 INFO - Running setup.py install for moztest 17:06:47 INFO - Running setup.py install for mozversion 17:06:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:47 INFO - Cleaning up... 17:06:47 INFO - Return code: 0 17:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:47 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 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:47 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 17:06:47 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 17:06:47 INFO - Using env: {'DISPLAY': ':0', 17:06:47 INFO - 'HOME': '/home/cltbld', 17:06:47 INFO - 'LANG': 'en_US.UTF-8', 17:06:47 INFO - 'LANGUAGE': 'en_US:en', 17:06:47 INFO - 'LOGNAME': 'cltbld', 17:06:47 INFO - 'MAIL': '/var/mail/cltbld', 17:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:47 INFO - 'MOZ_NO_REMOTE': '1', 17:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:47 INFO - 'NO_EM_RESTART': '1', 17:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:47 INFO - 'PWD': '/builds/slave/test', 17:06:47 INFO - 'SHELL': '/bin/bash', 17:06:47 INFO - 'SHLVL': '1', 17:06:47 INFO - 'TERM': 'linux', 17:06:47 INFO - 'TMOUT': '86400', 17:06:47 INFO - 'USER': 'cltbld', 17:06:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:47 INFO - '_': '/tools/buildbot/bin/python'} 17:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:47 INFO - Running setup.py (path:/tmp/pip-YZ3cos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:48 INFO - Running setup.py (path:/tmp/pip-3mkECY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:48 INFO - Running setup.py (path:/tmp/pip-PwYIZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:48 INFO - Running setup.py (path:/tmp/pip-claQzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:48 INFO - Running setup.py (path:/tmp/pip-ALgCpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:48 INFO - Running setup.py (path:/tmp/pip-u72A8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:48 INFO - Running setup.py (path:/tmp/pip-h7Ji1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:48 INFO - Running setup.py (path:/tmp/pip-XtN0b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:48 INFO - Running setup.py (path:/tmp/pip-HSsU4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:48 INFO - Running setup.py (path:/tmp/pip-hFQ5Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:48 INFO - Running setup.py (path:/tmp/pip-5u2CiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:48 INFO - Running setup.py (path:/tmp/pip-JyLjCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:48 INFO - Running setup.py (path:/tmp/pip-sTPs8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:48 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)) 17:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:48 INFO - Running setup.py (path:/tmp/pip-64FSLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:49 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)) 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:49 INFO - Running setup.py (path:/tmp/pip-29ezO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:49 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)) 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:49 INFO - Running setup.py (path:/tmp/pip-xLASLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:49 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)) 17:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:49 INFO - Running setup.py (path:/tmp/pip-_gIeQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:49 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)) 17:06:49 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)) 17:06:49 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)) 17:06:49 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)) 17:06:49 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)) 17:06:49 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)) 17:06:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:49 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 17:06:51 INFO - Downloading blessings-1.6.tar.gz 17:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:51 INFO - Installing collected packages: blessings 17:06:51 INFO - Running setup.py install for blessings 17:06:51 INFO - Successfully installed blessings 17:06:51 INFO - Cleaning up... 17:06:51 INFO - Return code: 0 17:06:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:51 INFO - Reading from file tmpfile_stdout 17:06:51 INFO - Current package versions: 17:06:51 INFO - argparse == 1.2.1 17:06:51 INFO - blessings == 1.6 17:06:51 INFO - blobuploader == 1.2.4 17:06:51 INFO - docopt == 0.6.1 17:06:51 INFO - manifestparser == 1.1 17:06:51 INFO - mozInstall == 1.12 17:06:51 INFO - mozcrash == 0.17 17:06:51 INFO - mozdebug == 0.1 17:06:51 INFO - mozdevice == 0.48 17:06:51 INFO - mozfile == 1.2 17:06:51 INFO - mozhttpd == 0.7 17:06:51 INFO - mozinfo == 0.9 17:06:51 INFO - mozleak == 0.1 17:06:51 INFO - mozlog == 3.1 17:06:51 INFO - moznetwork == 0.27 17:06:51 INFO - mozprocess == 0.22 17:06:51 INFO - mozprofile == 0.28 17:06:51 INFO - mozrunner == 6.11 17:06:51 INFO - mozscreenshot == 0.1 17:06:51 INFO - mozsystemmonitor == 0.0 17:06:51 INFO - moztest == 0.7 17:06:51 INFO - mozversion == 1.4 17:06:51 INFO - psutil == 3.1.1 17:06:51 INFO - requests == 1.2.3 17:06:51 INFO - wsgiref == 0.1.2 17:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:51 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')]} 17:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:51 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')]} 17:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:51 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 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:51 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 17:06:51 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 17:06:51 INFO - Using env: {'DISPLAY': ':0', 17:06:51 INFO - 'HOME': '/home/cltbld', 17:06:51 INFO - 'LANG': 'en_US.UTF-8', 17:06:51 INFO - 'LANGUAGE': 'en_US:en', 17:06:51 INFO - 'LOGNAME': 'cltbld', 17:06:51 INFO - 'MAIL': '/var/mail/cltbld', 17:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:51 INFO - 'MOZ_NO_REMOTE': '1', 17:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:51 INFO - 'NO_EM_RESTART': '1', 17:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:51 INFO - 'PWD': '/builds/slave/test', 17:06:51 INFO - 'SHELL': '/bin/bash', 17:06:51 INFO - 'SHLVL': '1', 17:06:51 INFO - 'TERM': 'linux', 17:06:51 INFO - 'TMOUT': '86400', 17:06:51 INFO - 'USER': 'cltbld', 17:06:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:51 INFO - '_': '/tools/buildbot/bin/python'} 17:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 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)) 17:06:51 INFO - Cleaning up... 17:06:51 INFO - Return code: 0 17:06:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:06:51 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')]} 17:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:51 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')]} 17:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:51 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 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:51 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 17:06:51 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 17:06:51 INFO - Using env: {'DISPLAY': ':0', 17:06:51 INFO - 'HOME': '/home/cltbld', 17:06:51 INFO - 'LANG': 'en_US.UTF-8', 17:06:51 INFO - 'LANGUAGE': 'en_US:en', 17:06:51 INFO - 'LOGNAME': 'cltbld', 17:06:51 INFO - 'MAIL': '/var/mail/cltbld', 17:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:51 INFO - 'MOZ_NO_REMOTE': '1', 17:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:51 INFO - 'NO_EM_RESTART': '1', 17:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:51 INFO - 'PWD': '/builds/slave/test', 17:06:51 INFO - 'SHELL': '/bin/bash', 17:06:51 INFO - 'SHLVL': '1', 17:06:51 INFO - 'TERM': 'linux', 17:06:51 INFO - 'TMOUT': '86400', 17:06:51 INFO - 'USER': 'cltbld', 17:06:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:51 INFO - '_': '/tools/buildbot/bin/python'} 17:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:52 INFO - Downloading/unpacking jsonschema 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06:53 INFO - Downloading/unpacking functools32 (from jsonschema) 17:06:53 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 17:06:53 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 17:06:53 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 17:06:53 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 17:06:53 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 17:06:53 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 17:06:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:54 INFO - warning: no files found matching '*.txt' 17:06:54 INFO - no previously-included directories found matching 'build' 17:06:54 INFO - no previously-included directories found matching 'dist' 17:06:54 INFO - no previously-included directories found matching '.git*' 17:06:54 INFO - Installing collected packages: jsonschema, functools32 17:06:54 INFO - Running setup.py install for functools32 17:06:54 INFO - warning: no files found matching '*.txt' 17:06:54 INFO - no previously-included directories found matching 'build' 17:06:54 INFO - no previously-included directories found matching 'dist' 17:06:54 INFO - no previously-included directories found matching '.git*' 17:06:54 INFO - Successfully installed jsonschema functools32 17:06:54 INFO - Cleaning up... 17:06:54 INFO - Return code: 0 17:06:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e4a991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2581770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', '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 17:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:06:54 INFO - Using env: {'DISPLAY': ':0', 17:06:54 INFO - 'HOME': '/home/cltbld', 17:06:54 INFO - 'LANG': 'en_US.UTF-8', 17:06:54 INFO - 'LANGUAGE': 'en_US:en', 17:06:54 INFO - 'LOGNAME': 'cltbld', 17:06:54 INFO - 'MAIL': '/var/mail/cltbld', 17:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:54 INFO - 'MOZ_NO_REMOTE': '1', 17:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:54 INFO - 'NO_EM_RESTART': '1', 17:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:54 INFO - 'PWD': '/builds/slave/test', 17:06:54 INFO - 'SHELL': '/bin/bash', 17:06:54 INFO - 'SHLVL': '1', 17:06:54 INFO - 'TERM': 'linux', 17:06:54 INFO - 'TMOUT': '86400', 17:06:54 INFO - 'USER': 'cltbld', 17:06:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:54 INFO - '_': '/tools/buildbot/bin/python'} 17:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:54 INFO - Downloading/unpacking flake8 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:06:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:06:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:06:57 INFO - no previously-included directories found matching 'docs/_build' 17:06:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:06:57 INFO - Running setup.py install for pep8 17:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:06:57 INFO - no previously-included directories found matching 'docs/_build' 17:06:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:06:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:06:57 INFO - Cleaning up... 17:06:57 INFO - Return code: 0 17:06:57 INFO - Running post-action listener: _resource_record_post_action 17:06:57 INFO - Running post-action listener: _start_resource_monitoring 17:06:57 INFO - Starting resource monitoring. 17:06:57 INFO - ##### 17:06:57 INFO - ##### Finished create-virtualenv step (success) 17:06:57 INFO - ##### 17:06:57 INFO - ##### 17:06:57 INFO - ##### Running install step. 17:06:57 INFO - ##### 17:06:57 INFO - Running pre-action listener: _resource_record_pre_action 17:06:57 INFO - Running main action method: install 17:06:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:57 INFO - Reading from file tmpfile_stdout 17:06:57 INFO - Detecting whether we're running mozinstall >=1.0... 17:06:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:06:57 INFO - Reading from file tmpfile_stdout 17:06:57 INFO - Output received: 17:06:57 INFO - Usage: mozinstall [options] installer 17:06:57 INFO - Options: 17:06:57 INFO - -h, --help show this help message and exit 17:06:57 INFO - -d DEST, --destination=DEST 17:06:57 INFO - Directory to install application into. [default: 17:06:57 INFO - "/builds/slave/test"] 17:06:57 INFO - --app=APP Application being installed. [default: firefox] 17:06:57 INFO - mkdir: /builds/slave/test/build/application 17:06:57 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'] 17:06:57 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 17:07:14 INFO - Reading from file tmpfile_stdout 17:07:14 INFO - Output received: 17:07:14 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:14 INFO - Running post-action listener: _resource_record_post_action 17:07:14 INFO - ##### 17:07:14 INFO - ##### Finished install step (success) 17:07:14 INFO - ##### 17:07:14 INFO - ##### 17:07:14 INFO - ##### Running run-tests step. 17:07:14 INFO - ##### 17:07:14 INFO - Running pre-action listener: _resource_record_pre_action 17:07:14 INFO - Running main action method: run_tests 17:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:14 INFO - Python 2.7.3 17:07:14 INFO - Return code: 0 17:07:14 INFO - grabbing minidump binary from tooltool 17:07:14 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')]} 17:07:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26109c0>, '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 0x26118c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2611d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:14 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 17:07:14 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 17:07:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:14 INFO - Return code: 0 17:07:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:07:15 INFO - Return code: 0 17:07:15 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/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:07:15 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/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 17:07:15 INFO - Using env: {'DISPLAY': ':0', 17:07:15 INFO - 'HOME': '/home/cltbld', 17:07:15 INFO - 'LANG': 'en_US.UTF-8', 17:07:15 INFO - 'LANGUAGE': 'en_US:en', 17:07:15 INFO - 'LOGNAME': 'cltbld', 17:07:15 INFO - 'MAIL': '/var/mail/cltbld', 17:07:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:15 INFO - 'MOZ_NO_REMOTE': '1', 17:07:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:15 INFO - 'NO_EM_RESTART': '1', 17:07:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:15 INFO - 'PWD': '/builds/slave/test', 17:07:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:15 INFO - 'SHELL': '/bin/bash', 17:07:15 INFO - 'SHLVL': '1', 17:07:15 INFO - 'TERM': 'linux', 17:07:15 INFO - 'TMOUT': '86400', 17:07:15 INFO - 'USER': 'cltbld', 17:07:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490', 17:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:15 INFO - '_': '/tools/buildbot/bin/python'} 17:07:15 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/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:07:15 INFO - mozversion application_buildid: 20160509143013 17:07:15 INFO - mozversion application_changeset: a3033ed384eb846bf37d9a4bf59a3728f15e9f74 17:07:15 INFO - mozversion application_display_name: Nightly 17:07:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:15 INFO - mozversion application_name: Firefox 17:07:15 INFO - mozversion application_remotingname: firefox 17:07:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:07:15 INFO - mozversion application_vendor: Mozilla 17:07:15 INFO - mozversion application_version: 49.0a1 17:07:15 INFO - mozversion platform_buildid: 20160509143013 17:07:15 INFO - mozversion platform_changeset: a3033ed384eb846bf37d9a4bf59a3728f15e9f74 17:07:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:07:15 INFO - mozversion platform_version: 49.0a1 17:07:15 INFO - using testdate: 1462838835 17:07:15 INFO - actual date: 1462838835 17:07:15 INFO - starting webserver on 'localhost:50810' 17:07:15 INFO - SUITE-START | Running 2 tests 17:07:15 INFO - TEST-START | dromaeo_css 17:07:15 INFO - operating with platform_type : linux_ 17:07:15 INFO - Initialising browser for dromaeo_css test... 17:07:15 INFO - TEST-INFO | started process 2692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe7r3_I/profile http://localhost:50810/getInfo.html) 17:07:19 INFO - PROCESS | 2692 | __metrics Screen width/height:1600/1200 17:07:19 INFO - PROCESS | 2692 | colorDepth:24 17:07:19 INFO - PROCESS | 2692 | Browser inner width/height: 1024/697 17:07:19 INFO - PROCESS | 2692 | __metrics 17:07:21 ERROR - PROCESS | 2692 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:07:22 INFO - TEST-INFO | 2692: exit 0 17:07:22 INFO - Browser initialized. 17:07:22 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:22 INFO - TEST-INFO | started process 2852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe7r3_I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:33 INFO - PROCESS | 2852 | RSS: Main: 151633920 17:07:33 INFO - PROCESS | 2852 | 17:08:25 INFO - PROCESS | 2852 | 1462838905168 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] 17:10:33 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:50810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50810/tests/dromaeo/cssquery-ext.html) 17:10:34 INFO - PROCESS | 2852 | RSS: Main: 255602688 17:10:34 INFO - PROCESS | 2852 | 17:13:36 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:50810/tests/dromaeo/cssquery-ext.html (next: http://localhost:50810/tests/dromaeo/cssquery-jquery.html) 17:13:37 INFO - PROCESS | 2852 | RSS: Main: 243077120 17:13:37 INFO - PROCESS | 2852 | 17:16:38 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:50810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50810/tests/dromaeo/cssquery-mootools.html) 17:16:39 INFO - PROCESS | 2852 | RSS: Main: 246026240 17:16:39 INFO - PROCESS | 2852 | 17:19:41 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:50810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50810/tests/dromaeo/cssquery-prototype.html) 17:19:42 INFO - PROCESS | 2852 | RSS: Main: 235601920 17:19:42 INFO - PROCESS | 2852 | 17:22:44 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:50810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50810/tests/dromaeo/cssquery-yui.html) 17:22:45 INFO - PROCESS | 2852 | RSS: Main: 221937664 17:22:45 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:50810/tests/dromaeo/cssquery-yui.html (next: http://localhost:50810/tests/dromaeo/cssquery-dojo.html) 17:25:48 INFO - PROCESS | 2852 | RSS: Main: 280915968 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | __start_tp_report 17:25:48 INFO - PROCESS | 2852 | _x_x_mozilla_page_load 17:25:48 INFO - PROCESS | 2852 | _x_x_mozilla_page_load_details 17:25:48 INFO - PROCESS | 2852 | |i|pagename|runs| 17:25:48 INFO - PROCESS | 2852 | |0;dojo.html;3173.523971404289;3174.6031746031745;3202.0553936588713;3208.887688930888;3235.7734958552896;5231.084560201959;5290.523852853243;5322.308099947007;5393.271908292384;5439;5244.632875698702;5322.308099947011;5331.253624492564;5344.35867695877;5371.4897084776885;4798.83204087857;4866.659333846632;4880.6095512358925;4897.1674815281485;5030.522100400456;4946.703197808125;4995.850124496271;5003.524665156822;5013.097642424362;5014.498550144975;4785.353977213083;4842.055799119138;4852.563269305761;4886.609071274325;4937.037277730844;4851.223804191312;4861.586765124968;4868.026394721034;4930.359053323081;4967.975160124212;4900.534449227318;4924.556789888928;4926.482719314492;4934.950650493485;4939.061578300111;5145.871353216199;5161.483851614846;5221.242919776611;5231.189165679326;5300.575953923677;5707.429257074301;5769.1923130761725;5800.303963524404;5800.593958422912;5807.535397168216;5633.887322253532;5777.711114444303;5826.359100498942;5831.183634291203;5837.678927658977;5357.946420535784;5374.220737993008;5390.029794636964;5441.646292990943;5509.228707980926;5947.851303717355;5951.821445356646;5953.880922381615;5959.731812068468;5970.014947533608;5539.473749993744;5663.858403539944;5739.5695322850115;5747.971260143672;5749.540036797046;5806.071028635482;5843.328017277982;5854.590178687451;5865.794697185578;5921.644701317935;5808.970955145197;5830.737616807254;5830.76676932918;5831.7667293307795;5850.53195744348;5596.188552659842;5672.12082127271;5739.62692424991;5844;5849.093390524476;4382.167388196232;4390.714603550759;4397.538258482878;4402.075564131568;4429.402030725811;3878.825452854628;3898.8440462381755;3899.473571067926;3927.6072392761066;3930.2336044471053;5371.274877891435;5398.190271459234;5405.081136206854;5433.918491222635;5435.211894275308;5760.53915686744;5790.334111577223;5796.246487956539;5800.88398232033;5813.186153938452;5373.167159090347;5442.156465747737;5446.074167391553;5446.673199608036;5455.672659640434;4929.926051109236;4977.129002424561;4977.552020318117;4998.70007799526;5009.599232061426;6027.48766354856;6060;6067.302260240041;6070.089486576961;6076.27084749824;5611.130274807411;5756.481916627524;5834.766609335579;5852.063669812809;5858.414158584107;5960.8807823844145;6027.36712645166;6031.788887388921;6040.36576159497;6092.847678808065;5755.769769209185;5756.222909907109;5761.4238576143725;5764.106563482667;5766.192733017297;5567.832965011056;5717.628354156966;5723.713814309352;5826.533877289891;5843.8539036522725;5619.409961953936;5620.381758006698;5625.831225063091;5625.859353516031;5668.319801623831;5563.054280772198;5581.134924086773;5598.692071936082;5627.324721033502;5637.295338082739;5401.891962160814;5509.614326997072;5530.5022547970875;5539.058360078716;5544.944550554605;5709.771609135588;5714.857128571819;5742.712864356849;5749.942500574941;5780;5601.355844077983;5604.6917419542315;5605.467480589337;5606;5636.718164091861 17:25:48 INFO - PROCESS | 2852 | |1;ext.html;604.7671646416131;631.1321932343028;640.4684112186883;655.1810237203496;657.6645910585602;44201.33697994533;45804;45908.311375329395;49287;49452.50547494524;45301;46163;46260.768696156556;46269.76865115669;46373.7681311593;8657.870131948026;8867.68963086292;8874.245689116433;8878.378513504058;8881;8829.426087304304;8874.290056795473;8902.421342612743;8940.329475289347;8941.061188575204;8869.600867960957;8905.866412003825;8928.642854285821;8936.240419564345;8937.150970657809;8904.332175086862;8975.416597921114;8975.730728078168;8982.550872456384;8984.910150898506;8837.955810220908;8916.643334266622;8921.304952059088;8921.955390223007;8924.643014279422;42123;42590.57409425928;42592.57407425917;42625.78687106576;42708.78645606783;3554.2003049313957;3582.0865679251883;3704.629537046301;3984.30274701926;4304.504981927056;32004.519932201034;32308.515372269434;32546;32993.835030824936;33562;4311.439512863339;4344.283193273106;4370.8033138508845;4385.956140438619;4412.316091005867;312320;313684;314245;314247;315197.99999999773;61401.69299153565;61493.69253153705;61551.076733849026;61875.6906215475;61941;58339.416605834245;64434.355656443775;64662.35337646658;65450.345496544425;65687.67156164188;17926.193321300572;18022.459326220236;18085.7287140693;18088.186031628607;18123;12979.480820767252;13001;13038.739225215631;13046.347682615831;13054.216746995211;17837.910810445865;19470.07357327495;20803;20843.478913027295;20966;7277.927220727831;7282;7338.339549440576;7413.925860741431;7527.247275272429;982.8918818929913;1008.1330056151704;1150.1948635954866;1167.3521195736448;1207.0946789907568;32704.672953270638;32965.83517082399;33137.66862331346;33403.49894751581;34049.65950340465;1096.2162054131334;1123.5056575106926;1157.2593540134321;1175.3476820364779;1214.9088818338482;16414;16861.325546978227;16987.660246795243;17122.785462328247;17259;423240;423697;424868;426057;426848;57789.711051445316;58446.4155358441;58483;58537;58561;1341.215388997428;1392.5543825975792;1394.1774353131905;1403.1510935883848;1426.5577670922048;30354.696453035187;30754;31189.37621247517;31514;31566.36867262596;48851.26723099227;49755.253671195685;49782.25326620176;49825.750871245415;49880.750596246784;381584;381859;383504;383510;383975;25357.492850143262;26086;27675;27710.168694939184;28606.14181574556;42558.65927374024;47427.762861185474;47674.52325476701;47785.52214477811;48674.513254867;39666.206675866895;40491.39262911;40559.18881622292;41010.79494602508;41282.587174127875;39637;40245;40970.385444218955;41365;41401.37897931594;40276.3958540628;40560.391594126704;41169;41230.38154427626;41310.586894130676;33811.492827607115;35972.4604130933;36035.27929441449;36362.45456318105;36751.26497470089;27653.72346276592;27675.308117297227;27924.86037569799;27947.161585152477;27982.44035119327 17:25:48 INFO - PROCESS | 2852 | |2;jquery.html;382.96170382961697;387.54076419442964;390.75968279508095;402.1093278388369;404.48832227232555;17503.212355444004;19293.32473363429;20083.59832803343;20105.497362565944;20126.59746805063;18896.71654925177;19142.425727228205;19299.324523641677;19594.216231350765;19666.606667866636;5573.442655734435;5573.470520300585;5630.887382252353;5761.337446193678;5902.557308201881;5893.528517718572;5899.528037756991;5914.172015917775;5931.851703707399;5935.851603709899;5446.482584154499;5779.422057794208;5779.479846813786;5883.264591926009;5897.351291357947;5726.513246374063;5731.426857314277;5740.741666625012;5747.33905600855;5753.280839895013;5361.276227709248;5516.779328826842;5558.666480011172;5564.10974244119;5577.470140336662;13530.052896297264;13768.793468097987;15270.694586108326;22514.77485225143;23073;2265.150568536799;2316.779905908953;2332.7084114485688;2363.5036642305136;2475.418276704973;9655.46894920779;10318.484075796181;10543.683689489251;12507.624771256877;13683.700048495377;1861.702127659568;1908.0841196225751;1941.7669879614396;1978.2284908885547;1985.3547597031022;81006;82179.5891020547;83242;83812;83894.58052709758;8776.210141087333;9268.351215414856;9455.905440945502;9711.805763884682;10144.847827282596;12781.297028663326;12803.743925121445;12811.295378754072;12852.48590056406;12869.549565765154;7409.370203532652;7667.156612772591;7876.448648594658;7961.16407777175;7988.281054705104;7986.480878742979;8134.511929284262;8198.221168988937;8322.958385208036;8332.708355207538;3978.144698889753;4028;4078.8164532596106;4148.170365926766;4149.8962525937095;1866.2534986005705;1965.3416105604497;1973.2304401283511;1983.2364539652049;2025.5543780368296;960.841461158915;1059.4543809937888;1067.1676092647747;1074.505727365405;1098.9230753847314;17984;18705.31652151313;18740.812591873906;19662.90168549148;19739.60520789605;1021.7317555027827;1027.173125633872;1034.3121823986965;1054.9472526373804;1065.6003998500562;10634.149268058536;11068.501917413736;11081.113510919107;11087.168462365355;11089.5564177432;421769;422754;422763;423374;433021;87562.56218718865;89350;90823;91716;91804;1025.5231317437278;1041.6406339812752;1044.9947750261351;1060.6181774561153;1064.7497838008062;16300.836991629933;16967.236474358437;17297.827021729623;17308.740368894225;17669.204885779913;39391.80304098461;40367.79816100901;40400.19199615932;40676.1864762709;41047;54222.45777542174;54709;55830.72084639551;55853.72073139608;55987.160192596326;7492.175860655215;7847.529148251123;8310.916890831015;8790.560471976247;8882.822343553222;13333.733325333245;13667.453301868212;13738.10702304347;13823.654408639864;13881.305934703427;11643.47604357789;11952.223105498115;11953.641390758292;12047.939760301142;12418.56535021306;11775.587854425054;11942.34317112567;12006.459709312927;12169.39153042362;12317.692057698629;12071.275723456622;12322.137450378388;12409.689757756129;12542;12766.361681916052;8135.064467586067;8142.47073940192;8211.630476628447;8213.630386632496;8296.917030829856;11187.384693841917;12377.545020579499;12515.56195533152;12589.559365422167;12810.743785124432 17:25:48 INFO - PROCESS | 2852 | |3;mootools.html;1363.1820907455522;1520.2702702702702;1531.8621324080834;1730.152225409549;1845.935392261271;7732.1881202473705;8038.316743076845;8040.91959080409;8215.178482151781;8222.753317400473;7991.320737737299;8167.06078800938;8173;8178.631961561729;8222.835543289131;1977.8714383565093;2034.3693455028915;2232.8325375596814;2303.251443280928;2332.218706733238;2313.3869524576003;2338.2751347082376;2342.2973108067513;2342.309018839438;2349.6240601503764;2291.5302363015544;2300.1489448903844;2311.04091801902;2341.519988402382;2346.5189636124555;1939.3697048459167;2160.4274867160216;2236.37381533171;2251.6397376419695;2270.909163633453;2267.5464907018495;2287.931362059141;2289.210222473244;2291.186628746804;2293.747687754346;8415;8475.660973561051;8480.279176270025;8483.787905302355;8487.193716596914;4977.352944117278;5062.164742817431;5067.721275329855;5092.159793634046;5107.7956881724685;3167.825769582672;3195.6964088411796;3353.815540145291;3369.2419205678525;3378.4594464885745;1135.3868910788165;1145.1297014269132;1159.2406973432414;1162.8023236049892;1180.6340034589218;11399.829002564968;11418.42907854604;11427.60003399877;11444.141689373413;11449.255798373079;4468;4548.56788605082;4597.540245975376;4634.443866736014;4639.721616702941;9795.167410770022;9867;9887.752806179904;9891.35706179096;9909.702708918743;5243.737813109329;5246.422893481714;5248.737563121828;5255.5795536357;5256.237845512379;4267.253230684618;4743.976280118577;4755.548222918817;4893.290472881484;4926.285688575136;3758.248350329945;3863.497745293094;3889.747166434173;3911.1395492991496;3940.625640564142;1233.2353940556911;1237.6287113865803;1248.2572869142846;1255.8241846141548;1259.238160912653;880.2825697056878;995.1292618958412;1029.9279050466546;1031.118393773328;1035.896410358958;5988.161657367972;6147.508199344042;6233.34549872266;6286.717097730613;6324.652144132025;451.7041337923665;453.8956040110727;458.92657174851865;467.8619807156897;468.96951698139515;4082.6121518455698;4191.700572822435;4257.40396344512;4280.785960701953;4313.158934007838;10301.278910476194;10488.842667359995;10683.14534837211;10790.568377264979;10806.459677016275;10480.371177729208;10588.576456941637;10665.89334106649;10674.412907290174;10680.786384272427;7616;8030.397720170894;8033.919660803434;8039.115697273295;8096.392770542233;6112.1748563945075;6193.225846769154;6239.220097487814;6241.656708881055;6262.780802671885;9616;9749.853752193865;9881.85177222328;10015.349002314826;10023.899761002296;9790.461524616214;9878.901210988086;10149.238807089645;10170.135538479311;10177.287589868638;7059.399951004222;7071.292870713093;7234.385077268491;7450.701971921062;7550.7734767957045;8458.577071146541;8465.788355291166;8512.616932237941;8526.82946341082;8536.914630853613;7519.548827070394;7680.231976802275;7740.612969351398;7823.726169584037;7844.450888437755;7452.652414489418;7470.92529074724;7533.472656913963;7628.618569071636;7635.236476352543;6691.5650482718465;6743.190817101783;6765.391114799691;6772.52592318533;6775.220849602359;4973.950260497493;5063.367079115111;5104.719240441811;5195;5231.738413079407;4992.176290912104;5008.223725322581;5087.135187018142;5141.100307446257;5161.612879034013 17:25:48 INFO - PROCESS | 2852 | |4;prototype.html;322.72714096605574;332.19277156509685;334.7924286942096;341.342914888839;346.4958485403738;5276.630635855492;5308.867278318044;5310.654807437514;5312.814051508198;5323.387810401795;5058.898822023557;5160.587153027758;5218.608604354679;5220.712860792655;5251.973740131294;4058.8635182148896;4112.547619761824;4152.107296931159;4163.521195062576;4210.179015092058;4124.340105583107;4128.8761337159785;4162.334026555752;4166.166766646667;4187.371894215861;4065.918681626366;4121.8969525761795;4147.792610369469;4160.646345060673;4201.831926722927;4142.212979533879;4142.772147531885;4154.979225103885;4159.856039589107;4179.895502612429;3719.8512059517857;3721.2371463849845;3721.5162028936065;3739;3744.5319335083113;4986.202207646796;5065.898682026339;5089.287499750038;5100.413452452978;5141.408737995141;4732.692374995614;4748.169070412699;4767.880802979918;4769.688335707673;4782.832600858988;5443.401225865152;5458;5468.9726551367385;5477.589180811455;5508.421615730331;3987.940180897289;4068.1660259646997;4078.7967549572945;4106.398504583215;4116.938245926313;5672.546196304327;5710.257666503369;5719.799807006776;5721.313442386899;5733.369329373765;4148.315527937856;4161.708680392404;4163.979180104141;4184.497860256728;4199.328107502785;4024.9195016099516;4210.85262015828;4216.135692183095;4222.366645003212;4242.17277630859;4709.411323584552;4738.289256611536;4738.360321356642;4738.597219236403;4797.232442809134;5514.255575497336;5539.25220095282;5556.472135147235;5562.193481945095;5575.163725441135;1328.4619729009767;1347.4408120629828;1403.9368228429746;1410.3089486151712;1419.340006896798;967.8403063494444;971.3055165556661;974.5517062151348;980.9656662016795;983.6409710455632;5086.72023038729;5104.2343648453025;5118.820841270538;5125.820596279187;5149.304843846107;5500.779968801203;5508.118701007819;5511.22842802008;5512.5589952803675;5522.696251706195;4979.278004689299;5115.148247440162;5122.641415100981;5181.896362072737;5182.585393168538;2844.8435336056714;2856.371598248382;2862.6278583783974;2878.2372671242138;2885.047934181715;5557.527610153183;5627.352854421712;5629.971850140723;5647.181158731961;5676.90608618304;5833.258368566767;5889.174355949669;5891.35042188188;5902.76388944446;5914.852128696731;5938.248216776062;5949.732262048132;5966.582339236299;5969.791057312973;5987.670678112659;5457.590680698884;5695.487406133468;5697.601167918206;5713.285839270091;5715.857103572278;5597.804076857454;5640;5644.8306550803545;5661.264035675501;5669.809340038638;5651.937042979365;5906.645601263938;5915.58590898633;5916.940830591639;5931.51712071982;4061.6750659947725;4068.267711811784;4088.8568900088353;4095.6928230382246;4097.610726980932;5475.616706830484;5612.354579223442;5688.061469857427;5771.192033115283;5783.971080144573;5553.250311208097;5560.916586251128;5574.933786417373;5581.190727344593;5581.553475721851;5506.311711036121;5567.888642227052;5571.637843540157;5574.414686457863;5577.637453565668;5224.634275600672;5430.15832545956;5444.727763611724;5453.64551304164;5480.410680902493;5586.664800112007;5594.356648985418;5606.607537472338;5613.46672066153;5615.7192140392;5203.479652034766;5478.397376288684;5486.984907792072;5500.534663162182;5505.073224371438 17:25:48 INFO - PROCESS | 2852 | |5;yui.html;819.709003303827;851.3231980575442;863.6502216602271;870.5516658920653;888.3648191543045;13306.66733331666;14881.925590372046;15090.320935557898;15090.849091509082;15120.546383608496;13833.792493112585;13858.4456621735;13904.443822247124;13906.58280251594;13910.304484775746;694.191267173742;807.9757607271791;817.6647574494458;842.8187939592987;849.2823564088335;835.8453686068067;841.0160112668193;841.6675413211777;842.8609279468881;843.9493630382166;893.6112790935931;895.6417433026776;896.135229503529;896.3546246702397;896.5606852642223;728.5264578024273;852.5737131434283;865.6537385045968;875.3041332140963;894.3650008493977;642.2613993906998;644.0178727440643;644.2591020326615;644.3942693867749;644.7131026693123;13941.372638231303;13993.440262389595;14011;14021.08862923917;14022.92988535061;13358.064935454522;13507.797383039262;13604.183748975092;13635.38640761168;13798.241096739675;11901.345426001566;12106.878931210664;12113.15207935445;12191.695207619881;12378.0716446266;4371.737695738234;4415.116976604692;4444.555544445562;4463.352813841975;4504.2793153095345;54301;54920.17619735707;55618;55680.72159639216;55757.72121139409;11229.550817967352;11245.212835101627;11359.659210223706;11384.43077846121;11514.884851151548;20157.395278141677;20168.69746953797;20190.990450477417;20208.494787630134;20233.494162646053;8011.359091272684;8138.43030987837;8292.212239837207;8333.541655208901;8627.827443451095;4724.503927087606;4747.976260118678;4822.493638168012;4864.683795553277;4888.926666100011;3458.844352004166;3554.0937061049785;3574.749767516301;3578.141246100969;3578.481120237551;503.7179179659403;660.448525481219;665.374547924949;667.6461475418037;703.2440126863539;775.0621747685251;776.984460310802;801.0027515742937;814.645629151321;819.7540737778643;9577.569009394594;10083.092521673085;10127.544260508148;10217.642382516577;10258.640947566799;677.6476232359245;689.2039694153261;734.1337222077999;738.2174894611729;776.8096816280048;4711.905761884743;4712.222483290218;4766.404199475066;4861.124997500413;4939;66565.33434665688;67296;67375;67821;67824;59780;60077.69961150167;60522.394776052555;62381.68809155925;63990;54994;56325.43674563284;56513.434865650815;56840.43159568434;57971.710141449024;9030.277577793891;9081.364304498622;9192.770180745534;9193.494357810117;9218.907810922074;35540;35847.283054338244;36029.45955810612;36082.63917360793;36153.45769813402;43979.34030989602;46317.53682463132;47943.52056479391;48722.75638621784;49413;11749.765004699688;11758.58844940423;11952.76094478123;12134.635960921187;12407.131500795218;13004.869951300745;13232.933835330761;13375.26436045988;13487.25820079905;13947.790783138464;12646.747065058831;12691.682707932006;13109.410076546768;13172.209667419986;13190.142640728322;12504.374781261082;12525.37373131358;12610;13095.214287142802;13197.472101116233;12021;12056;12494.500219991098;12523.749525009267;12617.179883307555;10472.162227021972;10576.15390768752;10682.786344272916;10933.890661093605;11013.394263315595;10803.683800467315;10839.566417343218;10859.185561082792;10883.28940222134;11019.393933333744 17:25:48 INFO - PROCESS | 2852 | __end_tp_report 17:25:48 INFO - PROCESS | 2852 | __start_cc_report 17:25:48 INFO - PROCESS | 2852 | _x_x_mozilla_cycle_collect,851 17:25:48 INFO - PROCESS | 2852 | __end_cc_report 17:25:48 INFO - PROCESS | 2852 | __startTimestamp1462839948253__endTimestamp 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | ------- Summary: start ------- 17:25:48 INFO - PROCESS | 2852 | Number of tests: 6 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | [#0] dojo.html Cycles:165 Average:5365.63 Median:5567.83 stddev:613.87 (11.0%) stddev-sans-first:591.18 17:25:48 INFO - PROCESS | 2852 | Values: 3173.5 3174.6 3202.1 3208.9 3235.8 5231.1 5290.5 5322.3 5393.3 5439.0 5244.6 5322.3 5331.3 5344.4 5371.5 4798.8 4866.7 4880.6 4897.2 5030.5 4946.7 4995.9 5003.5 5013.1 5014.5 4785.4 4842.1 4852.6 4886.6 4937.0 4851.2 4861.6 4868.0 4930.4 4968.0 4900.5 4924.6 4926.5 4935.0 4939.1 5145.9 5161.5 5221.2 5231.2 5300.6 5707.4 5769.2 5800.3 5800.6 5807.5 5633.9 5777.7 5826.4 5831.2 5837.7 5357.9 5374.2 5390.0 5441.6 5509.2 5947.9 5951.8 5953.9 5959.7 5970.0 5539.5 5663.9 5739.6 5748.0 5749.5 5806.1 5843.3 5854.6 5865.8 5921.6 5809.0 5830.7 5830.8 5831.8 5850.5 5596.2 5672.1 5739.6 5844.0 5849.1 4382.2 4390.7 4397.5 4402.1 4429.4 3878.8 3898.8 3899.5 3927.6 3930.2 5371.3 5398.2 5405.1 5433.9 5435.2 5760.5 5790.3 5796.2 5800.9 5813.2 5373.2 5442.2 5446.1 5446.7 5455.7 4929.9 4977.1 4977.6 4998.7 5009.6 6027.5 6060.0 6067.3 6070.1 6076.3 5611.1 5756.5 5834.8 5852.1 5858.4 5960.9 6027.4 6031.8 6040.4 6092.8 5755.8 5756.2 5761.4 5764.1 5766.2 5567.8 5717.6 5723.7 5826.5 5843.9 5619.4 5620.4 5625.8 5625.9 5668.3 5563.1 5581.1 5598.7 5627.3 5637.3 5401.9 5509.6 5530.5 5539.1 5544.9 5709.8 5714.9 5742.7 5749.9 5780.0 5601.4 5604.7 5605.5 5606.0 5636.7 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | [#1] ext.html Cycles:180 Average:54993.75 Median:41337.79 stddev:99091.09 (239.7%) stddev-sans-first:99284.92 17:25:48 INFO - PROCESS | 2852 | Values: 604.8 631.1 640.5 655.2 657.7 44201.3 45804.0 45908.3 49287.0 49452.5 45301.0 46163.0 46260.8 46269.8 46373.8 8657.9 8867.7 8874.2 8878.4 8881.0 8829.4 8874.3 8902.4 8940.3 8941.1 8869.6 8905.9 8928.6 8936.2 8937.2 8904.3 8975.4 8975.7 8982.6 8984.9 8838.0 8916.6 8921.3 8922.0 8924.6 42123.0 42590.6 42592.6 42625.8 42708.8 3554.2 3582.1 3704.6 3984.3 4304.5 32004.5 32308.5 32546.0 32993.8 33562.0 4311.4 4344.3 4370.8 4386.0 4412.3 312320.0 313684.0 314245.0 314247.0 315198.0 61401.7 61493.7 61551.1 61875.7 61941.0 58339.4 64434.4 64662.4 65450.3 65687.7 17926.2 18022.5 18085.7 18088.2 18123.0 12979.5 13001.0 13038.7 13046.3 13054.2 17837.9 19470.1 20803.0 20843.5 20966.0 7277.9 7282.0 7338.3 7413.9 7527.2 982.9 1008.1 1150.2 1167.4 1207.1 32704.7 32965.8 33137.7 33403.5 34049.7 1096.2 1123.5 1157.3 1175.3 1214.9 16414.0 16861.3 16987.7 17122.8 17259.0 423240.0 423697.0 424868.0 426057.0 426848.0 57789.7 58446.4 58483.0 58537.0 58561.0 1341.2 1392.6 1394.2 1403.2 1426.6 30354.7 30754.0 31189.4 31514.0 31566.4 48851.3 49755.3 49782.3 49825.8 49880.8 381584.0 381859.0 383504.0 383510.0 383975.0 25357.5 26086.0 27675.0 27710.2 28606.1 42558.7 47427.8 47674.5 47785.5 48674.5 39666.2 40491.4 40559.2 41010.8 41282.6 39637.0 40245.0 40970.4 41365.0 41401.4 40276.4 40560.4 41169.0 41230.4 41310.6 33811.5 35972.5 36035.3 36362.5 36751.3 27653.7 27675.3 27924.9 27947.2 27982.4 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | [#2] jquery.html Cycles:180 Average:26887.71 Median:2324.74 stddev:70428.84 (3029.5%) stddev-sans-first:70598.29 17:25:48 INFO - PROCESS | 2852 | Values: 383.0 387.5 390.8 402.1 404.5 17503.2 19293.3 20083.6 20105.5 20126.6 18896.7 19142.4 19299.3 19594.2 19666.6 5573.4 5573.5 5630.9 5761.3 5902.6 5893.5 5899.5 5914.2 5931.9 5935.9 5446.5 5779.4 5779.5 5883.3 5897.4 5726.5 5731.4 5740.7 5747.3 5753.3 5361.3 5516.8 5558.7 5564.1 5577.5 13530.1 13768.8 15270.7 22514.8 23073.0 2265.2 2316.8 2332.7 2363.5 2475.4 9655.5 10318.5 10543.7 12507.6 13683.7 1861.7 1908.1 1941.8 1978.2 1985.4 81006.0 82179.6 83242.0 83812.0 83894.6 8776.2 9268.4 9455.9 9711.8 10144.8 12781.3 12803.7 12811.3 12852.5 12869.5 7409.4 7667.2 7876.4 7961.2 7988.3 7986.5 8134.5 8198.2 8323.0 8332.7 3978.1 4028.0 4078.8 4148.2 4149.9 1866.3 1965.3 1973.2 1983.2 2025.6 960.8 1059.5 1067.2 1074.5 1098.9 17984.0 18705.3 18740.8 19662.9 19739.6 1021.7 1027.2 1034.3 1054.9 1065.6 10634.1 11068.5 11081.1 11087.2 11089.6 421769.0 422754.0 422763.0 423374.0 433021.0 87562.6 89350.0 90823.0 91716.0 91804.0 1025.5 1041.6 1045.0 1060.6 1064.7 16300.8 16967.2 17297.8 17308.7 17669.2 39391.8 40367.8 40400.2 40676.2 41047.0 54222.5 54709.0 55830.7 55853.7 55987.2 7492.2 7847.5 8310.9 8790.6 8882.8 13333.7 13667.5 13738.1 13823.7 13881.3 11643.5 11952.2 11953.6 12047.9 12418.6 11775.6 11942.3 12006.5 12169.4 12317.7 12071.3 12322.1 12409.7 12542.0 12766.4 8135.1 8142.5 8211.6 8213.6 8296.9 11187.4 12377.5 12515.6 12589.6 12810.7 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | [#3] mootools.html Cycles:180 Average:5643.84 Median:4824.42 stddev:3169.47 (65.7%) stddev-sans-first:3162.03 17:25:48 INFO - PROCESS | 2852 | Values: 1363.2 1520.3 1531.9 1730.2 1845.9 7732.2 8038.3 8040.9 8215.2 8222.8 7991.3 8167.1 8173.0 8178.6 8222.8 1977.9 2034.4 2232.8 2303.3 2332.2 2313.4 2338.3 2342.3 2342.3 2349.6 2291.5 2300.1 2311.0 2341.5 2346.5 1939.4 2160.4 2236.4 2251.6 2270.9 2267.5 2287.9 2289.2 2291.2 2293.7 8415.0 8475.7 8480.3 8483.8 8487.2 4977.4 5062.2 5067.7 5092.2 5107.8 3167.8 3195.7 3353.8 3369.2 3378.5 1135.4 1145.1 1159.2 1162.8 1180.6 11399.8 11418.4 11427.6 11444.1 11449.3 4468.0 4548.6 4597.5 4634.4 4639.7 9795.2 9867.0 9887.8 9891.4 9909.7 5243.7 5246.4 5248.7 5255.6 5256.2 4267.3 4744.0 4755.5 4893.3 4926.3 3758.2 3863.5 3889.7 3911.1 3940.6 1233.2 1237.6 1248.3 1255.8 1259.2 880.3 995.1 1029.9 1031.1 1035.9 5988.2 6147.5 6233.3 6286.7 6324.7 451.7 453.9 458.9 467.9 469.0 4082.6 4191.7 4257.4 4280.8 4313.2 10301.3 10488.8 10683.1 10790.6 10806.5 10480.4 10588.6 10665.9 10674.4 10680.8 7616.0 8030.4 8033.9 8039.1 8096.4 6112.2 6193.2 6239.2 6241.7 6262.8 9616.0 9749.9 9881.9 10015.3 10023.9 9790.5 9878.9 10149.2 10170.1 10177.3 7059.4 7071.3 7234.4 7450.7 7550.8 8458.6 8465.8 8512.6 8526.8 8536.9 7519.5 7680.2 7740.6 7823.7 7844.5 7452.7 7470.9 7533.5 7628.6 7635.2 6691.6 6743.2 6765.4 6772.5 6775.2 4974.0 5063.4 5104.7 5195.0 5231.7 4992.2 5008.2 5087.1 5141.1 5161.6 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | [#4] prototype.html Cycles:180 Average:4661.47 Median:5238.30 stddev:1360.04 (26.0%) stddev-sans-first:1324.30 17:25:48 INFO - PROCESS | 2852 | Values: 322.7 332.2 334.8 341.3 346.5 5276.6 5308.9 5310.7 5312.8 5323.4 5058.9 5160.6 5218.6 5220.7 5252.0 4058.9 4112.5 4152.1 4163.5 4210.2 4124.3 4128.9 4162.3 4166.2 4187.4 4065.9 4121.9 4147.8 4160.6 4201.8 4142.2 4142.8 4155.0 4159.9 4179.9 3719.9 3721.2 3721.5 3739.0 3744.5 4986.2 5065.9 5089.3 5100.4 5141.4 4732.7 4748.2 4767.9 4769.7 4782.8 5443.4 5458.0 5469.0 5477.6 5508.4 3987.9 4068.2 4078.8 4106.4 4116.9 5672.5 5710.3 5719.8 5721.3 5733.4 4148.3 4161.7 4164.0 4184.5 4199.3 4024.9 4210.9 4216.1 4222.4 4242.2 4709.4 4738.3 4738.4 4738.6 4797.2 5514.3 5539.3 5556.5 5562.2 5575.2 1328.5 1347.4 1403.9 1410.3 1419.3 967.8 971.3 974.6 981.0 983.6 5086.7 5104.2 5118.8 5125.8 5149.3 5500.8 5508.1 5511.2 5512.6 5522.7 4979.3 5115.1 5122.6 5181.9 5182.6 2844.8 2856.4 2862.6 2878.2 2885.0 5557.5 5627.4 5630.0 5647.2 5676.9 5833.3 5889.2 5891.4 5902.8 5914.9 5938.2 5949.7 5966.6 5969.8 5987.7 5457.6 5695.5 5697.6 5713.3 5715.9 5597.8 5640.0 5644.8 5661.3 5669.8 5651.9 5906.6 5915.6 5916.9 5931.5 4061.7 4068.3 4088.9 4095.7 4097.6 5475.6 5612.4 5688.1 5771.2 5784.0 5553.3 5560.9 5574.9 5581.2 5581.6 5506.3 5567.9 5571.6 5574.4 5577.6 5224.6 5430.2 5444.7 5453.6 5480.4 5586.7 5594.4 5606.6 5613.5 5615.7 5203.5 5478.4 5487.0 5500.5 5505.1 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - PROCESS | 2852 | [#5] yui.html Cycles:180 Average:15577.51 Median:25514.72 stddev:18462.44 (72.4%) stddev-sans-first:18480.97 17:25:48 INFO - PROCESS | 2852 | Values: 819.7 851.3 863.7 870.6 888.4 13306.7 14881.9 15090.3 15090.8 15120.5 13833.8 13858.4 13904.4 13906.6 13910.3 694.2 808.0 817.7 842.8 849.3 835.8 841.0 841.7 842.9 843.9 893.6 895.6 896.1 896.4 896.6 728.5 852.6 865.7 875.3 894.4 642.3 644.0 644.3 644.4 644.7 13941.4 13993.4 14011.0 14021.1 14022.9 13358.1 13507.8 13604.2 13635.4 13798.2 11901.3 12106.9 12113.2 12191.7 12378.1 4371.7 4415.1 4444.6 4463.4 4504.3 54301.0 54920.2 55618.0 55680.7 55757.7 11229.6 11245.2 11359.7 11384.4 11514.9 20157.4 20168.7 20191.0 20208.5 20233.5 8011.4 8138.4 8292.2 8333.5 8627.8 4724.5 4748.0 4822.5 4864.7 4888.9 3458.8 3554.1 3574.7 3578.1 3578.5 503.7 660.4 665.4 667.6 703.2 775.1 777.0 801.0 814.6 819.8 9577.6 10083.1 10127.5 10217.6 10258.6 677.6 689.2 734.1 738.2 776.8 4711.9 4712.2 4766.4 4861.1 4939.0 66565.3 67296.0 67375.0 67821.0 67824.0 59780.0 60077.7 60522.4 62381.7 63990.0 54994.0 56325.4 56513.4 56840.4 57971.7 9030.3 9081.4 9192.8 9193.5 9218.9 35540.0 35847.3 36029.5 36082.6 36153.5 43979.3 46317.5 47943.5 48722.8 49413.0 11749.8 11758.6 11952.8 12134.6 12407.1 13004.9 13232.9 13375.3 13487.3 13947.8 12646.7 12691.7 13109.4 13172.2 13190.1 12504.4 12525.4 12610.0 13095.2 13197.5 12021.0 12056.0 12494.5 12523.7 12617.2 10472.2 10576.2 10682.8 10933.9 11013.4 10803.7 10839.6 10859.2 10883.3 11019.4 17:25:48 INFO - PROCESS | 2852 | -------- Summary: end -------- 17:25:48 INFO - PROCESS | 2852 | 17:25:48 INFO - TEST-INFO | 2852: exit 0 17:25:48 INFO - TEST-OK | dromaeo_css | took 1113508ms 17:25:48 INFO - TEST-START | kraken 17:25:48 INFO - operating with platform_type : linux_ 17:25:48 INFO - Initialising browser for kraken test... 17:25:48 INFO - TEST-INFO | started process 3051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqfijq/profile http://localhost:50810/getInfo.html) 17:25:53 INFO - PROCESS | 3051 | __metrics Screen width/height:1600/1200 17:25:53 INFO - PROCESS | 3051 | colorDepth:24 17:25:53 INFO - PROCESS | 3051 | Browser inner width/height: 1024/697 17:25:53 INFO - PROCESS | 3051 | __metrics 17:25:54 ERROR - PROCESS | 3051 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:25:55 INFO - TEST-INFO | 3051: exit 0 17:25:55 INFO - Browser initialized. 17:25:55 INFO - Running cycle 1/1 for kraken test... 17:25:55 INFO - TEST-INFO | started process 3134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqfijq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:07 INFO - PROCESS | 3134 | RSS: Main: 151654400 17:26:07 INFO - PROCESS | 3134 | 17:26:09 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50810/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:10 INFO - PROCESS | 3134 | RSS: Main: 207917056 17:26:10 INFO - PROCESS | 3134 | 17:26:13 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50810/tests/kraken/driver.html?testName=audio-dft) 17:26:13 INFO - PROCESS | 3134 | RSS: Main: 197201920 17:26:13 INFO - PROCESS | 3134 | 17:26:17 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50810/tests/kraken/driver.html?testName=audio-fft) 17:26:17 INFO - PROCESS | 3134 | RSS: Main: 264769536 17:26:17 INFO - PROCESS | 3134 | 17:26:19 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50810/tests/kraken/driver.html?testName=audio-oscillator) 17:26:20 INFO - PROCESS | 3134 | RSS: Main: 173146112 17:26:20 INFO - PROCESS | 3134 | 17:26:22 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:23 INFO - PROCESS | 3134 | RSS: Main: 177864704 17:26:23 INFO - PROCESS | 3134 | 17:26:26 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50810/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:27 INFO - PROCESS | 3134 | RSS: Main: 214278144 17:26:27 INFO - PROCESS | 3134 | 17:26:30 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50810/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:31 INFO - PROCESS | 3134 | RSS: Main: 212230144 17:26:31 INFO - PROCESS | 3134 | 17:26:34 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50810/tests/kraken/driver.html?testName=json-parse-financial) 17:26:34 INFO - PROCESS | 3134 | RSS: Main: 212869120 17:26:34 INFO - PROCESS | 3134 | 17:26:36 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:37 INFO - PROCESS | 3134 | RSS: Main: 203116544 17:26:37 INFO - PROCESS | 3134 | 17:26:38 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50810/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:39 INFO - PROCESS | 3134 | RSS: Main: 205537280 17:26:39 INFO - PROCESS | 3134 | 17:26:41 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:42 INFO - PROCESS | 3134 | RSS: Main: 214052864 17:26:42 INFO - PROCESS | 3134 | 17:26:45 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:45 INFO - PROCESS | 3134 | RSS: Main: 222789632 17:26:45 INFO - PROCESS | 3134 | 17:26:48 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:49 INFO - PROCESS | 3134 | RSS: Main: 219750400 17:26:49 INFO - PROCESS | 3134 | 17:26:50 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:50810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50810/tests/kraken/driver.html?testName=ai-astar) 17:26:51 INFO - PROCESS | 3134 | RSS: Main: 264785920 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | __start_tp_report 17:26:51 INFO - PROCESS | 3134 | _x_x_mozilla_page_load 17:26:51 INFO - PROCESS | 3134 | _x_x_mozilla_page_load_details 17:26:51 INFO - PROCESS | 3134 | |i|pagename|runs| 17:26:51 INFO - PROCESS | 3134 | |0;ai-astar;112;107;111;110;110;111;109;109;111;110 17:26:51 INFO - PROCESS | 3134 | |1;audio-beat-detection;160;126;149;215;125;159;154;133;177;129 17:26:51 INFO - PROCESS | 3134 | |2;audio-dft;160;163;163;161;159;161;162;163;162;160 17:26:51 INFO - PROCESS | 3134 | |3;audio-fft;74;75;76;165;77;76;76;75;135;76 17:26:51 INFO - PROCESS | 3134 | |4;audio-oscillator;92;91;148;90;92;92;128;92;91;120 17:26:51 INFO - PROCESS | 3134 | |5;imaging-gaussian-blur;116;117;116;116;117;116;119;117;116;118 17:26:51 INFO - PROCESS | 3134 | |6;imaging-darkroom;146;147;145;145;145;145;145;146;145;146 17:26:51 INFO - PROCESS | 3134 | |7;imaging-desaturate;94;95;95;95;94;95;96;95;95;96 17:26:51 INFO - PROCESS | 3134 | |8;json-parse-financial;57;56;58;57;58;58;59;117;57;56 17:26:51 INFO - PROCESS | 3134 | |9;json-stringify-tinderbox;59;59;59;60;60;59;59;60;59;60 17:26:51 INFO - PROCESS | 3134 | |10;stanford-crypto-aes;82;85;79;78;78;81;79;80;80;84 17:26:51 INFO - PROCESS | 3134 | |11;stanford-crypto-ccm;140;126;137;126;128;123;124;124;189;135 17:26:51 INFO - PROCESS | 3134 | |12;stanford-crypto-pbkdf2;168;169;172;171;171;169;171;170;168;166 17:26:51 INFO - PROCESS | 3134 | |13;stanford-crypto-sha256-iterative;67;66;65;65;65;66;66;65;63;63 17:26:51 INFO - PROCESS | 3134 | __end_tp_report 17:26:51 INFO - PROCESS | 3134 | __start_cc_report 17:26:51 INFO - PROCESS | 3134 | _x_x_mozilla_cycle_collect,1850 17:26:51 INFO - PROCESS | 3134 | __end_cc_report 17:26:51 INFO - PROCESS | 3134 | __startTimestamp1462840011063__endTimestamp 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | ------- Summary: start ------- 17:26:51 INFO - PROCESS | 3134 | Number of tests: 14 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.41 (1.3%) stddev-sans-first:1.30 17:26:51 INFO - PROCESS | 3134 | Values: 112.0 107.0 111.0 110.0 110.0 111.0 109.0 109.0 111.0 110.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:156.50 stddev:27.91 (17.8%) stddev-sans-first:29.48 17:26:51 INFO - PROCESS | 3134 | Values: 160.0 126.0 149.0 215.0 125.0 159.0 154.0 133.0 177.0 129.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 17:26:51 INFO - PROCESS | 3134 | Values: 160.0 163.0 163.0 161.0 159.0 161.0 162.0 163.0 162.0 160.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#3] audio-fft Cycles:10 Average:90.50 Median:76.00 stddev:32.16 (42.3%) stddev-sans-first:33.55 17:26:51 INFO - PROCESS | 3134 | Values: 74.0 75.0 76.0 165.0 77.0 76.0 76.0 75.0 135.0 76.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:91.50 stddev:20.75 (22.7%) stddev-sans-first:21.58 17:26:51 INFO - PROCESS | 3134 | Values: 92.0 91.0 148.0 90.0 92.0 92.0 128.0 92.0 91.0 120.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 17:26:51 INFO - PROCESS | 3134 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 119.0 117.0 116.0 118.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 17:26:51 INFO - PROCESS | 3134 | Values: 146.0 147.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:26:51 INFO - PROCESS | 3134 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 96.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:57.50 stddev:18.89 (32.9%) stddev-sans-first:19.90 17:26:51 INFO - PROCESS | 3134 | Values: 57.0 56.0 58.0 57.0 58.0 58.0 59.0 117.0 57.0 56.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 17:26:51 INFO - PROCESS | 3134 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 59.0 60.0 59.0 60.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:2.41 (3.0%) stddev-sans-first:2.51 17:26:51 INFO - PROCESS | 3134 | Values: 82.0 85.0 79.0 78.0 78.0 81.0 79.0 80.0 80.0 84.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:131.50 stddev:19.84 (15.1%) stddev-sans-first:20.96 17:26:51 INFO - PROCESS | 3134 | Values: 140.0 126.0 137.0 126.0 128.0 123.0 124.0 124.0 189.0 135.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.50 stddev:1.84 (1.1%) stddev-sans-first:1.87 17:26:51 INFO - PROCESS | 3134 | Values: 168.0 169.0 172.0 171.0 171.0 169.0 171.0 170.0 168.0 166.0 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - PROCESS | 3134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.29 (2.0%) stddev-sans-first:1.17 17:26:51 INFO - PROCESS | 3134 | Values: 67.0 66.0 65.0 65.0 65.0 66.0 66.0 65.0 63.0 63.0 17:26:51 INFO - PROCESS | 3134 | -------- Summary: end -------- 17:26:51 INFO - PROCESS | 3134 | 17:26:51 INFO - TEST-INFO | 3134: exit 0 17:26:52 INFO - TEST-OK | kraken | took 63065ms 17:26:52 INFO - SUITE-END | took 1176s 17:26:52 INFO - Completed test suite (00:19:36) 17:26:52 INFO - javascript benchmark 17:26:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3173.523971404289, 3174.6031746031745, 3202.0553936588713, 3208.887688930888, 3235.7734958552896, 5231.084560201959, 5290.523852853243, 5322.308099947007, 5393.271908292384, 5439.0, 5244.632875698702, 5322.308099947011, 5331.253624492564, 5344.35867695877, 5371.4897084776885, 4798.83204087857, 4866.659333846632, 4880.6095512358925, 4897.1674815281485, 5030.522100400456, 4946.703197808125, 4995.850124496271, 5003.524665156822, 5013.097642424362, 5014.498550144975, 4785.353977213083, 4842.055799119138, 4852.563269305761, 4886.609071274325, 4937.037277730844, 4851.223804191312, 4861.586765124968, 4868.026394721034, 4930.359053323081, 4967.975160124212, 4900.534449227318, 4924.556789888928, 4926.482719314492, 4934.950650493485, 4939.061578300111, 5145.871353216199, 5161.483851614846, 5221.242919776611, 5231.189165679326, 5300.575953923677, 5707.429257074301, 5769.1923130761725, 5800.303963524404, 5800.593958422912, 5807.535397168216, 5633.887322253532, 5777.711114444303, 5826.359100498942, 5831.183634291203, 5837.678927658977, 5357.946420535784, 5374.220737993008, 5390.029794636964, 5441.646292990943, 5509.228707980926, 5947.851303717355, 5951.821445356646, 5953.880922381615, 5959.731812068468, 5970.014947533608, 5539.473749993744, 5663.858403539944, 5739.5695322850115, 5747.971260143672, 5749.540036797046, 5806.071028635482, 5843.328017277982, 5854.590178687451, 5865.794697185578, 5921.644701317935, 5808.970955145197, 5830.737616807254, 5830.76676932918, 5831.7667293307795, 5850.53195744348, 5596.188552659842, 5672.12082127271, 5739.62692424991, 5844.0, 5849.093390524476, 4382.167388196232, 4390.714603550759, 4397.538258482878, 4402.075564131568, 4429.402030725811, 3878.825452854628, 3898.8440462381755, 3899.473571067926, 3927.6072392761066, 3930.2336044471053, 5371.274877891435, 5398.190271459234, 5405.081136206854, 5433.918491222635, 5435.211894275308, 5760.53915686744, 5790.334111577223, 5796.246487956539, 5800.88398232033, 5813.186153938452, 5373.167159090347, 5442.156465747737, 5446.074167391553, 5446.673199608036, 5455.672659640434, 4929.926051109236, 4977.129002424561, 4977.552020318117, 4998.70007799526, 5009.599232061426, 6027.48766354856, 6060.0, 6067.302260240041, 6070.089486576961, 6076.27084749824, 5611.130274807411, 5756.481916627524, 5834.766609335579, 5852.063669812809, 5858.414158584107, 5960.8807823844145, 6027.36712645166, 6031.788887388921, 6040.36576159497, 6092.847678808065, 5755.769769209185, 5756.222909907109, 5761.4238576143725, 5764.106563482667, 5766.192733017297, 5567.832965011056, 5717.628354156966, 5723.713814309352, 5826.533877289891, 5843.8539036522725, 5619.409961953936, 5620.381758006698, 5625.831225063091, 5625.859353516031, 5668.319801623831, 5563.054280772198, 5581.134924086773, 5598.692071936082, 5627.324721033502, 5637.295338082739, 5401.891962160814, 5509.614326997072, 5530.5022547970875, 5539.058360078716, 5544.944550554605, 5709.771609135588, 5714.857128571819, 5742.712864356849, 5749.942500574941, 5780.0, 5601.355844077983, 5604.6917419542315, 5605.467480589337, 5606.0, 5636.718164091861], "value": 5324.535895179412, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.7671646416131, 631.1321932343028, 640.4684112186883, 655.1810237203496, 657.6645910585602, 44201.33697994533, 45804.0, 45908.311375329395, 49287.0, 49452.50547494524, 45301.0, 46163.0, 46260.768696156556, 46269.76865115669, 46373.7681311593, 8657.870131948026, 8867.68963086292, 8874.245689116433, 8878.378513504058, 8881.0, 8829.426087304304, 8874.290056795473, 8902.421342612743, 8940.329475289347, 8941.061188575204, 8869.600867960957, 8905.866412003825, 8928.642854285821, 8936.240419564345, 8937.150970657809, 8904.332175086862, 8975.416597921114, 8975.730728078168, 8982.550872456384, 8984.910150898506, 8837.955810220908, 8916.643334266622, 8921.304952059088, 8921.955390223007, 8924.643014279422, 42123.0, 42590.57409425928, 42592.57407425917, 42625.78687106576, 42708.78645606783, 3554.2003049313957, 3582.0865679251883, 3704.629537046301, 3984.30274701926, 4304.504981927056, 32004.519932201034, 32308.515372269434, 32546.0, 32993.835030824936, 33562.0, 4311.439512863339, 4344.283193273106, 4370.8033138508845, 4385.956140438619, 4412.316091005867, 312320.0, 313684.0, 314245.0, 314247.0, 315197.99999999773, 61401.69299153565, 61493.69253153705, 61551.076733849026, 61875.6906215475, 61941.0, 58339.416605834245, 64434.355656443775, 64662.35337646658, 65450.345496544425, 65687.67156164188, 17926.193321300572, 18022.459326220236, 18085.7287140693, 18088.186031628607, 18123.0, 12979.480820767252, 13001.0, 13038.739225215631, 13046.347682615831, 13054.216746995211, 17837.910810445865, 19470.07357327495, 20803.0, 20843.478913027295, 20966.0, 7277.927220727831, 7282.0, 7338.339549440576, 7413.925860741431, 7527.247275272429, 982.8918818929913, 1008.1330056151704, 1150.1948635954866, 1167.3521195736448, 1207.0946789907568, 32704.672953270638, 32965.83517082399, 33137.66862331346, 33403.49894751581, 34049.65950340465, 1096.2162054131334, 1123.5056575106926, 1157.2593540134321, 1175.3476820364779, 1214.9088818338482, 16414.0, 16861.325546978227, 16987.660246795243, 17122.785462328247, 17259.0, 423240.0, 423697.0, 424868.0, 426057.0, 426848.0, 57789.711051445316, 58446.4155358441, 58483.0, 58537.0, 58561.0, 1341.215388997428, 1392.5543825975792, 1394.1774353131905, 1403.1510935883848, 1426.5577670922048, 30354.696453035187, 30754.0, 31189.37621247517, 31514.0, 31566.36867262596, 48851.26723099227, 49755.253671195685, 49782.25326620176, 49825.750871245415, 49880.750596246784, 381584.0, 381859.0, 383504.0, 383510.0, 383975.0, 25357.492850143262, 26086.0, 27675.0, 27710.168694939184, 28606.14181574556, 42558.65927374024, 47427.762861185474, 47674.52325476701, 47785.52214477811, 48674.513254867, 39666.206675866895, 40491.39262911, 40559.18881622292, 41010.79494602508, 41282.587174127875, 39637.0, 40245.0, 40970.385444218955, 41365.0, 41401.37897931594, 40276.3958540628, 40560.391594126704, 41169.0, 41230.38154427626, 41310.586894130676, 33811.492827607115, 35972.4604130933, 36035.27929441449, 36362.45456318105, 36751.26497470089, 27653.72346276592, 27675.308117297227, 27924.86037569799, 27947.161585152477, 27982.44035119327], "value": 20184.916811175095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.96170382961697, 387.54076419442964, 390.75968279508095, 402.1093278388369, 404.48832227232555, 17503.212355444004, 19293.32473363429, 20083.59832803343, 20105.497362565944, 20126.59746805063, 18896.71654925177, 19142.425727228205, 19299.324523641677, 19594.216231350765, 19666.606667866636, 5573.442655734435, 5573.470520300585, 5630.887382252353, 5761.337446193678, 5902.557308201881, 5893.528517718572, 5899.528037756991, 5914.172015917775, 5931.851703707399, 5935.851603709899, 5446.482584154499, 5779.422057794208, 5779.479846813786, 5883.264591926009, 5897.351291357947, 5726.513246374063, 5731.426857314277, 5740.741666625012, 5747.33905600855, 5753.280839895013, 5361.276227709248, 5516.779328826842, 5558.666480011172, 5564.10974244119, 5577.470140336662, 13530.052896297264, 13768.793468097987, 15270.694586108326, 22514.77485225143, 23073.0, 2265.150568536799, 2316.779905908953, 2332.7084114485688, 2363.5036642305136, 2475.418276704973, 9655.46894920779, 10318.484075796181, 10543.683689489251, 12507.624771256877, 13683.700048495377, 1861.702127659568, 1908.0841196225751, 1941.7669879614396, 1978.2284908885547, 1985.3547597031022, 81006.0, 82179.5891020547, 83242.0, 83812.0, 83894.58052709758, 8776.210141087333, 9268.351215414856, 9455.905440945502, 9711.805763884682, 10144.847827282596, 12781.297028663326, 12803.743925121445, 12811.295378754072, 12852.48590056406, 12869.549565765154, 7409.370203532652, 7667.156612772591, 7876.448648594658, 7961.16407777175, 7988.281054705104, 7986.480878742979, 8134.511929284262, 8198.221168988937, 8322.958385208036, 8332.708355207538, 3978.144698889753, 4028.0, 4078.8164532596106, 4148.170365926766, 4149.8962525937095, 1866.2534986005705, 1965.3416105604497, 1973.2304401283511, 1983.2364539652049, 2025.5543780368296, 960.841461158915, 1059.4543809937888, 1067.1676092647747, 1074.505727365405, 1098.9230753847314, 17984.0, 18705.31652151313, 18740.812591873906, 19662.90168549148, 19739.60520789605, 1021.7317555027827, 1027.173125633872, 1034.3121823986965, 1054.9472526373804, 1065.6003998500562, 10634.149268058536, 11068.501917413736, 11081.113510919107, 11087.168462365355, 11089.5564177432, 421769.0, 422754.0, 422763.0, 423374.0, 433021.0, 87562.56218718865, 89350.0, 90823.0, 91716.0, 91804.0, 1025.5231317437278, 1041.6406339812752, 1044.9947750261351, 1060.6181774561153, 1064.7497838008062, 16300.836991629933, 16967.236474358437, 17297.827021729623, 17308.740368894225, 17669.204885779913, 39391.80304098461, 40367.79816100901, 40400.19199615932, 40676.1864762709, 41047.0, 54222.45777542174, 54709.0, 55830.72084639551, 55853.72073139608, 55987.160192596326, 7492.175860655215, 7847.529148251123, 8310.916890831015, 8790.560471976247, 8882.822343553222, 13333.733325333245, 13667.453301868212, 13738.10702304347, 13823.654408639864, 13881.305934703427, 11643.47604357789, 11952.223105498115, 11953.641390758292, 12047.939760301142, 12418.56535021306, 11775.587854425054, 11942.34317112567, 12006.459709312927, 12169.39153042362, 12317.692057698629, 12071.275723456622, 12322.137450378388, 12409.689757756129, 12542.0, 12766.361681916052, 8135.064467586067, 8142.47073940192, 8211.630476628447, 8213.630386632496, 8296.917030829856, 11187.384693841917, 12377.545020579499, 12515.56195533152, 12589.559365422167, 12810.743785124432], "value": 9076.137264754485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.1820907455522, 1520.2702702702702, 1531.8621324080834, 1730.152225409549, 1845.935392261271, 7732.1881202473705, 8038.316743076845, 8040.91959080409, 8215.178482151781, 8222.753317400473, 7991.320737737299, 8167.06078800938, 8173.0, 8178.631961561729, 8222.835543289131, 1977.8714383565093, 2034.3693455028915, 2232.8325375596814, 2303.251443280928, 2332.218706733238, 2313.3869524576003, 2338.2751347082376, 2342.2973108067513, 2342.309018839438, 2349.6240601503764, 2291.5302363015544, 2300.1489448903844, 2311.04091801902, 2341.519988402382, 2346.5189636124555, 1939.3697048459167, 2160.4274867160216, 2236.37381533171, 2251.6397376419695, 2270.909163633453, 2267.5464907018495, 2287.931362059141, 2289.210222473244, 2291.186628746804, 2293.747687754346, 8415.0, 8475.660973561051, 8480.279176270025, 8483.787905302355, 8487.193716596914, 4977.352944117278, 5062.164742817431, 5067.721275329855, 5092.159793634046, 5107.7956881724685, 3167.825769582672, 3195.6964088411796, 3353.815540145291, 3369.2419205678525, 3378.4594464885745, 1135.3868910788165, 1145.1297014269132, 1159.2406973432414, 1162.8023236049892, 1180.6340034589218, 11399.829002564968, 11418.42907854604, 11427.60003399877, 11444.141689373413, 11449.255798373079, 4468.0, 4548.56788605082, 4597.540245975376, 4634.443866736014, 4639.721616702941, 9795.167410770022, 9867.0, 9887.752806179904, 9891.35706179096, 9909.702708918743, 5243.737813109329, 5246.422893481714, 5248.737563121828, 5255.5795536357, 5256.237845512379, 4267.253230684618, 4743.976280118577, 4755.548222918817, 4893.290472881484, 4926.285688575136, 3758.248350329945, 3863.497745293094, 3889.747166434173, 3911.1395492991496, 3940.625640564142, 1233.2353940556911, 1237.6287113865803, 1248.2572869142846, 1255.8241846141548, 1259.238160912653, 880.2825697056878, 995.1292618958412, 1029.9279050466546, 1031.118393773328, 1035.896410358958, 5988.161657367972, 6147.508199344042, 6233.34549872266, 6286.717097730613, 6324.652144132025, 451.7041337923665, 453.8956040110727, 458.92657174851865, 467.8619807156897, 468.96951698139515, 4082.6121518455698, 4191.700572822435, 4257.40396344512, 4280.785960701953, 4313.158934007838, 10301.278910476194, 10488.842667359995, 10683.14534837211, 10790.568377264979, 10806.459677016275, 10480.371177729208, 10588.576456941637, 10665.89334106649, 10674.412907290174, 10680.786384272427, 7616.0, 8030.397720170894, 8033.919660803434, 8039.115697273295, 8096.392770542233, 6112.1748563945075, 6193.225846769154, 6239.220097487814, 6241.656708881055, 6262.780802671885, 9616.0, 9749.853752193865, 9881.85177222328, 10015.349002314826, 10023.899761002296, 9790.461524616214, 9878.901210988086, 10149.238807089645, 10170.135538479311, 10177.287589868638, 7059.399951004222, 7071.292870713093, 7234.385077268491, 7450.701971921062, 7550.7734767957045, 8458.577071146541, 8465.788355291166, 8512.616932237941, 8526.82946341082, 8536.914630853613, 7519.548827070394, 7680.231976802275, 7740.612969351398, 7823.726169584037, 7844.450888437755, 7452.652414489418, 7470.92529074724, 7533.472656913963, 7628.618569071636, 7635.236476352543, 6691.5650482718465, 6743.190817101783, 6765.391114799691, 6772.52592318533, 6775.220849602359, 4973.950260497493, 5063.367079115111, 5104.719240441811, 5195.0, 5231.738413079407, 4992.176290912104, 5008.223725322581, 5087.135187018142, 5141.100307446257, 5161.612879034013], "value": 4470.53360333177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.72714096605574, 332.19277156509685, 334.7924286942096, 341.342914888839, 346.4958485403738, 5276.630635855492, 5308.867278318044, 5310.654807437514, 5312.814051508198, 5323.387810401795, 5058.898822023557, 5160.587153027758, 5218.608604354679, 5220.712860792655, 5251.973740131294, 4058.8635182148896, 4112.547619761824, 4152.107296931159, 4163.521195062576, 4210.179015092058, 4124.340105583107, 4128.8761337159785, 4162.334026555752, 4166.166766646667, 4187.371894215861, 4065.918681626366, 4121.8969525761795, 4147.792610369469, 4160.646345060673, 4201.831926722927, 4142.212979533879, 4142.772147531885, 4154.979225103885, 4159.856039589107, 4179.895502612429, 3719.8512059517857, 3721.2371463849845, 3721.5162028936065, 3739.0, 3744.5319335083113, 4986.202207646796, 5065.898682026339, 5089.287499750038, 5100.413452452978, 5141.408737995141, 4732.692374995614, 4748.169070412699, 4767.880802979918, 4769.688335707673, 4782.832600858988, 5443.401225865152, 5458.0, 5468.9726551367385, 5477.589180811455, 5508.421615730331, 3987.940180897289, 4068.1660259646997, 4078.7967549572945, 4106.398504583215, 4116.938245926313, 5672.546196304327, 5710.257666503369, 5719.799807006776, 5721.313442386899, 5733.369329373765, 4148.315527937856, 4161.708680392404, 4163.979180104141, 4184.497860256728, 4199.328107502785, 4024.9195016099516, 4210.85262015828, 4216.135692183095, 4222.366645003212, 4242.17277630859, 4709.411323584552, 4738.289256611536, 4738.360321356642, 4738.597219236403, 4797.232442809134, 5514.255575497336, 5539.25220095282, 5556.472135147235, 5562.193481945095, 5575.163725441135, 1328.4619729009767, 1347.4408120629828, 1403.9368228429746, 1410.3089486151712, 1419.340006896798, 967.8403063494444, 971.3055165556661, 974.5517062151348, 980.9656662016795, 983.6409710455632, 5086.72023038729, 5104.2343648453025, 5118.820841270538, 5125.820596279187, 5149.304843846107, 5500.779968801203, 5508.118701007819, 5511.22842802008, 5512.5589952803675, 5522.696251706195, 4979.278004689299, 5115.148247440162, 5122.641415100981, 5181.896362072737, 5182.585393168538, 2844.8435336056714, 2856.371598248382, 2862.6278583783974, 2878.2372671242138, 2885.047934181715, 5557.527610153183, 5627.352854421712, 5629.971850140723, 5647.181158731961, 5676.90608618304, 5833.258368566767, 5889.174355949669, 5891.35042188188, 5902.76388944446, 5914.852128696731, 5938.248216776062, 5949.732262048132, 5966.582339236299, 5969.791057312973, 5987.670678112659, 5457.590680698884, 5695.487406133468, 5697.601167918206, 5713.285839270091, 5715.857103572278, 5597.804076857454, 5640.0, 5644.8306550803545, 5661.264035675501, 5669.809340038638, 5651.937042979365, 5906.645601263938, 5915.58590898633, 5916.940830591639, 5931.51712071982, 4061.6750659947725, 4068.267711811784, 4088.8568900088353, 4095.6928230382246, 4097.610726980932, 5475.616706830484, 5612.354579223442, 5688.061469857427, 5771.192033115283, 5783.971080144573, 5553.250311208097, 5560.916586251128, 5574.933786417373, 5581.190727344593, 5581.553475721851, 5506.311711036121, 5567.888642227052, 5571.637843540157, 5574.414686457863, 5577.637453565668, 5224.634275600672, 5430.15832545956, 5444.727763611724, 5453.64551304164, 5480.410680902493, 5586.664800112007, 5594.356648985418, 5606.607537472338, 5613.46672066153, 5615.7192140392, 5203.479652034766, 5478.397376288684, 5486.984907792072, 5500.534663162182, 5505.073224371438], "value": 4229.047835756733, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.709003303827, 851.3231980575442, 863.6502216602271, 870.5516658920653, 888.3648191543045, 13306.66733331666, 14881.925590372046, 15090.320935557898, 15090.849091509082, 15120.546383608496, 13833.792493112585, 13858.4456621735, 13904.443822247124, 13906.58280251594, 13910.304484775746, 694.191267173742, 807.9757607271791, 817.6647574494458, 842.8187939592987, 849.2823564088335, 835.8453686068067, 841.0160112668193, 841.6675413211777, 842.8609279468881, 843.9493630382166, 893.6112790935931, 895.6417433026776, 896.135229503529, 896.3546246702397, 896.5606852642223, 728.5264578024273, 852.5737131434283, 865.6537385045968, 875.3041332140963, 894.3650008493977, 642.2613993906998, 644.0178727440643, 644.2591020326615, 644.3942693867749, 644.7131026693123, 13941.372638231303, 13993.440262389595, 14011.0, 14021.08862923917, 14022.92988535061, 13358.064935454522, 13507.797383039262, 13604.183748975092, 13635.38640761168, 13798.241096739675, 11901.345426001566, 12106.878931210664, 12113.15207935445, 12191.695207619881, 12378.0716446266, 4371.737695738234, 4415.116976604692, 4444.555544445562, 4463.352813841975, 4504.2793153095345, 54301.0, 54920.17619735707, 55618.0, 55680.72159639216, 55757.72121139409, 11229.550817967352, 11245.212835101627, 11359.659210223706, 11384.43077846121, 11514.884851151548, 20157.395278141677, 20168.69746953797, 20190.990450477417, 20208.494787630134, 20233.494162646053, 8011.359091272684, 8138.43030987837, 8292.212239837207, 8333.541655208901, 8627.827443451095, 4724.503927087606, 4747.976260118678, 4822.493638168012, 4864.683795553277, 4888.926666100011, 3458.844352004166, 3554.0937061049785, 3574.749767516301, 3578.141246100969, 3578.481120237551, 503.7179179659403, 660.448525481219, 665.374547924949, 667.6461475418037, 703.2440126863539, 775.0621747685251, 776.984460310802, 801.0027515742937, 814.645629151321, 819.7540737778643, 9577.569009394594, 10083.092521673085, 10127.544260508148, 10217.642382516577, 10258.640947566799, 677.6476232359245, 689.2039694153261, 734.1337222077999, 738.2174894611729, 776.8096816280048, 4711.905761884743, 4712.222483290218, 4766.404199475066, 4861.124997500413, 4939.0, 66565.33434665688, 67296.0, 67375.0, 67821.0, 67824.0, 59780.0, 60077.69961150167, 60522.394776052555, 62381.68809155925, 63990.0, 54994.0, 56325.43674563284, 56513.434865650815, 56840.43159568434, 57971.710141449024, 9030.277577793891, 9081.364304498622, 9192.770180745534, 9193.494357810117, 9218.907810922074, 35540.0, 35847.283054338244, 36029.45955810612, 36082.63917360793, 36153.45769813402, 43979.34030989602, 46317.53682463132, 47943.52056479391, 48722.75638621784, 49413.0, 11749.765004699688, 11758.58844940423, 11952.76094478123, 12134.635960921187, 12407.131500795218, 13004.869951300745, 13232.933835330761, 13375.26436045988, 13487.25820079905, 13947.790783138464, 12646.747065058831, 12691.682707932006, 13109.410076546768, 13172.209667419986, 13190.142640728322, 12504.374781261082, 12525.37373131358, 12610.0, 13095.214287142802, 13197.472101116233, 12021.0, 12056.0, 12494.500219991098, 12523.749525009267, 12617.179883307555, 10472.162227021972, 10576.15390768752, 10682.786344272916, 10933.890661093605, 11013.394263315595, 10803.683800467315, 10839.566417343218, 10859.185561082792, 10883.28940222134, 11019.393933333744], "value": 6999.396671138448, "unit": "score"}], "name": "dromaeo_css", "value": 7109.184237695079, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 110.0, 110.0, 111.0, 109.0, 109.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 149.0, 215.0, 125.0, 159.0, 154.0, 133.0, 177.0, 129.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 163.0, 161.0, 159.0, 161.0, 162.0, 163.0, 162.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 165.0, 77.0, 76.0, 76.0, 75.0, 135.0, 76.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 148.0, 90.0, 92.0, 92.0, 128.0, 92.0, 91.0, 120.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 119.0, 117.0, 116.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 57.0, 58.0, 58.0, 59.0, 117.0, 57.0, 56.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 79.0, 78.0, 78.0, 81.0, 79.0, 80.0, 80.0, 84.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 126.0, 137.0, 126.0, 128.0, 123.0, 124.0, 124.0, 189.0, 135.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 172.0, 171.0, 171.0, 169.0, 171.0, 170.0, 168.0, 166.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 63.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1548.6, "alertThreshold": 2.0}]} 17:26:52 INFO - Return code: 0 17:26:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:26:52 ERROR - # TBPL SUCCESS # 17:26:52 INFO - Running post-action listener: _resource_record_post_action 17:26:52 INFO - ##### 17:26:52 INFO - ##### Finished run-tests step (success) 17:26:52 INFO - ##### 17:26:52 INFO - Running post-run listener: _resource_record_post_run 17:26:53 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 519589888; Read time: 0; Write time: 565464 17:26:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 154820608; Read time: 0; Write time: 242004 17:26:53 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289550336; Read time: 0; Write time: 243560 17:26:53 INFO - Running post-run listener: _upload_blobber_files 17:26:53 INFO - Blob upload gear active. 17:26:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:26:53 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 17:26:53 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'] 17:26:53 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 17:26:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:54 INFO - (blobuploader) - INFO - Done attempting. 17:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:55 INFO - (blobuploader) - INFO - Done attempting. 17:26:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:26:55 INFO - Return code: 0 17:26:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:26:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:26:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/872966a49f10f125ada5de507a25f8ded26dd22774f05ad3bbeda5732a12956bb0d235e228eb0d3bba1e6141d2d6c6717fe1151812a5caee765a27cce3b05029", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/794a41ab2af91b4603b8a84f6ed890ae89a08b4bdbf305b20e9ada90cbceab27a1680a1e8844ff65deb1da285b18ccfdb1fc1eb066c56da854837fff5110de3d"} 17:26:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:26:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:26:55 INFO - Contents: 17:26:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/872966a49f10f125ada5de507a25f8ded26dd22774f05ad3bbeda5732a12956bb0d235e228eb0d3bba1e6141d2d6c6717fe1151812a5caee765a27cce3b05029", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/794a41ab2af91b4603b8a84f6ed890ae89a08b4bdbf305b20e9ada90cbceab27a1680a1e8844ff65deb1da285b18ccfdb1fc1eb066c56da854837fff5110de3d"} 17:26:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:26:55 INFO - Copying logs to upload dir... 17:26:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:26:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.271649 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-09 17:26:54.639817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 17:26:54.642950) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490 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/872966a49f10f125ada5de507a25f8ded26dd22774f05ad3bbeda5732a12956bb0d235e228eb0d3bba1e6141d2d6c6717fe1151812a5caee765a27cce3b05029", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/794a41ab2af91b4603b8a84f6ed890ae89a08b4bdbf305b20e9ada90cbceab27a1680a1e8844ff65deb1da285b18ccfdb1fc1eb066c56da854837fff5110de3d"} build_url:https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/PuKp0oYqQ8ap9WfBqAuhlg/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/872966a49f10f125ada5de507a25f8ded26dd22774f05ad3bbeda5732a12956bb0d235e228eb0d3bba1e6141d2d6c6717fe1151812a5caee765a27cce3b05029", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/794a41ab2af91b4603b8a84f6ed890ae89a08b4bdbf305b20e9ada90cbceab27a1680a1e8844ff65deb1da285b18ccfdb1fc1eb066c56da854837fff5110de3d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 17:26:54.669031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:26:54.669390) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462832723.390715-757088490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:26:54.752309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 17:26:54.755702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 17:26:54.756006) ========= ========= Total master_lag: 0.19 =========