builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1466435104.36 results: success (0) buildid: 20160620053002 builduid: 2dc8763fb1a14871929aa723d8195914 revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.358060) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.359112) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.359831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.378326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.378967) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 08:05:04-- 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% 111M=0s 2016-06-20 08:05:04 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.516109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.516707) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013676 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.570812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:04.571666) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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=652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 08:05:04,878 truncating revision to first 12 chars 2016-06-20 08:05:04,878 Setting DEBUG logging. 2016-06-20 08:05:04,878 attempt 1/10 2016-06-20 08:05:04,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c5025f98e56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 08:05:05,202 unpacking tar archive at: fx-team-3c5025f98e56/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670742 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:05.262846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:05.263582) ========= script_repo_revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:05.264655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:05.265306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 08:05:05.276932) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-20 08:05:05.277255) ========= /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=652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:05 INFO - MultiFileLogger online at 20160620 08:05:05 in /builds/slave/test 08:05:05 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 08:05:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:05 INFO - {'append_to_log': False, 08:05:05 INFO - 'base_work_dir': '/builds/slave/test', 08:05:05 INFO - 'blob_upload_branch': 'Fx-Team', 08:05:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:05 INFO - 'branch': 'Fx-Team', 08:05:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:05 INFO - 'config_files': ('talos/linux_config.py',), 08:05:05 INFO - 'default_actions': ('clobber', 08:05:05 INFO - 'read-buildbot-config', 08:05:05 INFO - 'download-and-extract', 08:05:05 INFO - 'populate-webroot', 08:05:05 INFO - 'create-virtualenv', 08:05:05 INFO - 'install', 08:05:05 INFO - 'run-tests'), 08:05:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:05 INFO - 'download_minidump_stackwalk': True, 08:05:05 INFO - 'download_symbols': 'ondemand', 08:05:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:05 INFO - 'installer_path': 'installer.exe', 08:05:05 INFO - 'log_level': 'info', 08:05:05 INFO - 'log_name': 'talos', 08:05:05 INFO - 'log_to_console': True, 08:05:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:05 INFO - 'opt_config_files': (), 08:05:05 INFO - 'pip_index': False, 08:05:05 INFO - 'sps_profile': False, 08:05:05 INFO - 'sps_profile_interval': 0, 08:05:05 INFO - 'suite': 'dromaeojs', 08:05:05 INFO - 'system_bits': '32', 08:05:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:05 INFO - 'title': 'talos-linux64-ix-046', 08:05:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:05 INFO - 'use_talos_json': True, 08:05:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:05 INFO - 'work_dir': 'build'} 08:05:05 INFO - ##### 08:05:05 INFO - ##### Running clobber step. 08:05:05 INFO - ##### 08:05:05 INFO - Running pre-action listener: _resource_record_pre_action 08:05:05 INFO - Running main action method: clobber 08:05:05 INFO - rmtree: /builds/slave/test/build 08:05:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:06 INFO - Running post-action listener: _resource_record_post_action 08:05:06 INFO - ##### 08:05:06 INFO - ##### Finished clobber step (success) 08:05:06 INFO - ##### 08:05:06 INFO - ##### 08:05:06 INFO - ##### Running read-buildbot-config step. 08:05:06 INFO - ##### 08:05:06 INFO - Running pre-action listener: _resource_record_pre_action 08:05:06 INFO - Running main action method: read_buildbot_config 08:05:06 INFO - Using buildbot properties: 08:05:06 INFO - { 08:05:06 INFO - "project": "", 08:05:06 INFO - "product": "firefox", 08:05:06 INFO - "script_repo_revision": "production", 08:05:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:05:06 INFO - "repository": "", 08:05:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:05:06 INFO - "buildid": "20160620053002", 08:05:06 INFO - "pgo_build": "True", 08:05:06 INFO - "basedir": "/builds/slave/test", 08:05:06 INFO - "buildnumber": 1266, 08:05:06 INFO - "slavename": "talos-linux64-ix-046", 08:05:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:05:06 INFO - "platform": "ubuntu64_hw", 08:05:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:05:06 INFO - "branch": "fx-team", 08:05:06 INFO - "repo_path": "integration/fx-team", 08:05:06 INFO - "revision": "3c5025f98e561a20e24d97c91a9e4e0ec28015ea", 08:05:06 INFO - "stage_platform": "linux64-pgo", 08:05:06 INFO - "builduid": "2dc8763fb1a14871929aa723d8195914", 08:05:06 INFO - "slavebuilddir": "test" 08:05:06 INFO - } 08:05:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:05:06 INFO - Running post-action listener: _resource_record_post_action 08:05:06 INFO - ##### 08:05:06 INFO - ##### Finished read-buildbot-config step (success) 08:05:06 INFO - ##### 08:05:06 INFO - ##### 08:05:06 INFO - ##### Running download-and-extract step. 08:05:06 INFO - ##### 08:05:06 INFO - Running pre-action listener: _resource_record_pre_action 08:05:06 INFO - Running main action method: download_and_extract 08:05:06 INFO - mkdir: /builds/slave/test/build/tests 08:05:06 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')]} 08:05:06 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:05:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:05:07 INFO - Downloaded 1361 bytes. 08:05:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:07 INFO - Using the following test package requirements: 08:05:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'jsshell-linux-x86_64.zip'], 08:05:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:07 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:08 INFO - Downloaded 24220838 bytes. 08:05:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:05:09 INFO - Return code: 0 08:05:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:05:09 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')]} 08:05:09 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:11 INFO - Downloaded 24220838 bytes. 08:05:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:05:12 INFO - Return code: 0 08:05:12 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')]} 08:05:12 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:05:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:05:13 INFO - Downloaded 14405384 bytes. 08:05:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:05:13 INFO - Return code: 0 08:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:13 INFO - https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:05:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:05:15 INFO - Downloaded 60128070 bytes. 08:05:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:15 INFO - mkdir: /builds/slave/test/properties 08:05:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:15 INFO - Contents: 08:05:15 INFO - build_url:https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:16 INFO - Running post-action listener: _resource_record_post_action 08:05:16 INFO - Running post-action listener: set_extra_try_arguments 08:05:16 INFO - ##### 08:05:16 INFO - ##### Finished download-and-extract step (success) 08:05:16 INFO - ##### 08:05:16 INFO - ##### 08:05:16 INFO - ##### Running populate-webroot step. 08:05:16 INFO - ##### 08:05:16 INFO - Running pre-action listener: _resource_record_pre_action 08:05:16 INFO - Running main action method: populate_webroot 08:05:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:16 INFO - '--tppagecycles', 08:05:16 INFO - '7'], 08:05:16 INFO - 'tests': ['tsvgm']}}, 08:05:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:16 INFO - 'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:16 INFO - 'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['damp', 'tps']}, 08:05:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:16 INFO - 'tests': ['damp', 'tps']}, 08:05:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['dromaeo_dom']}, 08:05:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['basic_compositor_video']}, 08:05:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:05:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['a11yr', 08:05:16 INFO - 'ts_paint', 08:05:16 INFO - 'tpaint', 08:05:16 INFO - 'sessionrestore', 08:05:16 INFO - 'sessionrestore_no_auto_restore', 08:05:16 INFO - 'tabpaint']}, 08:05:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:16 INFO - 'ts_paint', 08:05:16 INFO - 'tpaint', 08:05:16 INFO - 'sessionrestore', 08:05:16 INFO - 'sessionrestore_no_auto_restore', 08:05:16 INFO - 'tabpaint']}, 08:05:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:16 INFO - 'ts_paint', 08:05:16 INFO - 'tpaint', 08:05:16 INFO - 'sessionrestore', 08:05:16 INFO - 'sessionrestore_no_auto_restore', 08:05:16 INFO - 'tabpaint']}, 08:05:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:16 INFO - 'ts_paint', 08:05:16 INFO - 'tpaint', 08:05:16 INFO - 'sessionrestore', 08:05:16 INFO - 'sessionrestore_no_auto_restore', 08:05:16 INFO - 'tabpaint']}, 08:05:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['a11yr', 08:05:16 INFO - 'ts_paint', 08:05:16 INFO - 'tpaint', 08:05:16 INFO - 'sessionrestore', 08:05:16 INFO - 'sessionrestore_no_auto_restore', 08:05:16 INFO - 'tabpaint']}, 08:05:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['a11yr', 08:05:16 INFO - 'ts_paint', 08:05:16 INFO - 'tpaint', 08:05:16 INFO - 'sessionrestore', 08:05:16 INFO - 'sessionrestore_no_auto_restore', 08:05:16 INFO - 'tabpaint']}, 08:05:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['tsvgx', 08:05:16 INFO - 'tsvgr_opacity', 08:05:16 INFO - 'tart', 08:05:16 INFO - 'tscrollx', 08:05:16 INFO - 'cart']}, 08:05:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:16 INFO - 'tsvgr_opacity', 08:05:16 INFO - 'tart', 08:05:16 INFO - 'tscrollx', 08:05:16 INFO - 'cart']}, 08:05:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:16 INFO - 'talos_options': ['--disable-e10s'], 08:05:16 INFO - 'tests': ['tp5o']}, 08:05:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:16 INFO - 'tests': ['tp5o']}, 08:05:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:16 INFO - 'talos_options': ['--disable-e10s', 08:05:16 INFO - '--xperf_path', 08:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:16 INFO - 'tests': ['tp5n']}, 08:05:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:16 INFO - 'talos_options': ['--xperf_path', 08:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:16 INFO - 'tests': ['tp5n']}}, 08:05:16 INFO - 'talos.zip': {'path': '', 08:05:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:16 INFO - Running post-action listener: _resource_record_post_action 08:05:16 INFO - ##### 08:05:16 INFO - ##### Finished populate-webroot step (success) 08:05:16 INFO - ##### 08:05:16 INFO - ##### 08:05:16 INFO - ##### Running create-virtualenv step. 08:05:16 INFO - ##### 08:05:16 INFO - Running pre-action listener: _resource_record_pre_action 08:05:16 INFO - Running main action method: create_virtualenv 08:05:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:16 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 08:05:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:16 INFO - Using real prefix '/usr' 08:05:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:19 INFO - Installing pip.................done. 08:05:19 INFO - Return code: 0 08:05:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:19 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')]} 08:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 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')]} 08:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 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 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:19 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 08:05:19 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 08:05:19 INFO - Using env: {'DISPLAY': ':0', 08:05:19 INFO - 'HOME': '/home/cltbld', 08:05:19 INFO - 'LANG': 'en_US.UTF-8', 08:05:19 INFO - 'LANGUAGE': 'en_US:en', 08:05:19 INFO - 'LOGNAME': 'cltbld', 08:05:19 INFO - 'MAIL': '/var/mail/cltbld', 08:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:19 INFO - 'MOZ_NO_REMOTE': '1', 08:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:19 INFO - 'NO_EM_RESTART': '1', 08:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:19 INFO - 'PWD': '/builds/slave/test', 08:05:19 INFO - 'SHELL': '/bin/bash', 08:05:19 INFO - 'SHLVL': '1', 08:05:19 INFO - 'TERM': 'linux', 08:05:19 INFO - 'TMOUT': '86400', 08:05:19 INFO - 'USER': 'cltbld', 08:05:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:19 INFO - '_': '/tools/buildbot/bin/python'} 08:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:19 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 08:05:19 INFO - Cleaning up... 08:05:19 INFO - Return code: 0 08:05:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:19 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')]} 08:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 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')]} 08:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:19 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>=3.1.1'] in /builds/slave/test/build 08:05:19 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>=3.1.1 08:05:19 INFO - Using env: {'DISPLAY': ':0', 08:05:19 INFO - 'HOME': '/home/cltbld', 08:05:19 INFO - 'LANG': 'en_US.UTF-8', 08:05:19 INFO - 'LANGUAGE': 'en_US:en', 08:05:19 INFO - 'LOGNAME': 'cltbld', 08:05:19 INFO - 'MAIL': '/var/mail/cltbld', 08:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:19 INFO - 'MOZ_NO_REMOTE': '1', 08:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:19 INFO - 'NO_EM_RESTART': '1', 08:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:19 INFO - 'PWD': '/builds/slave/test', 08:05:19 INFO - 'SHELL': '/bin/bash', 08:05:19 INFO - 'SHLVL': '1', 08:05:19 INFO - 'TERM': 'linux', 08:05:19 INFO - 'TMOUT': '86400', 08:05:19 INFO - 'USER': 'cltbld', 08:05:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:19 INFO - '_': '/tools/buildbot/bin/python'} 08:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:19 INFO - Downloading/unpacking psutil>=3.1.1 08:05:19 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 08:05:19 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 08:05:19 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 08:05:19 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 08:05:19 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 08:05:19 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 08:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:21 INFO - Installing collected packages: psutil 08:05:21 INFO - Running setup.py install for psutil 08:05:21 INFO - building 'psutil._psutil_linux' extension 08:05:21 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 08:05:21 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 08:05:21 INFO - building 'psutil._psutil_posix' extension 08:05:21 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 08:05:22 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 08:05:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:22 INFO - Successfully installed psutil 08:05:22 INFO - Cleaning up... 08:05:22 INFO - Return code: 0 08:05:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:22 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')]} 08:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:22 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')]} 08:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:22 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:22 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.3'] in /builds/slave/test/build 08:05:22 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.3 08:05:22 INFO - Using env: {'DISPLAY': ':0', 08:05:22 INFO - 'HOME': '/home/cltbld', 08:05:22 INFO - 'LANG': 'en_US.UTF-8', 08:05:22 INFO - 'LANGUAGE': 'en_US:en', 08:05:22 INFO - 'LOGNAME': 'cltbld', 08:05:22 INFO - 'MAIL': '/var/mail/cltbld', 08:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:22 INFO - 'MOZ_NO_REMOTE': '1', 08:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:22 INFO - 'NO_EM_RESTART': '1', 08:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:22 INFO - 'PWD': '/builds/slave/test', 08:05:22 INFO - 'SHELL': '/bin/bash', 08:05:22 INFO - 'SHLVL': '1', 08:05:22 INFO - 'TERM': 'linux', 08:05:22 INFO - 'TMOUT': '86400', 08:05:22 INFO - 'USER': 'cltbld', 08:05:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:22 INFO - '_': '/tools/buildbot/bin/python'} 08:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:24 INFO - Installing collected packages: mozsystemmonitor 08:05:24 INFO - Running setup.py install for mozsystemmonitor 08:05:24 INFO - Successfully installed mozsystemmonitor 08:05:24 INFO - Cleaning up... 08:05:24 INFO - Return code: 0 08:05:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:05:24 INFO - Using env: {'DISPLAY': ':0', 08:05:24 INFO - 'HOME': '/home/cltbld', 08:05:24 INFO - 'LANG': 'en_US.UTF-8', 08:05:24 INFO - 'LANGUAGE': 'en_US:en', 08:05:24 INFO - 'LOGNAME': 'cltbld', 08:05:24 INFO - 'MAIL': '/var/mail/cltbld', 08:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:24 INFO - 'MOZ_NO_REMOTE': '1', 08:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:24 INFO - 'NO_EM_RESTART': '1', 08:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:24 INFO - 'PWD': '/builds/slave/test', 08:05:24 INFO - 'SHELL': '/bin/bash', 08:05:24 INFO - 'SHLVL': '1', 08:05:24 INFO - 'TERM': 'linux', 08:05:24 INFO - 'TMOUT': '86400', 08:05:24 INFO - 'USER': 'cltbld', 08:05:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:24 INFO - '_': '/tools/buildbot/bin/python'} 08:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:26 INFO - warning: no files found matching '*.txt' 08:05:26 INFO - no previously-included directories found matching 'build' 08:05:26 INFO - no previously-included directories found matching 'dist' 08:05:26 INFO - no previously-included directories found matching '.git*' 08:05:26 INFO - Installing collected packages: jsonschema, functools32 08:05:26 INFO - Running setup.py install for functools32 08:05:27 INFO - warning: no files found matching '*.txt' 08:05:27 INFO - no previously-included directories found matching 'build' 08:05:27 INFO - no previously-included directories found matching 'dist' 08:05:27 INFO - no previously-included directories found matching '.git*' 08:05:27 INFO - Successfully installed jsonschema functools32 08:05:27 INFO - Cleaning up... 08:05:27 INFO - Return code: 0 08:05:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:05:27 INFO - Using env: {'DISPLAY': ':0', 08:05:27 INFO - 'HOME': '/home/cltbld', 08:05:27 INFO - 'LANG': 'en_US.UTF-8', 08:05:27 INFO - 'LANGUAGE': 'en_US:en', 08:05:27 INFO - 'LOGNAME': 'cltbld', 08:05:27 INFO - 'MAIL': '/var/mail/cltbld', 08:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:27 INFO - 'MOZ_NO_REMOTE': '1', 08:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:27 INFO - 'NO_EM_RESTART': '1', 08:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:27 INFO - 'PWD': '/builds/slave/test', 08:05:27 INFO - 'SHELL': '/bin/bash', 08:05:27 INFO - 'SHLVL': '1', 08:05:27 INFO - 'TERM': 'linux', 08:05:27 INFO - 'TMOUT': '86400', 08:05:27 INFO - 'USER': 'cltbld', 08:05:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:27 INFO - '_': '/tools/buildbot/bin/python'} 08:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:29 INFO - Downloading docopt-0.6.1.tar.gz 08:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:29 INFO - Running setup.py install for blobuploader 08:05:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:30 INFO - Running setup.py install for requests 08:05:30 INFO - Running setup.py install for docopt 08:05:30 INFO - Successfully installed blobuploader requests docopt 08:05:30 INFO - Cleaning up... 08:05:30 INFO - Return code: 0 08:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:30 INFO - Using env: {'DISPLAY': ':0', 08:05:30 INFO - 'HOME': '/home/cltbld', 08:05:30 INFO - 'LANG': 'en_US.UTF-8', 08:05:30 INFO - 'LANGUAGE': 'en_US:en', 08:05:30 INFO - 'LOGNAME': 'cltbld', 08:05:30 INFO - 'MAIL': '/var/mail/cltbld', 08:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:30 INFO - 'MOZ_NO_REMOTE': '1', 08:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:30 INFO - 'NO_EM_RESTART': '1', 08:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:30 INFO - 'PWD': '/builds/slave/test', 08:05:30 INFO - 'SHELL': '/bin/bash', 08:05:30 INFO - 'SHLVL': '1', 08:05:30 INFO - 'TERM': 'linux', 08:05:30 INFO - 'TMOUT': '86400', 08:05:30 INFO - 'USER': 'cltbld', 08:05:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:30 INFO - '_': '/tools/buildbot/bin/python'} 08:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:30 INFO - Running setup.py (path:/tmp/pip-Nog9l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:30 INFO - Running setup.py (path:/tmp/pip-bKtE2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:30 INFO - Running setup.py (path:/tmp/pip-uF6WhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:31 INFO - Running setup.py (path:/tmp/pip-fNvtz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:31 INFO - Running setup.py (path:/tmp/pip-E6BNz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:31 INFO - Running setup.py (path:/tmp/pip-HlyU8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:31 INFO - Running setup.py (path:/tmp/pip-p00LP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:31 INFO - Running setup.py (path:/tmp/pip-tan3QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:31 INFO - Running setup.py (path:/tmp/pip-Vfwa_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:31 INFO - Running setup.py (path:/tmp/pip-O_NHaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:31 INFO - Running setup.py (path:/tmp/pip-ES5VmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:31 INFO - Running setup.py (path:/tmp/pip-PV0Q10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:31 INFO - Running setup.py (path:/tmp/pip-AXLbtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:31 INFO - Running setup.py (path:/tmp/pip-AETX7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:31 INFO - Running setup.py (path:/tmp/pip-3Hhzl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:31 INFO - Running setup.py (path:/tmp/pip-Vl81wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:31 INFO - Running setup.py (path:/tmp/pip-uXrUbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:32 INFO - Running setup.py install for manifestparser 08:05:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Running setup.py install for mozcrash 08:05:32 INFO - Running setup.py install for mozdebug 08:05:32 INFO - Running setup.py install for mozdevice 08:05:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Running setup.py install for mozfile 08:05:32 INFO - Running setup.py install for mozhttpd 08:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Running setup.py install for mozinfo 08:05:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Running setup.py install for mozInstall 08:05:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Running setup.py install for mozleak 08:05:32 INFO - Running setup.py install for mozlog 08:05:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for moznetwork 08:05:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for mozprocess 08:05:33 INFO - Running setup.py install for mozprofile 08:05:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for mozrunner 08:05:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for mozscreenshot 08:05:33 INFO - Running setup.py install for moztest 08:05:33 INFO - Running setup.py install for mozversion 08:05:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:33 INFO - Cleaning up... 08:05:33 INFO - Return code: 0 08:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:33 INFO - Using env: {'DISPLAY': ':0', 08:05:33 INFO - 'HOME': '/home/cltbld', 08:05:33 INFO - 'LANG': 'en_US.UTF-8', 08:05:33 INFO - 'LANGUAGE': 'en_US:en', 08:05:33 INFO - 'LOGNAME': 'cltbld', 08:05:33 INFO - 'MAIL': '/var/mail/cltbld', 08:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:33 INFO - 'MOZ_NO_REMOTE': '1', 08:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:33 INFO - 'NO_EM_RESTART': '1', 08:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:33 INFO - 'PWD': '/builds/slave/test', 08:05:33 INFO - 'SHELL': '/bin/bash', 08:05:33 INFO - 'SHLVL': '1', 08:05:33 INFO - 'TERM': 'linux', 08:05:33 INFO - 'TMOUT': '86400', 08:05:33 INFO - 'USER': 'cltbld', 08:05:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:33 INFO - '_': '/tools/buildbot/bin/python'} 08:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:34 INFO - Running setup.py (path:/tmp/pip-tdf_RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:34 INFO - Running setup.py (path:/tmp/pip-SFLA6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:34 INFO - Running setup.py (path:/tmp/pip-e8tXp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:34 INFO - Running setup.py (path:/tmp/pip-cx0W2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:34 INFO - Running setup.py (path:/tmp/pip-jZfema-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:34 INFO - Running setup.py (path:/tmp/pip-MmNpet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:34 INFO - Running setup.py (path:/tmp/pip-YkbTov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:34 INFO - Running setup.py (path:/tmp/pip-LZqWgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:34 INFO - Running setup.py (path:/tmp/pip-xypLdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:34 INFO - Running setup.py (path:/tmp/pip-ig90Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:34 INFO - Running setup.py (path:/tmp/pip-qGQLIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:34 INFO - Running setup.py (path:/tmp/pip-MrWNcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:34 INFO - Running setup.py (path:/tmp/pip-oD5PS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:34 INFO - Running setup.py (path:/tmp/pip-0RDHmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:35 INFO - Running setup.py (path:/tmp/pip-Z0y6lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:35 INFO - Running setup.py (path:/tmp/pip-VgjBrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:35 INFO - Running setup.py (path:/tmp/pip-JsqSwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:37 INFO - Downloading blessings-1.6.tar.gz 08:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:37 INFO - Installing collected packages: blessings 08:05:37 INFO - Running setup.py install for blessings 08:05:37 INFO - Successfully installed blessings 08:05:37 INFO - Cleaning up... 08:05:37 INFO - Return code: 0 08:05:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:37 INFO - Reading from file tmpfile_stdout 08:05:37 INFO - Current package versions: 08:05:37 INFO - argparse == 1.2.1 08:05:37 INFO - blessings == 1.6 08:05:37 INFO - blobuploader == 1.2.4 08:05:37 INFO - docopt == 0.6.1 08:05:37 INFO - functools32 == 3.2.3-2 08:05:37 INFO - jsonschema == 2.5.1 08:05:37 INFO - manifestparser == 1.1 08:05:37 INFO - mozInstall == 1.12 08:05:37 INFO - mozcrash == 0.17 08:05:37 INFO - mozdebug == 0.1 08:05:37 INFO - mozdevice == 0.48 08:05:37 INFO - mozfile == 1.2 08:05:37 INFO - mozhttpd == 0.7 08:05:37 INFO - mozinfo == 0.9 08:05:37 INFO - mozleak == 0.1 08:05:37 INFO - mozlog == 3.2 08:05:37 INFO - moznetwork == 0.27 08:05:37 INFO - mozprocess == 0.22 08:05:37 INFO - mozprofile == 0.28 08:05:37 INFO - mozrunner == 6.11 08:05:37 INFO - mozscreenshot == 0.1 08:05:37 INFO - mozsystemmonitor == 0.3 08:05:37 INFO - moztest == 0.7 08:05:37 INFO - mozversion == 1.4 08:05:37 INFO - psutil == 3.1.1 08:05:37 INFO - requests == 1.2.3 08:05:37 INFO - wsgiref == 0.1.2 08:05:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:37 INFO - Using env: {'DISPLAY': ':0', 08:05:37 INFO - 'HOME': '/home/cltbld', 08:05:37 INFO - 'LANG': 'en_US.UTF-8', 08:05:37 INFO - 'LANGUAGE': 'en_US:en', 08:05:37 INFO - 'LOGNAME': 'cltbld', 08:05:37 INFO - 'MAIL': '/var/mail/cltbld', 08:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:37 INFO - 'MOZ_NO_REMOTE': '1', 08:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:37 INFO - 'NO_EM_RESTART': '1', 08:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:37 INFO - 'PWD': '/builds/slave/test', 08:05:37 INFO - 'SHELL': '/bin/bash', 08:05:37 INFO - 'SHLVL': '1', 08:05:37 INFO - 'TERM': 'linux', 08:05:37 INFO - 'TMOUT': '86400', 08:05:37 INFO - 'USER': 'cltbld', 08:05:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:37 INFO - '_': '/tools/buildbot/bin/python'} 08:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:37 INFO - Cleaning up... 08:05:37 INFO - Return code: 0 08:05:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:05:37 INFO - Using env: {'DISPLAY': ':0', 08:05:37 INFO - 'HOME': '/home/cltbld', 08:05:37 INFO - 'LANG': 'en_US.UTF-8', 08:05:37 INFO - 'LANGUAGE': 'en_US:en', 08:05:37 INFO - 'LOGNAME': 'cltbld', 08:05:37 INFO - 'MAIL': '/var/mail/cltbld', 08:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:37 INFO - 'MOZ_NO_REMOTE': '1', 08:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:37 INFO - 'NO_EM_RESTART': '1', 08:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:37 INFO - 'PWD': '/builds/slave/test', 08:05:37 INFO - 'SHELL': '/bin/bash', 08:05:37 INFO - 'SHLVL': '1', 08:05:37 INFO - 'TERM': 'linux', 08:05:37 INFO - 'TMOUT': '86400', 08:05:37 INFO - 'USER': 'cltbld', 08:05:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:37 INFO - '_': '/tools/buildbot/bin/python'} 08:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:38 INFO - Cleaning up... 08:05:38 INFO - Return code: 0 08:05:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cb01c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b77350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', '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 08:05: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', 'flake8'] in /builds/slave/test/build 08:05: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 flake8 08:05:38 INFO - Using env: {'DISPLAY': ':0', 08:05:38 INFO - 'HOME': '/home/cltbld', 08:05:38 INFO - 'LANG': 'en_US.UTF-8', 08:05:38 INFO - 'LANGUAGE': 'en_US:en', 08:05:38 INFO - 'LOGNAME': 'cltbld', 08:05:38 INFO - 'MAIL': '/var/mail/cltbld', 08:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:38 INFO - 'MOZ_NO_REMOTE': '1', 08:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:38 INFO - 'NO_EM_RESTART': '1', 08:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:38 INFO - 'PWD': '/builds/slave/test', 08:05:38 INFO - 'SHELL': '/bin/bash', 08:05:38 INFO - 'SHLVL': '1', 08:05:38 INFO - 'TERM': 'linux', 08:05:38 INFO - 'TMOUT': '86400', 08:05:38 INFO - 'USER': 'cltbld', 08:05:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:38 INFO - '_': '/tools/buildbot/bin/python'} 08:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:38 INFO - Downloading/unpacking flake8 08:05:38 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 08:05:38 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 08:05:38 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 08:05:38 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 08:05:38 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 08:05:38 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 08:05:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:05:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:05:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:05:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:40 INFO - no previously-included directories found matching 'docs/_build' 08:05:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:05:40 INFO - Running setup.py install for pep8 08:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:41 INFO - no previously-included directories found matching 'docs/_build' 08:05:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:05:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:05:41 INFO - Cleaning up... 08:05:41 INFO - Return code: 0 08:05:41 INFO - Running post-action listener: _resource_record_post_action 08:05:41 INFO - Running post-action listener: _start_resource_monitoring 08:05:41 INFO - Starting resource monitoring. 08:05:41 INFO - ##### 08:05:41 INFO - ##### Finished create-virtualenv step (success) 08:05:41 INFO - ##### 08:05:41 INFO - ##### 08:05:41 INFO - ##### Running install step. 08:05:41 INFO - ##### 08:05:41 INFO - Running pre-action listener: _resource_record_pre_action 08:05:41 INFO - Running main action method: install 08:05:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:41 INFO - Reading from file tmpfile_stdout 08:05:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:41 INFO - Reading from file tmpfile_stdout 08:05:41 INFO - Output received: 08:05:41 INFO - Usage: mozinstall [options] installer 08:05:41 INFO - Options: 08:05:41 INFO - -h, --help show this help message and exit 08:05:41 INFO - -d DEST, --destination=DEST 08:05:41 INFO - Directory to install application into. [default: 08:05:41 INFO - "/builds/slave/test"] 08:05:41 INFO - --app=APP Application being installed. [default: firefox] 08:05:41 INFO - mkdir: /builds/slave/test/build/application 08:05:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:05:58 INFO - Reading from file tmpfile_stdout 08:05:58 INFO - Output received: 08:05:58 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:58 INFO - Running post-action listener: _resource_record_post_action 08:05:58 INFO - ##### 08:05:58 INFO - ##### Finished install step (success) 08:05:58 INFO - ##### 08:05:58 INFO - ##### 08:05:58 INFO - ##### Running run-tests step. 08:05:58 INFO - ##### 08:05:58 INFO - Running pre-action listener: _resource_record_pre_action 08:05:58 INFO - Running main action method: run_tests 08:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:58 INFO - Python 2.7.3 08:05:58 INFO - Return code: 0 08:05:58 INFO - grabbing minidump binary from tooltool 08:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c061c0>, '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 0x2c070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c07550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:58 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 08:05:58 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 08:05:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:05:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:58 INFO - Return code: 0 08:05:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:05:59 INFO - Return code: 0 08:05:59 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 08:05:59 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 08:05:59 INFO - Using env: {'DISPLAY': ':0', 08:05:59 INFO - 'HOME': '/home/cltbld', 08:05:59 INFO - 'LANG': 'en_US.UTF-8', 08:05:59 INFO - 'LANGUAGE': 'en_US:en', 08:05:59 INFO - 'LOGNAME': 'cltbld', 08:05:59 INFO - 'MAIL': '/var/mail/cltbld', 08:05:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:59 INFO - 'MOZ_NO_REMOTE': '1', 08:05:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:59 INFO - 'NO_EM_RESTART': '1', 08:05:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:59 INFO - 'PWD': '/builds/slave/test', 08:05:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:59 INFO - 'SHELL': '/bin/bash', 08:05:59 INFO - 'SHLVL': '1', 08:05:59 INFO - 'TERM': 'linux', 08:05:59 INFO - 'TMOUT': '86400', 08:05:59 INFO - 'USER': 'cltbld', 08:05:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758', 08:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:59 INFO - '_': '/tools/buildbot/bin/python'} 08:05:59 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/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 08:05:59 INFO - mozversion application_buildid: 20160620053002 08:05:59 INFO - mozversion application_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 08:05:59 INFO - mozversion application_display_name: Nightly 08:05:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:59 INFO - mozversion application_name: Firefox 08:05:59 INFO - mozversion application_remotingname: firefox 08:05:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:05:59 INFO - mozversion application_vendor: Mozilla 08:05:59 INFO - mozversion application_version: 50.0a1 08:05:59 INFO - mozversion platform_buildid: 20160620053002 08:05:59 INFO - mozversion platform_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 08:05:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:05:59 INFO - mozversion platform_version: 50.0a1 08:05:59 INFO - using testdate: 1466435159 08:05:59 INFO - actual date: 1466435159 08:05:59 INFO - starting webserver on 'localhost:58581' 08:05:59 INFO - SUITE-START | Running 2 tests 08:05:59 INFO - TEST-START | dromaeo_css 08:05:59 INFO - operating with platform_type : linux_ 08:05:59 INFO - Initialising browser for dromaeo_css test... 08:05:59 INFO - TEST-INFO | started process 29626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8SrqE/profile http://localhost:58581/getInfo.html) 08:06:03 INFO - PROCESS | 29626 | __metrics Screen width/height:1600/1200 08:06:03 INFO - PROCESS | 29626 | colorDepth:24 08:06:03 INFO - PROCESS | 29626 | Browser inner width/height: 1024/697 08:06:03 INFO - PROCESS | 29626 | __metrics 08:06:04 INFO - PROCESS | 29626 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:05 INFO - TEST-INFO | 29626: exit 0 08:06:05 INFO - Browser initialized. 08:06:05 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:05 INFO - TEST-INFO | started process 29707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8SrqE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:17 INFO - PROCESS | 29707 | RSS: Main: 174055424 08:06:17 INFO - PROCESS | 29707 | 08:07:09 INFO - PROCESS | 29707 | 1466435229503 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] 08:09:17 INFO - PROCESS | 29707 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58581/tests/dromaeo/cssquery-ext.html) 08:09:18 INFO - PROCESS | 29707 | RSS: Main: 301326336 08:09:18 INFO - PROCESS | 29707 | 08:12:20 INFO - PROCESS | 29707 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-ext.html (next: http://localhost:58581/tests/dromaeo/cssquery-jquery.html) 08:12:21 INFO - PROCESS | 29707 | RSS: Main: 261840896 08:12:21 INFO - PROCESS | 29707 | 08:15:23 INFO - PROCESS | 29707 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58581/tests/dromaeo/cssquery-mootools.html) 08:15:24 INFO - PROCESS | 29707 | RSS: Main: 256356352 08:15:24 INFO - PROCESS | 29707 | 08:18:26 INFO - PROCESS | 29707 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58581/tests/dromaeo/cssquery-prototype.html) 08:18:26 INFO - PROCESS | 29707 | RSS: Main: 255406080 08:18:26 INFO - PROCESS | 29707 | 08:21:29 INFO - PROCESS | 29707 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58581/tests/dromaeo/cssquery-yui.html) 08:21:29 INFO - PROCESS | 29707 | RSS: Main: 231096320 08:21:29 INFO - PROCESS | 29707 | 08:24:32 INFO - PROCESS | 29707 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-yui.html (next: http://localhost:58581/tests/dromaeo/cssquery-dojo.html) 08:24:33 INFO - PROCESS | 29707 | RSS: Main: 288854016 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - PROCESS | 29707 | __start_tp_report 08:24:33 INFO - PROCESS | 29707 | _x_x_mozilla_page_load 08:24:33 INFO - PROCESS | 29707 | _x_x_mozilla_page_load_details 08:24:33 INFO - PROCESS | 29707 | |i|pagename|runs| 08:24:33 INFO - PROCESS | 29707 | |0;dojo.html;3067.4478593853105;3080.8151510909347;3096.6748491408403;3144.135362775238;3162.2094476380903;5312.973435132823;5326.6537675051195;5388.946110538894;5426.430224826396;5474.91787623186;5431.076716958117;5475.288212532375;5477.67133971962;5512.724363781815;5542.63972841765;4872.049950259692;4955.876103097416;4966.528179822911;4989.600831933455;5187.118189907725;5090.338256026711;5106.106431374513;5149.948500515003;5163.483651634844;5168.508991645806;4858.878528036792;4884.511548845105;4935.210366341404;4960.975195124038;5008.424031236382;4922.26166075088;5034.421041580192;5044.772985215674;5053.343065401475;5083.415407228179;4907.705537667715;4933.136701077297;4939.234418665113;4960.032793605248;5020.49795020495;5360.59795515334;5413.918791218095;5417.945820541783;5492.423295553989;5501;5921.200637913913;5945.64326140433;5961.612495187799;5969.940300596982;5973.761049558012;5929.525637948954;5964.522838172979;5989.071693887455;5991.430814072656;6014.0377539593455;5371.785128594852;5416.1063424534905;5503.779848806083;5510.6969116698565;5525.778968841241;6056.5336200331285;6059.611540412359;6062.783849877691;6095.872263631242;6115.052166914135;5798.768049278066;5832.8541786454825;5843.5325173985975;5846.210761547137;5848.093545500455;5678.744456499468;5801.216835727123;5845.473907348274;5846.444587764156;5934.287885453773;5816.709164541756;5848.970755146197;5861.853453663693;5862.384449632812;5869.735861886225;5826.359100498942;5838.299404071538;5839.941600584025;5841.2990441146485;5884.176215329857;4376.890577735582;4391.824327026947;4395.1429471252795;4417.514073451917;4428.025834316445;3883.0486530800135;3890.630390112935;3897.0452239201577;3928.155446578999;3933.6263055009726;5498.670079795225;5508.834734957958;5510.393856675762;5513.696746678971;5516.089845175501;5743.195952566644;5776.971115144397;5803.535717142703;5810.593258471867;5821.76712931478;5500.889982200333;5502.944970550323;5508.669479831223;5511.311086114236;5514.944850551443;4927.975360123177;4980.078685443204;4980.402351717817;4982.559553048251;5039.798408063636;5892.086726557391;5944.346121926585;5948.762049518057;6012.699365031731;6064.878702425926;5862.355140934408;5870.853228669317;5871.588988770745;5882.764619429797;5954.136650185612;5876.647401155944;6086.117512960507;6091.756329746938;6095.725692343766;6101.633901965896;5719.8570035749435;5745.339285981999;5755.53955683536;5798.913016304843;5807.477327040587;5858.648481091148;5894.646321220741;5909.6158749681135;5920.437558431942;5926.970365148147;5565.16522521625;5648.71756412186;5764.36591974874;5766.509846663081;5766.711664416678;5598.580106491948;5616.1856530803625;5642.943570564242;5651.2935883014625;5652.265205523256;5557.833265002057;5563.388027316911;5564.081926482247;5566.860828479158;5567.805126820542;5539.25220095282;5586.52514536269;5661.320641523043;5709.029464991045;5725.198472213977;5617.9719101404235;5620.775168993195;5640.351359593699;5649.20911072442;5677.77288908439 08:24:33 INFO - PROCESS | 29707 | |1;ext.html;587.8324677466923;627.6798832595376;627.8618703885144;629.9716512756926;646.6605032358011;29228.999999999975;40839;42120.57879421205;42160.945976350566;42363;43123;43505;43545.91135221621;43551;43656.56343436565;8638.740837774862;8776.07851175627;8779.95610021949;8780.64877404903;8794.03265640779;8852.424592401505;8934.553272336358;8959.462432254086;8961.462312261285;8963.775905602346;9000.14498622633;9031;9035.548222588877;9039.64405339201;9040.09599040094;8946.329025323093;8978.281737460988;8991.055939126363;9021.097890210993;9056.818863622757;8904.821903561957;8965.103489651048;8971.237444817198;8976.012638609747;8980.191782739585;41668.79165604183;41910;41967.58032419667;42038.57961420377;42067.57932420667;3384.7969121852766;3472.774269672463;3596.1728802375337;3978.9403158952637;4175.645070169039;31797.52303715446;32567.51148732771;32837.17907052343;32875.835620821745;33210.83394583036;4378.321360189176;4398.3842262083335;4436.911261774746;4458.152950939344;4567.063751930879;234625;234738;235261;235321;235753;55316.72341638266;55388.723056385264;55594;55908.16137757937;55975.44024559702;53600.83590387156;57589.13616295759;59074.704626477454;59122.408775912554;64070.35929640644;14280.500547442369;14309.856901430852;14413.351399187062;14436.855631443552;14468.493602723855;10541.051305382553;10556.366618002945;10565;10577.84133238002;10644.414557199429;15225.6193595161;16522.173891305385;16969.133395326506;17012.829871701124;17113.743293850603;6258.624482531062;6333.714982825784;6366.649834259068;6395.840103997344;6443.838904027343;930.418488444722;970.8883478400074;1047.2093569355088;1068.2308737708838;1092.3882625729616;29666.406671866444;31289.217769555944;31294.374112517624;31695.659533790586;31698.524522132186;1054.8206804843196;1064.435849000031;1094.698957786599;1125.6397952655236;1129.9661010169707;16112.838871611368;16526.504204873872;16527.33890644361;16831.158442078093;16956.660866782597;502909;504322;505518;506986;510340;56441;56599.71700141473;56612.43387566154;56619;56653.716731416076;1300.4213125159213;1316.8551459339465;1328.130074801007;1330.3946704249543;1339.1362571141754;29646.703532965257;31154.532682009336;31191.532127018567;31414.685853141174;31939.520907185946;47728.2840757382;47781.76109119432;47871.5212847881;47979.28031079467;48073;443358;447118;447618;447694;447876;24926;27086.1874143776;27758.44483110286;28202.71797282001;28206.294842629097;46883.76558117187;47023.52976470192;48066.75966620145;51341;52441.7377913108;39060;39886;40830.387544187455;41510.79244603758;41527.792361038;37484.812575938035;39703.40444893271;39972;40652.18695626012;41001.53990760564;39649;40300.79849600733;40429.1914161721;41194.38208426936;41376.1724765509;35640.28719425649;36056.4591531122;36984.63015369812;37382.813085935486;37437.43843842399;27950.72049279481;28482;28539.42921141524;28668.283292917844;28671.426571468037 08:24:33 INFO - PROCESS | 29707 | |2;jquery.html;382.79903050898264;390.14363472178565;392.6995848176148;396.3381153473699;406.9470968774059;14143.151410915352;16159.353625854981;18281.54296142597;20042.89978550107;20087.09608067637;14497.710045799104;17507.562310942234;17872.731909021375;17998.730019049726;18679.252829886787;5513.558915286788;5525.171224316345;5571.415001424853;5719.19931209631;5749.568782341341;4087.12126892718;5615.438456154393;5636.323641163066;5679.062954612484;5971.970140149293;6290.528210384216;6352.110704501373;6367.172267605205;6377.362263773632;6381.840453988664;6141.232345956755;6267.843303917393;6289.433950944437;6332.1135041094285;6353.364663533633;5451.127819548893;5470.425605311465;5474.863128421782;5476.096444086721;5495.890082198373;21625.35123946284;21802.236921707823;22766.54466910669;23115;23172.420689482897;2173.9565208695735;2339.4385347516645;2470.629405589158;2920.19694583989;3058.709422604849;7383.07711536058;7448.180700122982;13561.118527295794;13697.726045479134;13879;1852.6850435425874;1921.6829223178158;1963.2637760839684;1965.8329042031444;2054.4658388818866;78928.21071789267;81528.59235703843;81769.59115204445;82099.17900820976;82836;10145.847812282822;10454.947725261478;10482.895171048192;10560.630377936735;10642.148628109733;14377.424903003972;14449.060811047248;14522.709545809235;14845.109293442212;14846.40614375413;6647.900281495685;7063.505554611128;7867.449278550561;8033.55815430157;8229.094799572042;6942.652867356612;6972.442204623618;7260.092488438945;7380.520266182681;7551.73568925085;6325.240971083499;6508.837279068061;6578.407943285128;6609.603423794491;6614.437772789367;1888.5467487803103;1899.7530321058175;1918.4820098573587;1921.9615607687767;1926.7074124438932;432.6863024307352;910.1444642036597;1043.1498328861953;1099.923005389631;1112.7830073135822;11117.55529778816;11742.823857642143;11865.762684746429;11966.042716582653;12167.2699638022;464.8768076459741;468.15965342210814;475.18980138863157;479.04908756119073;484.9248366503198;6340.461060809883;6420.646864422408;6436.549441539141;6482.319356467598;6548.345165483509;534497;535246;540547;549667;554104;73637.63181184059;90884.5455772717;91267;91398.54300728453;92175.07824921799;473.143610065782;478.19901664712165;479.20452049597503;479.4462395932703;480.31315219236825;10820.17289915557;10973.670789876316;11000.449977501254;11105;11177.161712871404;31966.84016579902;38651.80674096724;38832.223355532165;40589.59410405976;40784.388234175916;58588.41411585829;59475.40524594699;59758.701206493686;59902.101468477136;61435.69282153561;8501.14988501145;8675.262602678842;8695.347848911484;8863.246624037029;8889.19997200255;12269.57056503018;12966.416511256828;13391.799123013358;13818.86181138216;14134.717305654034;11449.942750286194;11608.709782255173;11902.166848320534;11910.404479775803;12200.328981906081;11625.18623696367;11691.181617286707;11753.177277590486;11766.764664706487;11954.103442241692;11826.58606948787;11995.880041199825;12042.157049006835;12294.262344259372;12306.507739690313;7393.593352365457;7697.846043079219;7721.112072111779;8738.737837864874;8795.692150774692;8713;10766.676999690022;11333.603323883624;11528.423578820857;11708 08:24:33 INFO - PROCESS | 29707 | |3;mootools.html;1278.50138446006;1411.8305803303606;1445.1834713386936;1538.3769573322802;1712.8287171282866;8289.461185022978;8573.356998225134;8607.35444841637;8960;8962.865557016634;8632.438891472066;8790.428622139556;8797.1202879712;8823.867641985375;8839.425437346568;2261.5589959957815;2275.943101422469;2287.885605719716;2288.7711228877147;2290.80528155107;2282.7260728712577;2292.839501234914;2327.44141406063;2346.307839187435;2347.0259842165483;2313.7223533175957;2321.3268152235833;2344.847584906984;2346.2609278077352;2346.894389752465;2250.054976909702;2251.200823707593;2270.4096934796908;2273.5111950930464;2274.545090981802;2255.3121298004103;2259.2883241778786;2269.341890851651;2275.97724022761;2277.1119263487253;8564.914350856474;8768.649254029831;8899.510526921016;8904.109589041043;8925.509096999662;5180.067587834188;5295.602829787781;5298.337707786527;5304.36347638282;5305.867353316198;3304.4217261979056;3319.867205311785;3347.44767113426;3375.6961873431264;3391.101358140095;1136.6817291158488;1186.341580422865;1195.8206269059624;1196.1985469735298;1205.0781152418408;12264.938675306656;12325.198862073936;12351.135420520568;12368.690782730413;12380.319082450551;4440.533743956903;4450.577195166454;4561.543845615412;4581.335706322631;4581.587657110809;9615.759606009766;9617.951910240545;9633.662821801343;9636.71089867305;9646.758831029281;5033.723145226974;5113.463086375951;5138.511841375063;5145.22821576759;5151.8196863109615;4291.6566674665955;4415.845445409395;4655.51117132703;4683.063387322549;4822.397200349957;3701.056230661164;3711.109333759878;3792.639699228569;3807.828647710804;3894.4742459768136;1097.8572785537829;1111.2776695148057;1117.5753213778712;1118.9146527867956;1125.0212315285753;770.3836930455614;909.2316992141762;950.5959967013991;960.1502670136979;997.8303688372849;6124.35694252106;6146.78486252979;6230.6884655767935;6394.424501794861;6395.232572091379;943.8206740719241;960.1262850805733;978.1978777402462;979.7158823940978;983.537737263485;4280.892977675583;4388.736675799462;4399.186150562156;4403.009322902385;4414.668899832525;10984.286021408583;11223.214374993835;11267.774644507228;11311.717207069725;11342.149338799458;10313.639022634172;10759.677209683721;10786.784264314827;11222.214444988773;11222.719432014264;8189.590520473953;8375.539345336065;8376.706815261437;8377.413581049268;8379.790505237295;6220.284667263141;6463.192100987377;6471.902921456276;6513.478921686348;6533.771318003847;10122.898771012196;10431;10434.269601127848;10518.896220755727;10616.416097114425;10530.57877684884;10590.311629744043;10644;10718.89281107179;10750.46247687628;7162.319579639926;7540.359069479156;7689.269519395649;7752.418568607264;7901.446898717035;8757.956210218908;8777.122287771172;8844.425112367675;8850.38047336706;8865.68970086044;7473.327400533761;7529.134149572869;7620.885686714814;7663;7689.461737678309;7171;7231.204567497466;7325.7435989742235;7402.629868506661;7427.22014188524;6867.862642747017;6940.167179938439;6967.338102880219;6970.756023539152;6975.267596902252;5063.670861393997;5070.822521211888;5163.3545806774155;5227.18978558324;5271.604629652868;5279.208118782213;5349.358077030781;5368.8389348319615;5460.071787796005;5515.889682206413 08:24:33 INFO - PROCESS | 29707 | |4;prototype.html;312.8779775887404;330.4514505920173;330.6676789826224;331.6948407465132;335.1236516509328;5243.318368612085;5325.387580428252;5373.731313434332;5376.247325374446;5401.3248343957;5277.841664750054;5294.41761406245;5311.867203319919;5330.413654498012;5347.438518955502;4141.275276826544;4141.544430112693;4145.440365550642;4156.97921510392;4164.250434921728;3965.286248475273;4015.5783642717533;4104.897377565555;4136.296829538986;4138.751674899516;4042.393640953851;4081.3877918312196;4084.305668036441;4088.1823635272917;4100.876973690794;3903.33643280643;4109.260333140033;4110.588941105895;4111.177764447122;4117.464729585135;3520.7887526748477;3565.607783143852;3587.3542762302777;3596.5324507813816;3604.837782299777;5032.47159048302;5081.872953176163;5090.643654944155;5110.495857030066;5174.275601415805;4550.431196100488;4652.464966528859;4656.4412270527755;4671.813127474897;4693.6010439112715;5467.824417750163;5492.725363731797;5499.092649712833;5511.9724401378135;5543.695096769717;3952.664023558001;3959.1883663848844;3959.920801583981;3974.3641017437362;3980.920381592352;5431.945680543223;5718.142278658193;5720.71396430181;5757.280339957505;5765.481106700375;3942.9014274643364;3962.841486340514;3977.3039718049804;3988.4814974053766;3992.321305378093;3996.3406038003986;4004.4593979812353;4012.9398059028554;4016.216837716676;4043.1509383029893;4640.164770341304;4655;4658.58072773452;4662.370579971728;4665.160271151225;5300.204969254565;5467.972660136754;5470.64440811346;5522.984110799529;5581.274434323594;1392.331680793225;1396.525181438316;1410.9435622575188;1421.971560568783;1429.306786208688;870.3168013109679;907.3648446087765;911.8039621481281;920.4569304110607;920.9217216536535;4853.199222128309;5182.222666600041;5203.100868183086;5368.4568184997715;5416.106342453451;5705.087186050212;5724.542036637059;5725.282415275401;5731.828045158652;5735.311762588516;5140;5346.34263378354;5364.22218778275;5432.777625034336;5434.157705555645;2996.5916019470815;3011.3525591997827;3014.3669829335645;3018.852835922379;3035.7723170762283;5782.392848750905;5783.624064435799;5799.710014499258;5826.883462330729;5843.737031833578;5525.613207075547;5795.797596913146;5812.186293918855;5922.940770592239;5924;5797.391273916262;5842.298924129132;5847.44449277318;5922.822315330547;5925.377835327315;5568.415316391883;5753.1370294456165;5809.36097029318;5828.222392170259;5830.912536311874;5685.60200785941;5693.9430605693415;5702.971485142548;5705.144228365778;5715.342735585461;5861.9413805861395;5882.999890018793;5929.851753706192;5934.982106083952;5941.405859414024;4016.477857878457;4045.5954404560484;4080.7961651313526;4112.9588704112575;4134.565870583546;5652.823662889735;5761.279840019997;5772.113943028486;5775.971120144372;5780.450857168562;5583.55331573465;5593.524550413261;5652.738904438258;5654.15187721845;5659.151127330933;5318.7074710891275;5546.278983732089;5556;5589.385167631639;5596.86007849807;5494.450554944474;5502.119660854404;5506.705924107911;5527.39198688152;5530.115181570929;5432.158015507603;5515.806946756844;5614.045612245846;5621.381648018633;5668.348139963957;5450.836474905759;5467.7266136692215;5475.178723191553;5491.176323551499;5505.146702261156 08:24:33 INFO - PROCESS | 29707 | |5;yui.html;685.9382655561002;690.544240801071;724.1000682553341;741.6217728958236;747.8018325143837;14633.634159146013;15709.84290157098;15858.048517088953;16024.519264422072;16258.268377922992;14295;14365.497207597737;14488.637784055403;14491.202983835885;14500.564983050524;642.1363266406676;746.3730466408216;766.306492624176;775.9689612415497;776.1850057439694;770.3067239484453;781.1719577248107;781.4178437064367;781.6365390093605;781.8279978404742;800.5997001499251;811.5090370325956;812.4800127918137;812.6383759227117;813.0162503370899;672.3746915368705;778.5173192620555;802.2699343597299;804.8712206047034;805.6414895371562;585.5374254339067;586.2203269651353;586.3052283044606;586.3462239602812;586.357938057826;13047.478100875953;13061.608151755463;13094.803577946339;13173.209607423585;13194.802077968838;13094;13370.799438008438;14018.43926242949;14695.191764452951;14930.62673433162;11646.558475676864;11709.473073711704;11821.408929553574;11864.110191735654;11934.22427542207;4386.407834942273;4448.911021779579;4479.73121612701;4488.775561221926;4491.820327186909;77993.32040077614;78589.60705196552;78846.60576697138;81008.59495702543;81514.59242703748;11552.711182220512;11574.247673901169;11619.0704743622;11625.418729063513;11690.298582085103;21363.786362136492;21383.57232855365;21389.35831925045;21405.143794248055;21406.464838379165;7997.080335761346;8015.879761803578;8121.715739949073;8131.14622964592;8279.751607451786;4350.912981740411;4397.259317621957;4425.938008975418;4450.043240703264;4547.204239258117;3205.6634053424523;3304.0913748718813;3305.2563173285816;3305.6033276007033;3306.272620023639;570.13624359096;574.1445246582646;577.3995045152993;578.8408187748319;585.157373382328;568.6701713006446;585.429206523636;624.893768059431;650.6681592387916;652.6964961292927;9766.46284454362;9782.657606983721;9976.501174941224;10082.941291164469;10610.57557697699;568.3180183779481;583.9678817664984;632.1118828046602;699.9475039371965;717.9784606461815;4650.604698600657;4858.8785280367565;5082.644214904995;5112.744362781846;5318.388385335658;119122.40438797751;119287;121404.39297803455;122185;122915.38542307231;106648;108257;108417;109308;110712.4464377673;77240.61379693066;96439.51780241194;97397.5130124359;97978.51010744901;98724.50637746765;9431.905680943102;9767.316287859781;10420.68737937863;10689.89310106889;10750.408727520062;43141.352879707454;50894.745526272134;51276;51621;51914.74042629914;50191;67464.3253567458;67910.66044669745;77832;78170.6091469539;12796.872031279569;13571.321433928462;13688.52090176839;13755;13786.310684465938;14395.712085758436;14791.92604036973;15045.774313385527;15993.920030399773;16013.839861601235;14410.567682969528;14583.489577864724;14669.339879705225;14726;15641.217939103228;13765.174089554659;13936.4425422986;13947.860521394656;14755.188464634548;14780.113193208443;12816.6795830105;13100.737985240432;13145.408456619283;13696.794548081587;13770.862291376958;11198.944005280247;11256.831147532957;11486;11648.184627076023;11699.06407487416;12135.332556709465;12403.813942790684;12502.812457813323;12686.175398599062;12714.936425317814 08:24:33 INFO - PROCESS | 29707 | __end_tp_report 08:24:33 INFO - PROCESS | 29707 | __start_cc_report 08:24:33 INFO - PROCESS | 29707 | _x_x_mozilla_cycle_collect,1117 08:24:33 INFO - PROCESS | 29707 | __end_cc_report 08:24:33 INFO - PROCESS | 29707 | __startTimestamp1466436273001__endTimestamp 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - PROCESS | 29707 | ------- Summary: start ------- 08:24:33 INFO - PROCESS | 29707 | Number of tests: 6 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - PROCESS | 29707 | [#0] dojo.html Cycles:165 Average:5428.82 Median:5586.53 stddev:634.58 (11.4%) stddev-sans-first:608.89 08:24:33 INFO - PROCESS | 29707 | Values: 3067.4 3080.8 3096.7 3144.1 3162.2 5313.0 5326.7 5388.9 5426.4 5474.9 5431.1 5475.3 5477.7 5512.7 5542.6 4872.0 4955.9 4966.5 4989.6 5187.1 5090.3 5106.1 5149.9 5163.5 5168.5 4858.9 4884.5 4935.2 4961.0 5008.4 4922.3 5034.4 5044.8 5053.3 5083.4 4907.7 4933.1 4939.2 4960.0 5020.5 5360.6 5413.9 5417.9 5492.4 5501.0 5921.2 5945.6 5961.6 5969.9 5973.8 5929.5 5964.5 5989.1 5991.4 6014.0 5371.8 5416.1 5503.8 5510.7 5525.8 6056.5 6059.6 6062.8 6095.9 6115.1 5798.8 5832.9 5843.5 5846.2 5848.1 5678.7 5801.2 5845.5 5846.4 5934.3 5816.7 5849.0 5861.9 5862.4 5869.7 5826.4 5838.3 5839.9 5841.3 5884.2 4376.9 4391.8 4395.1 4417.5 4428.0 3883.0 3890.6 3897.0 3928.2 3933.6 5498.7 5508.8 5510.4 5513.7 5516.1 5743.2 5777.0 5803.5 5810.6 5821.8 5500.9 5502.9 5508.7 5511.3 5514.9 4928.0 4980.1 4980.4 4982.6 5039.8 5892.1 5944.3 5948.8 6012.7 6064.9 5862.4 5870.9 5871.6 5882.8 5954.1 5876.6 6086.1 6091.8 6095.7 6101.6 5719.9 5745.3 5755.5 5798.9 5807.5 5858.6 5894.6 5909.6 5920.4 5927.0 5565.2 5648.7 5764.4 5766.5 5766.7 5598.6 5616.2 5642.9 5651.3 5652.3 5557.8 5563.4 5564.1 5566.9 5567.8 5539.3 5586.5 5661.3 5709.0 5725.2 5618.0 5620.8 5640.4 5649.2 5677.8 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - PROCESS | 29707 | [#1] ext.html Cycles:180 Average:55837.34 Median:23042.82 stddev:109658.82 (475.9%) stddev-sans-first:109887.98 08:24:33 INFO - PROCESS | 29707 | Values: 587.8 627.7 627.9 630.0 646.7 29229.0 40839.0 42120.6 42160.9 42363.0 43123.0 43505.0 43545.9 43551.0 43656.6 8638.7 8776.1 8780.0 8780.6 8794.0 8852.4 8934.6 8959.5 8961.5 8963.8 9000.1 9031.0 9035.5 9039.6 9040.1 8946.3 8978.3 8991.1 9021.1 9056.8 8904.8 8965.1 8971.2 8976.0 8980.2 41668.8 41910.0 41967.6 42038.6 42067.6 3384.8 3472.8 3596.2 3978.9 4175.6 31797.5 32567.5 32837.2 32875.8 33210.8 4378.3 4398.4 4436.9 4458.2 4567.1 234625.0 234738.0 235261.0 235321.0 235753.0 55316.7 55388.7 55594.0 55908.2 55975.4 53600.8 57589.1 59074.7 59122.4 64070.4 14280.5 14309.9 14413.4 14436.9 14468.5 10541.1 10556.4 10565.0 10577.8 10644.4 15225.6 16522.2 16969.1 17012.8 17113.7 6258.6 6333.7 6366.6 6395.8 6443.8 930.4 970.9 1047.2 1068.2 1092.4 29666.4 31289.2 31294.4 31695.7 31698.5 1054.8 1064.4 1094.7 1125.6 1130.0 16112.8 16526.5 16527.3 16831.2 16956.7 502909.0 504322.0 505518.0 506986.0 510340.0 56441.0 56599.7 56612.4 56619.0 56653.7 1300.4 1316.9 1328.1 1330.4 1339.1 29646.7 31154.5 31191.5 31414.7 31939.5 47728.3 47781.8 47871.5 47979.3 48073.0 443358.0 447118.0 447618.0 447694.0 447876.0 24926.0 27086.2 27758.4 28202.7 28206.3 46883.8 47023.5 48066.8 51341.0 52441.7 39060.0 39886.0 40830.4 41510.8 41527.8 37484.8 39703.4 39972.0 40652.2 41001.5 39649.0 40300.8 40429.2 41194.4 41376.2 35640.3 36056.5 36984.6 37382.8 37437.4 27950.7 28482.0 28539.4 28668.3 28671.4 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - PROCESS | 29707 | [#2] jquery.html Cycles:180 Average:29691.64 Median:2259.90 stddev:89303.71 (3951.7%) stddev-sans-first:89527.11 08:24:33 INFO - PROCESS | 29707 | Values: 382.8 390.1 392.7 396.3 406.9 14143.2 16159.4 18281.5 20042.9 20087.1 14497.7 17507.6 17872.7 17998.7 18679.3 5513.6 5525.2 5571.4 5719.2 5749.6 4087.1 5615.4 5636.3 5679.1 5972.0 6290.5 6352.1 6367.2 6377.4 6381.8 6141.2 6267.8 6289.4 6332.1 6353.4 5451.1 5470.4 5474.9 5476.1 5495.9 21625.4 21802.2 22766.5 23115.0 23172.4 2174.0 2339.4 2470.6 2920.2 3058.7 7383.1 7448.2 13561.1 13697.7 13879.0 1852.7 1921.7 1963.3 1965.8 2054.5 78928.2 81528.6 81769.6 82099.2 82836.0 10145.8 10454.9 10482.9 10560.6 10642.1 14377.4 14449.1 14522.7 14845.1 14846.4 6647.9 7063.5 7867.4 8033.6 8229.1 6942.7 6972.4 7260.1 7380.5 7551.7 6325.2 6508.8 6578.4 6609.6 6614.4 1888.5 1899.8 1918.5 1922.0 1926.7 432.7 910.1 1043.1 1099.9 1112.8 11117.6 11742.8 11865.8 11966.0 12167.3 464.9 468.2 475.2 479.0 484.9 6340.5 6420.6 6436.5 6482.3 6548.3 534497.0 535246.0 540547.0 549667.0 554104.0 73637.6 90884.5 91267.0 91398.5 92175.1 473.1 478.2 479.2 479.4 480.3 10820.2 10973.7 11000.4 11105.0 11177.2 31966.8 38651.8 38832.2 40589.6 40784.4 58588.4 59475.4 59758.7 59902.1 61435.7 8501.1 8675.3 8695.3 8863.2 8889.2 12269.6 12966.4 13391.8 13818.9 14134.7 11449.9 11608.7 11902.2 11910.4 12200.3 11625.2 11691.2 11753.2 11766.8 11954.1 11826.6 11995.9 12042.2 12294.3 12306.5 7393.6 7697.8 7721.1 8738.7 8795.7 8713.0 10766.7 11333.6 11528.4 11708.0 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - PROCESS | 29707 | [#3] mootools.html Cycles:180 Average:5816.43 Median:5048.70 stddev:3332.11 (66.0%) stddev-sans-first:3324.00 08:24:33 INFO - PROCESS | 29707 | Values: 1278.5 1411.8 1445.2 1538.4 1712.8 8289.5 8573.4 8607.4 8960.0 8962.9 8632.4 8790.4 8797.1 8823.9 8839.4 2261.6 2275.9 2287.9 2288.8 2290.8 2282.7 2292.8 2327.4 2346.3 2347.0 2313.7 2321.3 2344.8 2346.3 2346.9 2250.1 2251.2 2270.4 2273.5 2274.5 2255.3 2259.3 2269.3 2276.0 2277.1 8564.9 8768.6 8899.5 8904.1 8925.5 5180.1 5295.6 5298.3 5304.4 5305.9 3304.4 3319.9 3347.4 3375.7 3391.1 1136.7 1186.3 1195.8 1196.2 1205.1 12264.9 12325.2 12351.1 12368.7 12380.3 4440.5 4450.6 4561.5 4581.3 4581.6 9615.8 9618.0 9633.7 9636.7 9646.8 5033.7 5113.5 5138.5 5145.2 5151.8 4291.7 4415.8 4655.5 4683.1 4822.4 3701.1 3711.1 3792.6 3807.8 3894.5 1097.9 1111.3 1117.6 1118.9 1125.0 770.4 909.2 950.6 960.2 997.8 6124.4 6146.8 6230.7 6394.4 6395.2 943.8 960.1 978.2 979.7 983.5 4280.9 4388.7 4399.2 4403.0 4414.7 10984.3 11223.2 11267.8 11311.7 11342.1 10313.6 10759.7 10786.8 11222.2 11222.7 8189.6 8375.5 8376.7 8377.4 8379.8 6220.3 6463.2 6471.9 6513.5 6533.8 10122.9 10431.0 10434.3 10518.9 10616.4 10530.6 10590.3 10644.0 10718.9 10750.5 7162.3 7540.4 7689.3 7752.4 7901.4 8758.0 8777.1 8844.4 8850.4 8865.7 7473.3 7529.1 7620.9 7663.0 7689.5 7171.0 7231.2 7325.7 7402.6 7427.2 6867.9 6940.2 6967.3 6970.8 6975.3 5063.7 5070.8 5163.4 5227.2 5271.6 5279.2 5349.4 5368.8 5460.1 5515.9 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - PROCESS | 29707 | [#4] prototype.html Cycles:180 Average:4664.29 Median:5371.09 stddev:1386.75 (25.8%) stddev-sans-first:1351.63 08:24:33 INFO - PROCESS | 29707 | Values: 312.9 330.5 330.7 331.7 335.1 5243.3 5325.4 5373.7 5376.2 5401.3 5277.8 5294.4 5311.9 5330.4 5347.4 4141.3 4141.5 4145.4 4157.0 4164.3 3965.3 4015.6 4104.9 4136.3 4138.8 4042.4 4081.4 4084.3 4088.2 4100.9 3903.3 4109.3 4110.6 4111.2 4117.5 3520.8 3565.6 3587.4 3596.5 3604.8 5032.5 5081.9 5090.6 5110.5 5174.3 4550.4 4652.5 4656.4 4671.8 4693.6 5467.8 5492.7 5499.1 5512.0 5543.7 3952.7 3959.2 3959.9 3974.4 3980.9 5431.9 5718.1 5720.7 5757.3 5765.5 3942.9 3962.8 3977.3 3988.5 3992.3 3996.3 4004.5 4012.9 4016.2 4043.2 4640.2 4655.0 4658.6 4662.4 4665.2 5300.2 5468.0 5470.6 5523.0 5581.3 1392.3 1396.5 1410.9 1422.0 1429.3 870.3 907.4 911.8 920.5 920.9 4853.2 5182.2 5203.1 5368.5 5416.1 5705.1 5724.5 5725.3 5731.8 5735.3 5140.0 5346.3 5364.2 5432.8 5434.2 2996.6 3011.4 3014.4 3018.9 3035.8 5782.4 5783.6 5799.7 5826.9 5843.7 5525.6 5795.8 5812.2 5922.9 5924.0 5797.4 5842.3 5847.4 5922.8 5925.4 5568.4 5753.1 5809.4 5828.2 5830.9 5685.6 5693.9 5703.0 5705.1 5715.3 5861.9 5883.0 5929.9 5935.0 5941.4 4016.5 4045.6 4080.8 4113.0 4134.6 5652.8 5761.3 5772.1 5776.0 5780.5 5583.6 5593.5 5652.7 5654.2 5659.2 5318.7 5546.3 5556.0 5589.4 5596.9 5494.5 5502.1 5506.7 5527.4 5530.1 5432.2 5515.8 5614.0 5621.4 5668.3 5450.8 5467.7 5475.2 5491.2 5505.1 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - PROCESS | 29707 | [#5] yui.html Cycles:180 Average:21383.14 Median:23746.13 stddev:31540.20 (132.8%) stddev-sans-first:31590.40 08:24:33 INFO - PROCESS | 29707 | Values: 685.9 690.5 724.1 741.6 747.8 14633.6 15709.8 15858.0 16024.5 16258.3 14295.0 14365.5 14488.6 14491.2 14500.6 642.1 746.4 766.3 776.0 776.2 770.3 781.2 781.4 781.6 781.8 800.6 811.5 812.5 812.6 813.0 672.4 778.5 802.3 804.9 805.6 585.5 586.2 586.3 586.3 586.4 13047.5 13061.6 13094.8 13173.2 13194.8 13094.0 13370.8 14018.4 14695.2 14930.6 11646.6 11709.5 11821.4 11864.1 11934.2 4386.4 4448.9 4479.7 4488.8 4491.8 77993.3 78589.6 78846.6 81008.6 81514.6 11552.7 11574.2 11619.1 11625.4 11690.3 21363.8 21383.6 21389.4 21405.1 21406.5 7997.1 8015.9 8121.7 8131.1 8279.8 4350.9 4397.3 4425.9 4450.0 4547.2 3205.7 3304.1 3305.3 3305.6 3306.3 570.1 574.1 577.4 578.8 585.2 568.7 585.4 624.9 650.7 652.7 9766.5 9782.7 9976.5 10082.9 10610.6 568.3 584.0 632.1 699.9 718.0 4650.6 4858.9 5082.6 5112.7 5318.4 119122.4 119287.0 121404.4 122185.0 122915.4 106648.0 108257.0 108417.0 109308.0 110712.4 77240.6 96439.5 97397.5 97978.5 98724.5 9431.9 9767.3 10420.7 10689.9 10750.4 43141.4 50894.7 51276.0 51621.0 51914.7 50191.0 67464.3 67910.7 77832.0 78170.6 12796.9 13571.3 13688.5 13755.0 13786.3 14395.7 14791.9 15045.8 15993.9 16013.8 14410.6 14583.5 14669.3 14726.0 15641.2 13765.2 13936.4 13947.9 14755.2 14780.1 12816.7 13100.7 13145.4 13696.8 13770.9 11198.9 11256.8 11486.0 11648.2 11699.1 12135.3 12403.8 12502.8 12686.2 12714.9 08:24:33 INFO - PROCESS | 29707 | -------- Summary: end -------- 08:24:33 INFO - PROCESS | 29707 | 08:24:33 INFO - TEST-INFO | 29707: exit 0 08:24:33 INFO - TEST-OK | dromaeo_css | took 1114075ms 08:24:33 INFO - TEST-START | kraken 08:24:33 INFO - operating with platform_type : linux_ 08:24:33 INFO - Initialising browser for kraken test... 08:24:33 INFO - TEST-INFO | started process 29895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9lgbBI/profile http://localhost:58581/getInfo.html) 08:24:37 INFO - PROCESS | 29895 | __metrics Screen width/height:1600/1200 08:24:37 INFO - PROCESS | 29895 | colorDepth:24 08:24:37 INFO - PROCESS | 29895 | Browser inner width/height: 1024/697 08:24:37 INFO - PROCESS | 29895 | __metrics 08:24:38 INFO - PROCESS | 29895 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:39 INFO - TEST-INFO | 29895: exit 0 08:24:39 INFO - Browser initialized. 08:24:39 INFO - Running cycle 1/1 for kraken test... 08:24:39 INFO - TEST-INFO | started process 29977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9lgbBI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:51 INFO - PROCESS | 29977 | RSS: Main: 173789184 08:24:51 INFO - PROCESS | 29977 | 08:24:54 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58581/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:55 INFO - PROCESS | 29977 | RSS: Main: 232873984 08:24:55 INFO - PROCESS | 29977 | 08:24:57 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58581/tests/kraken/driver.html?testName=audio-dft) 08:24:58 INFO - PROCESS | 29977 | RSS: Main: 220778496 08:24:58 INFO - PROCESS | 29977 | 08:25:01 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58581/tests/kraken/driver.html?testName=audio-fft) 08:25:02 INFO - PROCESS | 29977 | RSS: Main: 286420992 08:25:02 INFO - PROCESS | 29977 | 08:25:04 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58581/tests/kraken/driver.html?testName=audio-oscillator) 08:25:04 INFO - PROCESS | 29977 | RSS: Main: 197832704 08:25:04 INFO - PROCESS | 29977 | 08:25:06 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:07 INFO - PROCESS | 29977 | RSS: Main: 201859072 08:25:07 INFO - PROCESS | 29977 | 08:25:10 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58581/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:11 INFO - PROCESS | 29977 | RSS: Main: 237973504 08:25:11 INFO - PROCESS | 29977 | 08:25:14 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58581/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:15 INFO - PROCESS | 29977 | RSS: Main: 238243840 08:25:15 INFO - PROCESS | 29977 | 08:25:17 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58581/tests/kraken/driver.html?testName=json-parse-financial) 08:25:18 INFO - PROCESS | 29977 | RSS: Main: 239104000 08:25:18 INFO - PROCESS | 29977 | 08:25:20 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:20 INFO - PROCESS | 29977 | RSS: Main: 228114432 08:25:20 INFO - PROCESS | 29977 | 08:25:22 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:23 INFO - PROCESS | 29977 | RSS: Main: 229351424 08:25:23 INFO - PROCESS | 29977 | 08:25:25 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:25 INFO - PROCESS | 29977 | RSS: Main: 238444544 08:25:25 INFO - PROCESS | 29977 | 08:25:28 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:28 INFO - PROCESS | 29977 | RSS: Main: 241639424 08:25:28 INFO - PROCESS | 29977 | 08:25:31 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:32 INFO - PROCESS | 29977 | RSS: Main: 239276032 08:25:32 INFO - PROCESS | 29977 | 08:25:33 INFO - PROCESS | 29977 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58581/tests/kraken/driver.html?testName=ai-astar) 08:25:34 INFO - PROCESS | 29977 | RSS: Main: 282050560 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | __start_tp_report 08:25:34 INFO - PROCESS | 29977 | _x_x_mozilla_page_load 08:25:34 INFO - PROCESS | 29977 | _x_x_mozilla_page_load_details 08:25:34 INFO - PROCESS | 29977 | |i|pagename|runs| 08:25:34 INFO - PROCESS | 29977 | |0;ai-astar;113;105;109;110;112;113;113;110;109;109 08:25:34 INFO - PROCESS | 29977 | |1;audio-beat-detection;158;125;127;180;130;126;149;131;159;143 08:25:34 INFO - PROCESS | 29977 | |2;audio-dft;161;163;163;162;159;161;161;162;162;161 08:25:34 INFO - PROCESS | 29977 | |3;audio-fft;75;74;76;115;75;76;73;74;100;76 08:25:34 INFO - PROCESS | 29977 | |4;audio-oscillator;84;86;107;84;86;86;127;87;88;125 08:25:34 INFO - PROCESS | 29977 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 08:25:34 INFO - PROCESS | 29977 | |6;imaging-darkroom;146;145;145;145;146;145;147;146;146;145 08:25:34 INFO - PROCESS | 29977 | |7;imaging-desaturate;95;95;94;94;95;95;94;95;95;95 08:25:34 INFO - PROCESS | 29977 | |8;json-parse-financial;55;54;53;54;55;54;54;55;55;54 08:25:34 INFO - PROCESS | 29977 | |9;json-stringify-tinderbox;62;63;61;62;62;61;61;61;66;62 08:25:34 INFO - PROCESS | 29977 | |10;stanford-crypto-aes;83;81;78;78;79;81;86;80;120;85 08:25:34 INFO - PROCESS | 29977 | |11;stanford-crypto-ccm;122;130;121;128;127;122;121;131;129;128 08:25:34 INFO - PROCESS | 29977 | |12;stanford-crypto-pbkdf2;160;158;160;161;160;159;162;161;159;157 08:25:34 INFO - PROCESS | 29977 | |13;stanford-crypto-sha256-iterative;63;62;64;63;64;64;62;62;65;62 08:25:34 INFO - PROCESS | 29977 | __end_tp_report 08:25:34 INFO - PROCESS | 29977 | __start_cc_report 08:25:34 INFO - PROCESS | 29977 | _x_x_mozilla_cycle_collect,1631 08:25:34 INFO - PROCESS | 29977 | __end_cc_report 08:25:34 INFO - PROCESS | 29977 | __startTimestamp1466436334095__endTimestamp 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | ------- Summary: start ------- 08:25:34 INFO - PROCESS | 29977 | Number of tests: 14 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.54 (2.3%) stddev-sans-first:2.50 08:25:34 INFO - PROCESS | 29977 | Values: 113.0 105.0 109.0 110.0 112.0 113.0 113.0 110.0 109.0 109.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:146.00 stddev:18.46 (12.6%) stddev-sans-first:18.74 08:25:34 INFO - PROCESS | 29977 | Values: 158.0 125.0 127.0 180.0 130.0 126.0 149.0 131.0 159.0 143.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 08:25:34 INFO - PROCESS | 29977 | Values: 161.0 163.0 163.0 162.0 159.0 161.0 161.0 162.0 162.0 161.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.24 (19.0%) stddev-sans-first:14.91 08:25:34 INFO - PROCESS | 29977 | Values: 75.0 74.0 76.0 115.0 75.0 76.0 73.0 74.0 100.0 76.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:86.00 stddev:17.18 (20.0%) stddev-sans-first:17.66 08:25:34 INFO - PROCESS | 29977 | Values: 84.0 86.0 107.0 84.0 86.0 86.0 127.0 87.0 88.0 125.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:25:34 INFO - PROCESS | 29977 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:25:34 INFO - PROCESS | 29977 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 147.0 146.0 146.0 145.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:25:34 INFO - PROCESS | 29977 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 08:25:34 INFO - PROCESS | 29977 | Values: 55.0 54.0 53.0 54.0 55.0 54.0 54.0 55.0 55.0 54.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.52 (2.5%) stddev-sans-first:1.62 08:25:34 INFO - PROCESS | 29977 | Values: 62.0 63.0 61.0 62.0 62.0 61.0 61.0 61.0 66.0 62.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:81.00 stddev:12.56 (15.5%) stddev-sans-first:13.30 08:25:34 INFO - PROCESS | 29977 | Values: 83.0 81.0 78.0 78.0 79.0 81.0 86.0 80.0 120.0 85.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:128.00 stddev:3.96 (3.1%) stddev-sans-first:3.94 08:25:34 INFO - PROCESS | 29977 | Values: 122.0 130.0 121.0 128.0 127.0 122.0 121.0 131.0 129.0 128.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 08:25:34 INFO - PROCESS | 29977 | Values: 160.0 158.0 160.0 161.0 160.0 159.0 162.0 161.0 159.0 157.0 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - PROCESS | 29977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.10 (1.7%) stddev-sans-first:1.17 08:25:34 INFO - PROCESS | 29977 | Values: 63.0 62.0 64.0 63.0 64.0 64.0 62.0 62.0 65.0 62.0 08:25:34 INFO - PROCESS | 29977 | -------- Summary: end -------- 08:25:34 INFO - PROCESS | 29977 | 08:25:34 INFO - TEST-INFO | 29977: exit 0 08:25:35 INFO - TEST-OK | kraken | took 61290ms 08:25:35 INFO - SUITE-END | took 1175s 08:25:35 INFO - Completed test suite (00:19:35) 08:25:35 INFO - javascript benchmark 08:25:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.4478593853105, 3080.8151510909347, 3096.6748491408403, 3144.135362775238, 3162.2094476380903, 5312.973435132823, 5326.6537675051195, 5388.946110538894, 5426.430224826396, 5474.91787623186, 5431.076716958117, 5475.288212532375, 5477.67133971962, 5512.724363781815, 5542.63972841765, 4872.049950259692, 4955.876103097416, 4966.528179822911, 4989.600831933455, 5187.118189907725, 5090.338256026711, 5106.106431374513, 5149.948500515003, 5163.483651634844, 5168.508991645806, 4858.878528036792, 4884.511548845105, 4935.210366341404, 4960.975195124038, 5008.424031236382, 4922.26166075088, 5034.421041580192, 5044.772985215674, 5053.343065401475, 5083.415407228179, 4907.705537667715, 4933.136701077297, 4939.234418665113, 4960.032793605248, 5020.49795020495, 5360.59795515334, 5413.918791218095, 5417.945820541783, 5492.423295553989, 5501.0, 5921.200637913913, 5945.64326140433, 5961.612495187799, 5969.940300596982, 5973.761049558012, 5929.525637948954, 5964.522838172979, 5989.071693887455, 5991.430814072656, 6014.0377539593455, 5371.785128594852, 5416.1063424534905, 5503.779848806083, 5510.6969116698565, 5525.778968841241, 6056.5336200331285, 6059.611540412359, 6062.783849877691, 6095.872263631242, 6115.052166914135, 5798.768049278066, 5832.8541786454825, 5843.5325173985975, 5846.210761547137, 5848.093545500455, 5678.744456499468, 5801.216835727123, 5845.473907348274, 5846.444587764156, 5934.287885453773, 5816.709164541756, 5848.970755146197, 5861.853453663693, 5862.384449632812, 5869.735861886225, 5826.359100498942, 5838.299404071538, 5839.941600584025, 5841.2990441146485, 5884.176215329857, 4376.890577735582, 4391.824327026947, 4395.1429471252795, 4417.514073451917, 4428.025834316445, 3883.0486530800135, 3890.630390112935, 3897.0452239201577, 3928.155446578999, 3933.6263055009726, 5498.670079795225, 5508.834734957958, 5510.393856675762, 5513.696746678971, 5516.089845175501, 5743.195952566644, 5776.971115144397, 5803.535717142703, 5810.593258471867, 5821.76712931478, 5500.889982200333, 5502.944970550323, 5508.669479831223, 5511.311086114236, 5514.944850551443, 4927.975360123177, 4980.078685443204, 4980.402351717817, 4982.559553048251, 5039.798408063636, 5892.086726557391, 5944.346121926585, 5948.762049518057, 6012.699365031731, 6064.878702425926, 5862.355140934408, 5870.853228669317, 5871.588988770745, 5882.764619429797, 5954.136650185612, 5876.647401155944, 6086.117512960507, 6091.756329746938, 6095.725692343766, 6101.633901965896, 5719.8570035749435, 5745.339285981999, 5755.53955683536, 5798.913016304843, 5807.477327040587, 5858.648481091148, 5894.646321220741, 5909.6158749681135, 5920.437558431942, 5926.970365148147, 5565.16522521625, 5648.71756412186, 5764.36591974874, 5766.509846663081, 5766.711664416678, 5598.580106491948, 5616.1856530803625, 5642.943570564242, 5651.2935883014625, 5652.265205523256, 5557.833265002057, 5563.388027316911, 5564.081926482247, 5566.860828479158, 5567.805126820542, 5539.25220095282, 5586.52514536269, 5661.320641523043, 5709.029464991045, 5725.198472213977, 5617.9719101404235, 5620.775168993195, 5640.351359593699, 5649.20911072442, 5677.77288908439], "value": 5384.343130049531, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.8324677466923, 627.6798832595376, 627.8618703885144, 629.9716512756926, 646.6605032358011, 29228.999999999975, 40839.0, 42120.57879421205, 42160.945976350566, 42363.0, 43123.0, 43505.0, 43545.91135221621, 43551.0, 43656.56343436565, 8638.740837774862, 8776.07851175627, 8779.95610021949, 8780.64877404903, 8794.03265640779, 8852.424592401505, 8934.553272336358, 8959.462432254086, 8961.462312261285, 8963.775905602346, 9000.14498622633, 9031.0, 9035.548222588877, 9039.64405339201, 9040.09599040094, 8946.329025323093, 8978.281737460988, 8991.055939126363, 9021.097890210993, 9056.818863622757, 8904.821903561957, 8965.103489651048, 8971.237444817198, 8976.012638609747, 8980.191782739585, 41668.79165604183, 41910.0, 41967.58032419667, 42038.57961420377, 42067.57932420667, 3384.7969121852766, 3472.774269672463, 3596.1728802375337, 3978.9403158952637, 4175.645070169039, 31797.52303715446, 32567.51148732771, 32837.17907052343, 32875.835620821745, 33210.83394583036, 4378.321360189176, 4398.3842262083335, 4436.911261774746, 4458.152950939344, 4567.063751930879, 234625.0, 234738.0, 235261.0, 235321.0, 235753.0, 55316.72341638266, 55388.723056385264, 55594.0, 55908.16137757937, 55975.44024559702, 53600.83590387156, 57589.13616295759, 59074.704626477454, 59122.408775912554, 64070.35929640644, 14280.500547442369, 14309.856901430852, 14413.351399187062, 14436.855631443552, 14468.493602723855, 10541.051305382553, 10556.366618002945, 10565.0, 10577.84133238002, 10644.414557199429, 15225.6193595161, 16522.173891305385, 16969.133395326506, 17012.829871701124, 17113.743293850603, 6258.624482531062, 6333.714982825784, 6366.649834259068, 6395.840103997344, 6443.838904027343, 930.418488444722, 970.8883478400074, 1047.2093569355088, 1068.2308737708838, 1092.3882625729616, 29666.406671866444, 31289.217769555944, 31294.374112517624, 31695.659533790586, 31698.524522132186, 1054.8206804843196, 1064.435849000031, 1094.698957786599, 1125.6397952655236, 1129.9661010169707, 16112.838871611368, 16526.504204873872, 16527.33890644361, 16831.158442078093, 16956.660866782597, 502909.0, 504322.0, 505518.0, 506986.0, 510340.0, 56441.0, 56599.71700141473, 56612.43387566154, 56619.0, 56653.716731416076, 1300.4213125159213, 1316.8551459339465, 1328.130074801007, 1330.3946704249543, 1339.1362571141754, 29646.703532965257, 31154.532682009336, 31191.532127018567, 31414.685853141174, 31939.520907185946, 47728.2840757382, 47781.76109119432, 47871.5212847881, 47979.28031079467, 48073.0, 443358.0, 447118.0, 447618.0, 447694.0, 447876.0, 24926.0, 27086.1874143776, 27758.44483110286, 28202.71797282001, 28206.294842629097, 46883.76558117187, 47023.52976470192, 48066.75966620145, 51341.0, 52441.7377913108, 39060.0, 39886.0, 40830.387544187455, 41510.79244603758, 41527.792361038, 37484.812575938035, 39703.40444893271, 39972.0, 40652.18695626012, 41001.53990760564, 39649.0, 40300.79849600733, 40429.1914161721, 41194.38208426936, 41376.1724765509, 35640.28719425649, 36056.4591531122, 36984.63015369812, 37382.813085935486, 37437.43843842399, 27950.72049279481, 28482.0, 28539.42921141524, 28668.283292917844, 28671.426571468037], "value": 19392.942401073447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.79903050898264, 390.14363472178565, 392.6995848176148, 396.3381153473699, 406.9470968774059, 14143.151410915352, 16159.353625854981, 18281.54296142597, 20042.89978550107, 20087.09608067637, 14497.710045799104, 17507.562310942234, 17872.731909021375, 17998.730019049726, 18679.252829886787, 5513.558915286788, 5525.171224316345, 5571.415001424853, 5719.19931209631, 5749.568782341341, 4087.12126892718, 5615.438456154393, 5636.323641163066, 5679.062954612484, 5971.970140149293, 6290.528210384216, 6352.110704501373, 6367.172267605205, 6377.362263773632, 6381.840453988664, 6141.232345956755, 6267.843303917393, 6289.433950944437, 6332.1135041094285, 6353.364663533633, 5451.127819548893, 5470.425605311465, 5474.863128421782, 5476.096444086721, 5495.890082198373, 21625.35123946284, 21802.236921707823, 22766.54466910669, 23115.0, 23172.420689482897, 2173.9565208695735, 2339.4385347516645, 2470.629405589158, 2920.19694583989, 3058.709422604849, 7383.07711536058, 7448.180700122982, 13561.118527295794, 13697.726045479134, 13879.0, 1852.6850435425874, 1921.6829223178158, 1963.2637760839684, 1965.8329042031444, 2054.4658388818866, 78928.21071789267, 81528.59235703843, 81769.59115204445, 82099.17900820976, 82836.0, 10145.847812282822, 10454.947725261478, 10482.895171048192, 10560.630377936735, 10642.148628109733, 14377.424903003972, 14449.060811047248, 14522.709545809235, 14845.109293442212, 14846.40614375413, 6647.900281495685, 7063.505554611128, 7867.449278550561, 8033.55815430157, 8229.094799572042, 6942.652867356612, 6972.442204623618, 7260.092488438945, 7380.520266182681, 7551.73568925085, 6325.240971083499, 6508.837279068061, 6578.407943285128, 6609.603423794491, 6614.437772789367, 1888.5467487803103, 1899.7530321058175, 1918.4820098573587, 1921.9615607687767, 1926.7074124438932, 432.6863024307352, 910.1444642036597, 1043.1498328861953, 1099.923005389631, 1112.7830073135822, 11117.55529778816, 11742.823857642143, 11865.762684746429, 11966.042716582653, 12167.2699638022, 464.8768076459741, 468.15965342210814, 475.18980138863157, 479.04908756119073, 484.9248366503198, 6340.461060809883, 6420.646864422408, 6436.549441539141, 6482.319356467598, 6548.345165483509, 534497.0, 535246.0, 540547.0, 549667.0, 554104.0, 73637.63181184059, 90884.5455772717, 91267.0, 91398.54300728453, 92175.07824921799, 473.143610065782, 478.19901664712165, 479.20452049597503, 479.4462395932703, 480.31315219236825, 10820.17289915557, 10973.670789876316, 11000.449977501254, 11105.0, 11177.161712871404, 31966.84016579902, 38651.80674096724, 38832.223355532165, 40589.59410405976, 40784.388234175916, 58588.41411585829, 59475.40524594699, 59758.701206493686, 59902.101468477136, 61435.69282153561, 8501.14988501145, 8675.262602678842, 8695.347848911484, 8863.246624037029, 8889.19997200255, 12269.57056503018, 12966.416511256828, 13391.799123013358, 13818.86181138216, 14134.717305654034, 11449.942750286194, 11608.709782255173, 11902.166848320534, 11910.404479775803, 12200.328981906081, 11625.18623696367, 11691.181617286707, 11753.177277590486, 11766.764664706487, 11954.103442241692, 11826.58606948787, 11995.880041199825, 12042.157049006835, 12294.262344259372, 12306.507739690313, 7393.593352365457, 7697.846043079219, 7721.112072111779, 8738.737837864874, 8795.692150774692, 8713.0, 10766.676999690022, 11333.603323883624, 11528.423578820857, 11708.0], "value": 8495.042578189115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.50138446006, 1411.8305803303606, 1445.1834713386936, 1538.3769573322802, 1712.8287171282866, 8289.461185022978, 8573.356998225134, 8607.35444841637, 8960.0, 8962.865557016634, 8632.438891472066, 8790.428622139556, 8797.1202879712, 8823.867641985375, 8839.425437346568, 2261.5589959957815, 2275.943101422469, 2287.885605719716, 2288.7711228877147, 2290.80528155107, 2282.7260728712577, 2292.839501234914, 2327.44141406063, 2346.307839187435, 2347.0259842165483, 2313.7223533175957, 2321.3268152235833, 2344.847584906984, 2346.2609278077352, 2346.894389752465, 2250.054976909702, 2251.200823707593, 2270.4096934796908, 2273.5111950930464, 2274.545090981802, 2255.3121298004103, 2259.2883241778786, 2269.341890851651, 2275.97724022761, 2277.1119263487253, 8564.914350856474, 8768.649254029831, 8899.510526921016, 8904.109589041043, 8925.509096999662, 5180.067587834188, 5295.602829787781, 5298.337707786527, 5304.36347638282, 5305.867353316198, 3304.4217261979056, 3319.867205311785, 3347.44767113426, 3375.6961873431264, 3391.101358140095, 1136.6817291158488, 1186.341580422865, 1195.8206269059624, 1196.1985469735298, 1205.0781152418408, 12264.938675306656, 12325.198862073936, 12351.135420520568, 12368.690782730413, 12380.319082450551, 4440.533743956903, 4450.577195166454, 4561.543845615412, 4581.335706322631, 4581.587657110809, 9615.759606009766, 9617.951910240545, 9633.662821801343, 9636.71089867305, 9646.758831029281, 5033.723145226974, 5113.463086375951, 5138.511841375063, 5145.22821576759, 5151.8196863109615, 4291.6566674665955, 4415.845445409395, 4655.51117132703, 4683.063387322549, 4822.397200349957, 3701.056230661164, 3711.109333759878, 3792.639699228569, 3807.828647710804, 3894.4742459768136, 1097.8572785537829, 1111.2776695148057, 1117.5753213778712, 1118.9146527867956, 1125.0212315285753, 770.3836930455614, 909.2316992141762, 950.5959967013991, 960.1502670136979, 997.8303688372849, 6124.35694252106, 6146.78486252979, 6230.6884655767935, 6394.424501794861, 6395.232572091379, 943.8206740719241, 960.1262850805733, 978.1978777402462, 979.7158823940978, 983.537737263485, 4280.892977675583, 4388.736675799462, 4399.186150562156, 4403.009322902385, 4414.668899832525, 10984.286021408583, 11223.214374993835, 11267.774644507228, 11311.717207069725, 11342.149338799458, 10313.639022634172, 10759.677209683721, 10786.784264314827, 11222.214444988773, 11222.719432014264, 8189.590520473953, 8375.539345336065, 8376.706815261437, 8377.413581049268, 8379.790505237295, 6220.284667263141, 6463.192100987377, 6471.902921456276, 6513.478921686348, 6533.771318003847, 10122.898771012196, 10431.0, 10434.269601127848, 10518.896220755727, 10616.416097114425, 10530.57877684884, 10590.311629744043, 10644.0, 10718.89281107179, 10750.46247687628, 7162.319579639926, 7540.359069479156, 7689.269519395649, 7752.418568607264, 7901.446898717035, 8757.956210218908, 8777.122287771172, 8844.425112367675, 8850.38047336706, 8865.68970086044, 7473.327400533761, 7529.134149572869, 7620.885686714814, 7663.0, 7689.461737678309, 7171.0, 7231.204567497466, 7325.7435989742235, 7402.629868506661, 7427.22014188524, 6867.862642747017, 6940.167179938439, 6967.338102880219, 6970.756023539152, 6975.267596902252, 5063.670861393997, 5070.822521211888, 5163.3545806774155, 5227.18978558324, 5271.604629652868, 5279.208118782213, 5349.358077030781, 5368.8389348319615, 5460.071787796005, 5515.889682206413], "value": 4626.765783771945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8779775887404, 330.4514505920173, 330.6676789826224, 331.6948407465132, 335.1236516509328, 5243.318368612085, 5325.387580428252, 5373.731313434332, 5376.247325374446, 5401.3248343957, 5277.841664750054, 5294.41761406245, 5311.867203319919, 5330.413654498012, 5347.438518955502, 4141.275276826544, 4141.544430112693, 4145.440365550642, 4156.97921510392, 4164.250434921728, 3965.286248475273, 4015.5783642717533, 4104.897377565555, 4136.296829538986, 4138.751674899516, 4042.393640953851, 4081.3877918312196, 4084.305668036441, 4088.1823635272917, 4100.876973690794, 3903.33643280643, 4109.260333140033, 4110.588941105895, 4111.177764447122, 4117.464729585135, 3520.7887526748477, 3565.607783143852, 3587.3542762302777, 3596.5324507813816, 3604.837782299777, 5032.47159048302, 5081.872953176163, 5090.643654944155, 5110.495857030066, 5174.275601415805, 4550.431196100488, 4652.464966528859, 4656.4412270527755, 4671.813127474897, 4693.6010439112715, 5467.824417750163, 5492.725363731797, 5499.092649712833, 5511.9724401378135, 5543.695096769717, 3952.664023558001, 3959.1883663848844, 3959.920801583981, 3974.3641017437362, 3980.920381592352, 5431.945680543223, 5718.142278658193, 5720.71396430181, 5757.280339957505, 5765.481106700375, 3942.9014274643364, 3962.841486340514, 3977.3039718049804, 3988.4814974053766, 3992.321305378093, 3996.3406038003986, 4004.4593979812353, 4012.9398059028554, 4016.216837716676, 4043.1509383029893, 4640.164770341304, 4655.0, 4658.58072773452, 4662.370579971728, 4665.160271151225, 5300.204969254565, 5467.972660136754, 5470.64440811346, 5522.984110799529, 5581.274434323594, 1392.331680793225, 1396.525181438316, 1410.9435622575188, 1421.971560568783, 1429.306786208688, 870.3168013109679, 907.3648446087765, 911.8039621481281, 920.4569304110607, 920.9217216536535, 4853.199222128309, 5182.222666600041, 5203.100868183086, 5368.4568184997715, 5416.106342453451, 5705.087186050212, 5724.542036637059, 5725.282415275401, 5731.828045158652, 5735.311762588516, 5140.0, 5346.34263378354, 5364.22218778275, 5432.777625034336, 5434.157705555645, 2996.5916019470815, 3011.3525591997827, 3014.3669829335645, 3018.852835922379, 3035.7723170762283, 5782.392848750905, 5783.624064435799, 5799.710014499258, 5826.883462330729, 5843.737031833578, 5525.613207075547, 5795.797596913146, 5812.186293918855, 5922.940770592239, 5924.0, 5797.391273916262, 5842.298924129132, 5847.44449277318, 5922.822315330547, 5925.377835327315, 5568.415316391883, 5753.1370294456165, 5809.36097029318, 5828.222392170259, 5830.912536311874, 5685.60200785941, 5693.9430605693415, 5702.971485142548, 5705.144228365778, 5715.342735585461, 5861.9413805861395, 5882.999890018793, 5929.851753706192, 5934.982106083952, 5941.405859414024, 4016.477857878457, 4045.5954404560484, 4080.7961651313526, 4112.9588704112575, 4134.565870583546, 5652.823662889735, 5761.279840019997, 5772.113943028486, 5775.971120144372, 5780.450857168562, 5583.55331573465, 5593.524550413261, 5652.738904438258, 5654.15187721845, 5659.151127330933, 5318.7074710891275, 5546.278983732089, 5556.0, 5589.385167631639, 5596.86007849807, 5494.450554944474, 5502.119660854404, 5506.705924107911, 5527.39198688152, 5530.115181570929, 5432.158015507603, 5515.806946756844, 5614.045612245846, 5621.381648018633, 5668.348139963957, 5450.836474905759, 5467.7266136692215, 5475.178723191553, 5491.176323551499, 5505.146702261156], "value": 4219.002469745513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.9382655561002, 690.544240801071, 724.1000682553341, 741.6217728958236, 747.8018325143837, 14633.634159146013, 15709.84290157098, 15858.048517088953, 16024.519264422072, 16258.268377922992, 14295.0, 14365.497207597737, 14488.637784055403, 14491.202983835885, 14500.564983050524, 642.1363266406676, 746.3730466408216, 766.306492624176, 775.9689612415497, 776.1850057439694, 770.3067239484453, 781.1719577248107, 781.4178437064367, 781.6365390093605, 781.8279978404742, 800.5997001499251, 811.5090370325956, 812.4800127918137, 812.6383759227117, 813.0162503370899, 672.3746915368705, 778.5173192620555, 802.2699343597299, 804.8712206047034, 805.6414895371562, 585.5374254339067, 586.2203269651353, 586.3052283044606, 586.3462239602812, 586.357938057826, 13047.478100875953, 13061.608151755463, 13094.803577946339, 13173.209607423585, 13194.802077968838, 13094.0, 13370.799438008438, 14018.43926242949, 14695.191764452951, 14930.62673433162, 11646.558475676864, 11709.473073711704, 11821.408929553574, 11864.110191735654, 11934.22427542207, 4386.407834942273, 4448.911021779579, 4479.73121612701, 4488.775561221926, 4491.820327186909, 77993.32040077614, 78589.60705196552, 78846.60576697138, 81008.59495702543, 81514.59242703748, 11552.711182220512, 11574.247673901169, 11619.0704743622, 11625.418729063513, 11690.298582085103, 21363.786362136492, 21383.57232855365, 21389.35831925045, 21405.143794248055, 21406.464838379165, 7997.080335761346, 8015.879761803578, 8121.715739949073, 8131.14622964592, 8279.751607451786, 4350.912981740411, 4397.259317621957, 4425.938008975418, 4450.043240703264, 4547.204239258117, 3205.6634053424523, 3304.0913748718813, 3305.2563173285816, 3305.6033276007033, 3306.272620023639, 570.13624359096, 574.1445246582646, 577.3995045152993, 578.8408187748319, 585.157373382328, 568.6701713006446, 585.429206523636, 624.893768059431, 650.6681592387916, 652.6964961292927, 9766.46284454362, 9782.657606983721, 9976.501174941224, 10082.941291164469, 10610.57557697699, 568.3180183779481, 583.9678817664984, 632.1118828046602, 699.9475039371965, 717.9784606461815, 4650.604698600657, 4858.8785280367565, 5082.644214904995, 5112.744362781846, 5318.388385335658, 119122.40438797751, 119287.0, 121404.39297803455, 122185.0, 122915.38542307231, 106648.0, 108257.0, 108417.0, 109308.0, 110712.4464377673, 77240.61379693066, 96439.51780241194, 97397.5130124359, 97978.51010744901, 98724.50637746765, 9431.905680943102, 9767.316287859781, 10420.68737937863, 10689.89310106889, 10750.408727520062, 43141.352879707454, 50894.745526272134, 51276.0, 51621.0, 51914.74042629914, 50191.0, 67464.3253567458, 67910.66044669745, 77832.0, 78170.6091469539, 12796.872031279569, 13571.321433928462, 13688.52090176839, 13755.0, 13786.310684465938, 14395.712085758436, 14791.92604036973, 15045.774313385527, 15993.920030399773, 16013.839861601235, 14410.567682969528, 14583.489577864724, 14669.339879705225, 14726.0, 15641.217939103228, 13765.174089554659, 13936.4425422986, 13947.860521394656, 14755.188464634548, 14780.113193208443, 12816.6795830105, 13100.737985240432, 13145.408456619283, 13696.794548081587, 13770.862291376958, 11198.944005280247, 11256.831147532957, 11486.0, 11648.184627076023, 11699.06407487416, 12135.332556709465, 12403.813942790684, 12502.812457813323, 12686.175398599062, 12714.936425317814], "value": 7500.441947752298, "unit": "score"}], "name": "dromaeo_css", "value": 7116.391112258831, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 109.0, 110.0, 112.0, 113.0, 113.0, 110.0, 109.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 127.0, 180.0, 130.0, 126.0, 149.0, 131.0, 159.0, 143.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 162.0, 159.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 115.0, 75.0, 76.0, 73.0, 74.0, 100.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 107.0, 84.0, 86.0, 86.0, 127.0, 87.0, 88.0, 125.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 66.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 78.0, 78.0, 79.0, 81.0, 86.0, 80.0, 120.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 121.0, 128.0, 127.0, 122.0, 121.0, 131.0, 129.0, 128.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 160.0, 161.0, 160.0, 159.0, 162.0, 161.0, 159.0, 157.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 64.0, 64.0, 62.0, 62.0, 65.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1499.3999999999999, "alertThreshold": 2.0}]} 08:25:35 INFO - Return code: 0 08:25:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:25:35 INFO - # TBPL SUCCESS # 08:25:35 INFO - Running post-action listener: _resource_record_post_action 08:25:35 INFO - ##### 08:25:35 INFO - ##### Finished run-tests step (success) 08:25:35 INFO - ##### 08:25:35 INFO - Running post-run listener: _resource_record_post_run 08:25:35 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566751232; Read time: 8; Write time: 526876 08:25:35 INFO - TinderboxPrint: CPU usage
13.1% 08:25:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:25:35 INFO - TinderboxPrint: I/O write bytes / time
566,751,232 / 526,876 08:25:35 INFO - TinderboxPrint: CPU idle
8,276.2 (86.9%) 08:25:35 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 08:25:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:25:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 211763200; Read time: 0; Write time: 279360 08:25:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294326272; Read time: 8; Write time: 214160 08:25:36 INFO - Running post-run listener: _upload_blobber_files 08:25:36 INFO - Blob upload gear active. 08:25:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:36 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 08:25:36 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'] 08:25:36 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 08:25:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:25:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:37 INFO - (blobuploader) - INFO - Done attempting. 08:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:25:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:25:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:37 INFO - (blobuploader) - INFO - Done attempting. 08:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:25:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:42 INFO - (blobuploader) - INFO - Done attempting. 08:25:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:42 INFO - Return code: 0 08:25:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05d23b9e6fb95840e8070fbb4f6307dc1f38fe99a89fbd6188825598aaa61703e0112e09a161d219a4c5104f305f143628844deec60622b886f263c1c688ba91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a53219f3a059a6293d50aa2e6a4f1dc2ee66e270f7eb5006d02300400356c34751891aedbabc19bbb1061ff00cc9eff1e2e97be93606dbc7e0703881f9333cef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c30590183ae591eb58de50b08838fffd0059d3e03bb2b889a9f23121df74f721ff6efc078ee82323d1c09d57f9d42a8871bfc75b06393f301baad0e5e3ec4e8"} 08:25:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:42 INFO - Contents: 08:25:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05d23b9e6fb95840e8070fbb4f6307dc1f38fe99a89fbd6188825598aaa61703e0112e09a161d219a4c5104f305f143628844deec60622b886f263c1c688ba91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a53219f3a059a6293d50aa2e6a4f1dc2ee66e270f7eb5006d02300400356c34751891aedbabc19bbb1061ff00cc9eff1e2e97be93606dbc7e0703881f9333cef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c30590183ae591eb58de50b08838fffd0059d3e03bb2b889a9f23121df74f721ff6efc078ee82323d1c09d57f9d42a8871bfc75b06393f301baad0e5e3ec4e8"} 08:25:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:42 INFO - Copying logs to upload dir... 08:25:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.617436 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-20 08:25:41.916150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 08:25:41.919900) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758 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/05d23b9e6fb95840e8070fbb4f6307dc1f38fe99a89fbd6188825598aaa61703e0112e09a161d219a4c5104f305f143628844deec60622b886f263c1c688ba91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a53219f3a059a6293d50aa2e6a4f1dc2ee66e270f7eb5006d02300400356c34751891aedbabc19bbb1061ff00cc9eff1e2e97be93606dbc7e0703881f9333cef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c30590183ae591eb58de50b08838fffd0059d3e03bb2b889a9f23121df74f721ff6efc078ee82323d1c09d57f9d42a8871bfc75b06393f301baad0e5e3ec4e8"} build_url:https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/R5omumA9THqeiKNgtlZWxQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05d23b9e6fb95840e8070fbb4f6307dc1f38fe99a89fbd6188825598aaa61703e0112e09a161d219a4c5104f305f143628844deec60622b886f263c1c688ba91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a53219f3a059a6293d50aa2e6a4f1dc2ee66e270f7eb5006d02300400356c34751891aedbabc19bbb1061ff00cc9eff1e2e97be93606dbc7e0703881f9333cef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c30590183ae591eb58de50b08838fffd0059d3e03bb2b889a9f23121df74f721ff6efc078ee82323d1c09d57f9d42a8871bfc75b06393f301baad0e5e3ec4e8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 08:25:41.946631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:25:41.946964) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466435103.916879-1418019758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 08:25:42.028630) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 08:25:42.029012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 08:25:42.029338) ========= ========= Total master_lag: 0.19 =========