builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1465960465.5 results: success (0) buildid: 20160614171307 builduid: 82bf56d5c4d34fa6805db3edcb6897fb revision: cf14f77f4f1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.497144) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.497605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.497890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.521817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.522126) ========= 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=8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 20:14:25-- 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% 225M=0s 2016-06-14 20:14:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.618356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.618679) ========= 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=8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.668482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:25.668841) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cf14f77f4f1d --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 cf14f77f4f1d --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=8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 20:14:25,924 Setting DEBUG logging. 2016-06-14 20:14:25,924 attempt 1/10 2016-06-14 20:14:25,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cf14f77f4f1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 20:14:26,400 unpacking tar archive at: fx-team-cf14f77f4f1d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793175 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:26.476790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:26.477122) ========= script_repo_revision: cf14f77f4f1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:26.477589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:26.477866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 20:14:26.488552) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-14 20:14:26.488956) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:14:26 INFO - MultiFileLogger online at 20160614 20:14:26 in /builds/slave/test 20:14:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:14:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:14:26 INFO - {'append_to_log': False, 20:14:26 INFO - 'base_work_dir': '/builds/slave/test', 20:14:26 INFO - 'blob_upload_branch': 'Fx-Team', 20:14:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:14:26 INFO - 'branch': 'Fx-Team', 20:14:26 INFO - 'buildbot_json_path': 'buildprops.json', 20:14:26 INFO - 'config_files': ('talos/linux_config.py',), 20:14:26 INFO - 'default_actions': ('clobber', 20:14:26 INFO - 'read-buildbot-config', 20:14:26 INFO - 'download-and-extract', 20:14:26 INFO - 'populate-webroot', 20:14:26 INFO - 'create-virtualenv', 20:14:26 INFO - 'install', 20:14:26 INFO - 'run-tests'), 20:14:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:14:26 INFO - 'download_minidump_stackwalk': True, 20:14:26 INFO - 'download_symbols': 'ondemand', 20:14:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:14:26 INFO - 'tooltool.py': '/tools/tooltool.py', 20:14:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:14:26 INFO - '/tools/misc-python/virtualenv.py')}, 20:14:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:14:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:14:26 INFO - 'installer_path': 'installer.exe', 20:14:26 INFO - 'log_level': 'info', 20:14:26 INFO - 'log_name': 'talos', 20:14:26 INFO - 'log_to_console': True, 20:14:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:14:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:14:26 INFO - 'opt_config_files': (), 20:14:26 INFO - 'pip_index': False, 20:14:26 INFO - 'sps_profile': False, 20:14:26 INFO - 'sps_profile_interval': 0, 20:14:26 INFO - 'suite': 'dromaeojs-e10s', 20:14:26 INFO - 'system_bits': '32', 20:14:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:14:26 INFO - 'title': 'talos-linux64-ix-038', 20:14:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:14:26 INFO - 'use_talos_json': True, 20:14:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:14:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:14:26 INFO - 'work_dir': 'build'} 20:14:26 INFO - ##### 20:14:26 INFO - ##### Running clobber step. 20:14:26 INFO - ##### 20:14:26 INFO - Running pre-action listener: _resource_record_pre_action 20:14:26 INFO - Running main action method: clobber 20:14:26 INFO - rmtree: /builds/slave/test/build 20:14:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:14:27 INFO - Running post-action listener: _resource_record_post_action 20:14:27 INFO - ##### 20:14:27 INFO - ##### Finished clobber step (success) 20:14:27 INFO - ##### 20:14:27 INFO - ##### 20:14:27 INFO - ##### Running read-buildbot-config step. 20:14:27 INFO - ##### 20:14:27 INFO - Running pre-action listener: _resource_record_pre_action 20:14:27 INFO - Running main action method: read_buildbot_config 20:14:27 INFO - Using buildbot properties: 20:14:27 INFO - { 20:14:27 INFO - "project": "", 20:14:27 INFO - "product": "firefox", 20:14:27 INFO - "script_repo_revision": "production", 20:14:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:14:27 INFO - "repository": "", 20:14:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:14:27 INFO - "buildid": "20160614171307", 20:14:27 INFO - "pgo_build": "True", 20:14:27 INFO - "basedir": "/builds/slave/test", 20:14:27 INFO - "buildnumber": 471, 20:14:27 INFO - "slavename": "talos-linux64-ix-038", 20:14:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:14:27 INFO - "platform": "ubuntu64_hw", 20:14:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:14:27 INFO - "branch": "fx-team", 20:14:27 INFO - "repo_path": "integration/fx-team", 20:14:27 INFO - "revision": "cf14f77f4f1d", 20:14:27 INFO - "stage_platform": "linux64-pgo", 20:14:27 INFO - "builduid": "82bf56d5c4d34fa6805db3edcb6897fb", 20:14:27 INFO - "slavebuilddir": "test" 20:14:27 INFO - } 20:14:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:14:27 INFO - Running post-action listener: _resource_record_post_action 20:14:27 INFO - ##### 20:14:27 INFO - ##### Finished read-buildbot-config step (success) 20:14:27 INFO - ##### 20:14:27 INFO - ##### 20:14:27 INFO - ##### Running download-and-extract step. 20:14:27 INFO - ##### 20:14:27 INFO - Running pre-action listener: _resource_record_pre_action 20:14:27 INFO - Running main action method: download_and_extract 20:14:27 INFO - mkdir: /builds/slave/test/build/tests 20:14: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')]} 20:14:27 INFO - https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:28 INFO - Downloaded 1361 bytes. 20:14:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:28 INFO - Using the following test package requirements: 20:14:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:14:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:14:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:28 INFO - u'jsshell-linux-x86_64.zip'], 20:14:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:14:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:14:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:14:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:14:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:14:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:29 INFO - Downloaded 24219986 bytes. 20:14:29 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'] 20:14:29 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 20:14:30 INFO - Return code: 0 20:14:30 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 20:14: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')]} 20:14:30 INFO - https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:32 INFO - Downloaded 24219986 bytes. 20:14:32 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'] 20:14:32 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 20:14:33 INFO - Return code: 0 20:14: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')]} 20:14:33 INFO - https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:35 INFO - Downloaded 14405384 bytes. 20:14:35 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'] 20:14:35 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 20:14:35 INFO - Return code: 0 20:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:35 INFO - https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/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 20:14:39 INFO - Downloaded 59350299 bytes. 20:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:39 INFO - mkdir: /builds/slave/test/properties 20:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 20:14:39 INFO - Contents: 20:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:40 INFO - Running post-action listener: _resource_record_post_action 20:14:40 INFO - Running post-action listener: set_extra_try_arguments 20:14:40 INFO - ##### 20:14:40 INFO - ##### Finished download-and-extract step (success) 20:14:40 INFO - ##### 20:14:40 INFO - ##### 20:14:40 INFO - ##### Running populate-webroot step. 20:14:40 INFO - ##### 20:14:40 INFO - Running pre-action listener: _resource_record_pre_action 20:14:40 INFO - Running main action method: populate_webroot 20:14:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:14:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:14:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:14:40 INFO - '--tppagecycles', 20:14:40 INFO - '7'], 20:14:40 INFO - 'tests': ['tsvgm']}}, 20:14:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:14:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:14:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:14:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:14:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:40 INFO - 'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:40 INFO - 'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['damp', 'tps']}, 20:14:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:40 INFO - 'tests': ['damp', 'tps']}, 20:14:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['dromaeo_dom']}, 20:14:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:14:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['basic_compositor_video']}, 20:14:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:14:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['a11yr', 20:14:40 INFO - 'ts_paint', 20:14:40 INFO - 'tpaint', 20:14:40 INFO - 'sessionrestore', 20:14:40 INFO - 'sessionrestore_no_auto_restore', 20:14:40 INFO - 'tabpaint']}, 20:14:40 INFO - 'other-e10s': {'tests': ['a11yr', 20:14:40 INFO - 'ts_paint', 20:14:40 INFO - 'tpaint', 20:14:40 INFO - 'sessionrestore', 20:14:40 INFO - 'sessionrestore_no_auto_restore', 20:14:40 INFO - 'tabpaint']}, 20:14:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:14:40 INFO - 'ts_paint', 20:14:40 INFO - 'tpaint', 20:14:40 INFO - 'sessionrestore', 20:14:40 INFO - 'sessionrestore_no_auto_restore', 20:14:40 INFO - 'tabpaint']}, 20:14:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:14:40 INFO - 'ts_paint', 20:14:40 INFO - 'tpaint', 20:14:40 INFO - 'sessionrestore', 20:14:40 INFO - 'sessionrestore_no_auto_restore', 20:14:40 INFO - 'tabpaint']}, 20:14:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['a11yr', 20:14:40 INFO - 'ts_paint', 20:14:40 INFO - 'tpaint', 20:14:40 INFO - 'sessionrestore', 20:14:40 INFO - 'sessionrestore_no_auto_restore', 20:14:40 INFO - 'tabpaint']}, 20:14:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['a11yr', 20:14:40 INFO - 'ts_paint', 20:14:40 INFO - 'tpaint', 20:14:40 INFO - 'sessionrestore', 20:14:40 INFO - 'sessionrestore_no_auto_restore', 20:14:40 INFO - 'tabpaint']}, 20:14:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['tsvgx', 20:14:40 INFO - 'tsvgr_opacity', 20:14:40 INFO - 'tart', 20:14:40 INFO - 'tscrollx', 20:14:40 INFO - 'cart']}, 20:14:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:14:40 INFO - 'tsvgr_opacity', 20:14:40 INFO - 'tart', 20:14:40 INFO - 'tscrollx', 20:14:40 INFO - 'cart']}, 20:14:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:40 INFO - 'talos_options': ['--disable-e10s'], 20:14:40 INFO - 'tests': ['tp5o']}, 20:14:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:40 INFO - 'tests': ['tp5o']}, 20:14:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:40 INFO - 'talos_options': ['--disable-e10s', 20:14:40 INFO - '--xperf_path', 20:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:40 INFO - 'tests': ['tp5n']}, 20:14:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:40 INFO - 'talos_options': ['--xperf_path', 20:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:40 INFO - 'tests': ['tp5n']}}, 20:14:40 INFO - 'talos.zip': {'path': '', 20:14:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:14:40 INFO - Running post-action listener: _resource_record_post_action 20:14:40 INFO - ##### 20:14:40 INFO - ##### Finished populate-webroot step (success) 20:14:40 INFO - ##### 20:14:40 INFO - ##### 20:14:40 INFO - ##### Running create-virtualenv step. 20:14:40 INFO - ##### 20:14:40 INFO - Running pre-action listener: _resource_record_pre_action 20:14:40 INFO - Running main action method: create_virtualenv 20:14:40 INFO - Creating virtualenv /builds/slave/test/build/venv 20:14:40 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 20:14:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:14:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:14:40 INFO - Using real prefix '/usr' 20:14:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:14:41 INFO - Installing distribute.............................................................................................................................................................................................done. 20:14:43 INFO - Installing pip.................done. 20:14:43 INFO - Return code: 0 20:14:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:14:43 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')]} 20:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:43 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')]} 20:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:43 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:14:43 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 20:14:43 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 20:14:43 INFO - Using env: {'DISPLAY': ':0', 20:14:43 INFO - 'HOME': '/home/cltbld', 20:14:43 INFO - 'LANG': 'en_US.UTF-8', 20:14:43 INFO - 'LANGUAGE': 'en_US:en', 20:14:43 INFO - 'LOGNAME': 'cltbld', 20:14:43 INFO - 'MAIL': '/var/mail/cltbld', 20:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:43 INFO - 'MOZ_NO_REMOTE': '1', 20:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:43 INFO - 'NO_EM_RESTART': '1', 20:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:43 INFO - 'PWD': '/builds/slave/test', 20:14:43 INFO - 'SHELL': '/bin/bash', 20:14:43 INFO - 'SHLVL': '1', 20:14:43 INFO - 'TERM': 'linux', 20:14:43 INFO - 'TMOUT': '86400', 20:14:43 INFO - 'USER': 'cltbld', 20:14:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:43 INFO - '_': '/tools/buildbot/bin/python'} 20:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:43 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 20:14:43 INFO - Cleaning up... 20:14:43 INFO - Return code: 0 20:14:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:14:43 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')]} 20:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:43 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')]} 20:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:43 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:14:43 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 20:14:43 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 20:14:43 INFO - Using env: {'DISPLAY': ':0', 20:14:43 INFO - 'HOME': '/home/cltbld', 20:14:43 INFO - 'LANG': 'en_US.UTF-8', 20:14:43 INFO - 'LANGUAGE': 'en_US:en', 20:14:43 INFO - 'LOGNAME': 'cltbld', 20:14:43 INFO - 'MAIL': '/var/mail/cltbld', 20:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:43 INFO - 'MOZ_NO_REMOTE': '1', 20:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:43 INFO - 'NO_EM_RESTART': '1', 20:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:43 INFO - 'PWD': '/builds/slave/test', 20:14:43 INFO - 'SHELL': '/bin/bash', 20:14:43 INFO - 'SHLVL': '1', 20:14:43 INFO - 'TERM': 'linux', 20:14:43 INFO - 'TMOUT': '86400', 20:14:43 INFO - 'USER': 'cltbld', 20:14:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:43 INFO - '_': '/tools/buildbot/bin/python'} 20:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:43 INFO - Downloading/unpacking psutil>=3.1.1 20:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:45 INFO - Installing collected packages: psutil 20:14:45 INFO - Running setup.py install for psutil 20:14:45 INFO - building 'psutil._psutil_linux' extension 20:14:45 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 20:14:45 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 20:14:45 INFO - building 'psutil._psutil_posix' extension 20:14:45 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 20:14:45 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 20:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:45 INFO - Successfully installed psutil 20:14:45 INFO - Cleaning up... 20:14:46 INFO - Return code: 0 20:14:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:14:46 INFO - Using env: {'DISPLAY': ':0', 20:14:46 INFO - 'HOME': '/home/cltbld', 20:14:46 INFO - 'LANG': 'en_US.UTF-8', 20:14:46 INFO - 'LANGUAGE': 'en_US:en', 20:14:46 INFO - 'LOGNAME': 'cltbld', 20:14:46 INFO - 'MAIL': '/var/mail/cltbld', 20:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:46 INFO - 'MOZ_NO_REMOTE': '1', 20:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:46 INFO - 'NO_EM_RESTART': '1', 20:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:46 INFO - 'PWD': '/builds/slave/test', 20:14:46 INFO - 'SHELL': '/bin/bash', 20:14:46 INFO - 'SHLVL': '1', 20:14:46 INFO - 'TERM': 'linux', 20:14:46 INFO - 'TMOUT': '86400', 20:14:46 INFO - 'USER': 'cltbld', 20:14:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:46 INFO - '_': '/tools/buildbot/bin/python'} 20:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:14:46 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 20:14:46 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 20:14:46 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 20:14:46 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 20:14:46 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 20:14:46 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 20:14:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:14:48 INFO - Installing collected packages: mozsystemmonitor 20:14:48 INFO - Running setup.py install for mozsystemmonitor 20:14:48 INFO - Successfully installed mozsystemmonitor 20:14:48 INFO - Cleaning up... 20:14:48 INFO - Return code: 0 20:14:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:14:48 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')]} 20:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:48 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')]} 20:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:48 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:14:48 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 20:14:48 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 20:14:48 INFO - Using env: {'DISPLAY': ':0', 20:14:48 INFO - 'HOME': '/home/cltbld', 20:14:48 INFO - 'LANG': 'en_US.UTF-8', 20:14:48 INFO - 'LANGUAGE': 'en_US:en', 20:14:48 INFO - 'LOGNAME': 'cltbld', 20:14:48 INFO - 'MAIL': '/var/mail/cltbld', 20:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:48 INFO - 'MOZ_NO_REMOTE': '1', 20:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:48 INFO - 'NO_EM_RESTART': '1', 20:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:48 INFO - 'PWD': '/builds/slave/test', 20:14:48 INFO - 'SHELL': '/bin/bash', 20:14:48 INFO - 'SHLVL': '1', 20:14:48 INFO - 'TERM': 'linux', 20:14:48 INFO - 'TMOUT': '86400', 20:14:48 INFO - 'USER': 'cltbld', 20:14:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:48 INFO - '_': '/tools/buildbot/bin/python'} 20:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:48 INFO - Downloading/unpacking jsonschema==2.5.1 20:14:48 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 20:14:48 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 20:14:48 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 20:14:48 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 20:14:48 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 20:14:48 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 20:14:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:14:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:14:50 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 20:14:50 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 20:14:50 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 20:14:50 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 20:14:50 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 20:14:50 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 20:14:50 INFO - Downloading functools32-3.2.3-2.tar.gz 20:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:14:50 INFO - warning: no files found matching '*.txt' 20:14:50 INFO - no previously-included directories found matching 'build' 20:14:50 INFO - no previously-included directories found matching 'dist' 20:14:50 INFO - no previously-included directories found matching '.git*' 20:14:50 INFO - Installing collected packages: jsonschema, functools32 20:14:50 INFO - Running setup.py install for functools32 20:14:50 INFO - warning: no files found matching '*.txt' 20:14:50 INFO - no previously-included directories found matching 'build' 20:14:50 INFO - no previously-included directories found matching 'dist' 20:14:50 INFO - no previously-included directories found matching '.git*' 20:14:50 INFO - Successfully installed jsonschema functools32 20:14:50 INFO - Cleaning up... 20:14:50 INFO - Return code: 0 20:14:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:14:50 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')]} 20:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:50 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')]} 20:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:50 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:14:50 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 20:14:50 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 20:14:50 INFO - Using env: {'DISPLAY': ':0', 20:14:50 INFO - 'HOME': '/home/cltbld', 20:14:50 INFO - 'LANG': 'en_US.UTF-8', 20:14:50 INFO - 'LANGUAGE': 'en_US:en', 20:14:50 INFO - 'LOGNAME': 'cltbld', 20:14:50 INFO - 'MAIL': '/var/mail/cltbld', 20:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:50 INFO - 'MOZ_NO_REMOTE': '1', 20:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:50 INFO - 'NO_EM_RESTART': '1', 20:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:50 INFO - 'PWD': '/builds/slave/test', 20:14:50 INFO - 'SHELL': '/bin/bash', 20:14:50 INFO - 'SHLVL': '1', 20:14:50 INFO - 'TERM': 'linux', 20:14:50 INFO - 'TMOUT': '86400', 20:14:50 INFO - 'USER': 'cltbld', 20:14:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:50 INFO - '_': '/tools/buildbot/bin/python'} 20:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:51 INFO - Downloading/unpacking blobuploader==1.2.4 20:14:51 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 20:14:51 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 20:14:51 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 20:14:51 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 20:14:51 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 20:14:51 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 20:14:52 INFO - Downloading blobuploader-1.2.4.tar.gz 20:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:14:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:14:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:53 INFO - Downloading docopt-0.6.1.tar.gz 20:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:14:53 INFO - Installing collected packages: blobuploader, requests, docopt 20:14:53 INFO - Running setup.py install for blobuploader 20:14:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:14:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:14:53 INFO - Running setup.py install for requests 20:14:54 INFO - Running setup.py install for docopt 20:14:54 INFO - Successfully installed blobuploader requests docopt 20:14:54 INFO - Cleaning up... 20:14:54 INFO - Return code: 0 20:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:54 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:14:54 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 20:14:54 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 20:14:54 INFO - Using env: {'DISPLAY': ':0', 20:14:54 INFO - 'HOME': '/home/cltbld', 20:14:54 INFO - 'LANG': 'en_US.UTF-8', 20:14:54 INFO - 'LANGUAGE': 'en_US:en', 20:14:54 INFO - 'LOGNAME': 'cltbld', 20:14:54 INFO - 'MAIL': '/var/mail/cltbld', 20:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:54 INFO - 'MOZ_NO_REMOTE': '1', 20:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:54 INFO - 'NO_EM_RESTART': '1', 20:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:54 INFO - 'PWD': '/builds/slave/test', 20:14:54 INFO - 'SHELL': '/bin/bash', 20:14:54 INFO - 'SHLVL': '1', 20:14:54 INFO - 'TERM': 'linux', 20:14:54 INFO - 'TMOUT': '86400', 20:14:54 INFO - 'USER': 'cltbld', 20:14:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:54 INFO - '_': '/tools/buildbot/bin/python'} 20:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:54 INFO - Running setup.py (path:/tmp/pip-kLZsrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:54 INFO - Running setup.py (path:/tmp/pip-jfKxZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:54 INFO - Running setup.py (path:/tmp/pip-jiIiQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:54 INFO - Running setup.py (path:/tmp/pip-_gGPcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:54 INFO - Running setup.py (path:/tmp/pip-bb78EK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:54 INFO - Running setup.py (path:/tmp/pip-Rfe6rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:54 INFO - Running setup.py (path:/tmp/pip-rAJ7xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:55 INFO - Running setup.py (path:/tmp/pip-CdQKKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:55 INFO - Running setup.py (path:/tmp/pip-dgx7yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:55 INFO - Running setup.py (path:/tmp/pip-wXT3ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:55 INFO - Running setup.py (path:/tmp/pip-FpoTGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:55 INFO - Running setup.py (path:/tmp/pip-9fG9lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:55 INFO - Running setup.py (path:/tmp/pip-2dUfJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:55 INFO - Running setup.py (path:/tmp/pip-I9Dh8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:55 INFO - Running setup.py (path:/tmp/pip-QrURm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:55 INFO - Running setup.py (path:/tmp/pip-nE0hxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:55 INFO - Running setup.py (path:/tmp/pip-Sk7Gcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:14:55 INFO - Running setup.py install for manifestparser 20:14:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:14:55 INFO - Running setup.py install for mozcrash 20:14:55 INFO - Running setup.py install for mozdebug 20:14:56 INFO - Running setup.py install for mozdevice 20:14:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Running setup.py install for mozfile 20:14:56 INFO - Running setup.py install for mozhttpd 20:14:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Running setup.py install for mozinfo 20:14:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Running setup.py install for mozInstall 20:14:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Running setup.py install for mozleak 20:14:56 INFO - Running setup.py install for mozlog 20:14:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Running setup.py install for moznetwork 20:14:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:14:56 INFO - Running setup.py install for mozprocess 20:14:56 INFO - Running setup.py install for mozprofile 20:14:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:14:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:14:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:14:57 INFO - Running setup.py install for mozrunner 20:14:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:14:57 INFO - Running setup.py install for mozscreenshot 20:14:57 INFO - Running setup.py install for moztest 20:14:57 INFO - Running setup.py install for mozversion 20:14:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:14:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:14:57 INFO - Cleaning up... 20:14:57 INFO - Return code: 0 20:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:57 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:14:57 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 20:14:57 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 20:14:57 INFO - Using env: {'DISPLAY': ':0', 20:14:57 INFO - 'HOME': '/home/cltbld', 20:14:57 INFO - 'LANG': 'en_US.UTF-8', 20:14:57 INFO - 'LANGUAGE': 'en_US:en', 20:14:57 INFO - 'LOGNAME': 'cltbld', 20:14:57 INFO - 'MAIL': '/var/mail/cltbld', 20:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:57 INFO - 'MOZ_NO_REMOTE': '1', 20:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:57 INFO - 'NO_EM_RESTART': '1', 20:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:57 INFO - 'PWD': '/builds/slave/test', 20:14:57 INFO - 'SHELL': '/bin/bash', 20:14:57 INFO - 'SHLVL': '1', 20:14:57 INFO - 'TERM': 'linux', 20:14:57 INFO - 'TMOUT': '86400', 20:14:57 INFO - 'USER': 'cltbld', 20:14:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:57 INFO - '_': '/tools/buildbot/bin/python'} 20:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:57 INFO - Running setup.py (path:/tmp/pip-v9Saqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:57 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)) 20:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:57 INFO - Running setup.py (path:/tmp/pip-La0Aty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:57 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)) 20:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:57 INFO - Running setup.py (path:/tmp/pip-mk_tah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:57 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)) 20:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:57 INFO - Running setup.py (path:/tmp/pip-RD38YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:58 INFO - Running setup.py (path:/tmp/pip-XQz6dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:58 INFO - Running setup.py (path:/tmp/pip-XduzCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:58 INFO - Running setup.py (path:/tmp/pip-nygSHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:58 INFO - Running setup.py (path:/tmp/pip-LGd2tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:58 INFO - Running setup.py (path:/tmp/pip-GZcmgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:58 INFO - Running setup.py (path:/tmp/pip-GBhtuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:58 INFO - Running setup.py (path:/tmp/pip-bh1Nir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:58 INFO - Running setup.py (path:/tmp/pip-4rdVn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:58 INFO - Running setup.py (path:/tmp/pip-L3shCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:58 INFO - Running setup.py (path:/tmp/pip-Gagsa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:58 INFO - Running setup.py (path:/tmp/pip-qWFYR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:58 INFO - Running setup.py (path:/tmp/pip-mN0kVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:58 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)) 20:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:58 INFO - Running setup.py (path:/tmp/pip-Rytuvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:58 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)) 20:14:58 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)) 20:14:58 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)) 20:14:58 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)) 20:14:58 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)) 20:14:58 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)) 20:14:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14:58 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 20:14:58 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 20:14:58 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 20:14:58 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 20:14:58 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 20:14:58 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 20:15:00 INFO - Downloading blessings-1.6.tar.gz 20:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:15:01 INFO - Installing collected packages: blessings 20:15:01 INFO - Running setup.py install for blessings 20:15:01 INFO - Successfully installed blessings 20:15:01 INFO - Cleaning up... 20:15:01 INFO - Return code: 0 20:15:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:01 INFO - Reading from file tmpfile_stdout 20:15:01 INFO - Current package versions: 20:15:01 INFO - argparse == 1.2.1 20:15:01 INFO - blessings == 1.6 20:15:01 INFO - blobuploader == 1.2.4 20:15:01 INFO - docopt == 0.6.1 20:15:01 INFO - functools32 == 3.2.3-2 20:15:01 INFO - jsonschema == 2.5.1 20:15:01 INFO - manifestparser == 1.1 20:15:01 INFO - mozInstall == 1.12 20:15:01 INFO - mozcrash == 0.17 20:15:01 INFO - mozdebug == 0.1 20:15:01 INFO - mozdevice == 0.48 20:15:01 INFO - mozfile == 1.2 20:15:01 INFO - mozhttpd == 0.7 20:15:01 INFO - mozinfo == 0.9 20:15:01 INFO - mozleak == 0.1 20:15:01 INFO - mozlog == 3.2 20:15:01 INFO - moznetwork == 0.27 20:15:01 INFO - mozprocess == 0.22 20:15:01 INFO - mozprofile == 0.28 20:15:01 INFO - mozrunner == 6.11 20:15:01 INFO - mozscreenshot == 0.1 20:15:01 INFO - mozsystemmonitor == 0.3 20:15:01 INFO - moztest == 0.7 20:15:01 INFO - mozversion == 1.4 20:15:01 INFO - psutil == 3.1.1 20:15:01 INFO - requests == 1.2.3 20:15:01 INFO - wsgiref == 0.1.2 20:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:01 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:15:01 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 20:15:01 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 20:15:01 INFO - Using env: {'DISPLAY': ':0', 20:15:01 INFO - 'HOME': '/home/cltbld', 20:15:01 INFO - 'LANG': 'en_US.UTF-8', 20:15:01 INFO - 'LANGUAGE': 'en_US:en', 20:15:01 INFO - 'LOGNAME': 'cltbld', 20:15:01 INFO - 'MAIL': '/var/mail/cltbld', 20:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:01 INFO - 'MOZ_NO_REMOTE': '1', 20:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:01 INFO - 'NO_EM_RESTART': '1', 20:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:01 INFO - 'PWD': '/builds/slave/test', 20:15:01 INFO - 'SHELL': '/bin/bash', 20:15:01 INFO - 'SHLVL': '1', 20:15:01 INFO - 'TERM': 'linux', 20:15:01 INFO - 'TMOUT': '86400', 20:15:01 INFO - 'USER': 'cltbld', 20:15:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:01 INFO - '_': '/tools/buildbot/bin/python'} 20:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 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)) 20:15:01 INFO - Cleaning up... 20:15:01 INFO - Return code: 0 20:15:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:01 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:15:01 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 20:15:01 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 20:15:01 INFO - Using env: {'DISPLAY': ':0', 20:15:01 INFO - 'HOME': '/home/cltbld', 20:15:01 INFO - 'LANG': 'en_US.UTF-8', 20:15:01 INFO - 'LANGUAGE': 'en_US:en', 20:15:01 INFO - 'LOGNAME': 'cltbld', 20:15:01 INFO - 'MAIL': '/var/mail/cltbld', 20:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:01 INFO - 'MOZ_NO_REMOTE': '1', 20:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:01 INFO - 'NO_EM_RESTART': '1', 20:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:01 INFO - 'PWD': '/builds/slave/test', 20:15:01 INFO - 'SHELL': '/bin/bash', 20:15:01 INFO - 'SHLVL': '1', 20:15:01 INFO - 'TERM': 'linux', 20:15:01 INFO - 'TMOUT': '86400', 20:15:01 INFO - 'USER': 'cltbld', 20:15:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:01 INFO - '_': '/tools/buildbot/bin/python'} 20:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:15:01 INFO - Cleaning up... 20:15:01 INFO - Return code: 0 20:15:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:01 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 0x7f25ea24df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, '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': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', '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 20:15:01 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 20:15:01 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 20:15:01 INFO - Using env: {'DISPLAY': ':0', 20:15:01 INFO - 'HOME': '/home/cltbld', 20:15:01 INFO - 'LANG': 'en_US.UTF-8', 20:15:01 INFO - 'LANGUAGE': 'en_US:en', 20:15:01 INFO - 'LOGNAME': 'cltbld', 20:15:01 INFO - 'MAIL': '/var/mail/cltbld', 20:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:01 INFO - 'MOZ_NO_REMOTE': '1', 20:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:01 INFO - 'NO_EM_RESTART': '1', 20:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:01 INFO - 'PWD': '/builds/slave/test', 20:15:01 INFO - 'SHELL': '/bin/bash', 20:15:01 INFO - 'SHLVL': '1', 20:15:01 INFO - 'TERM': 'linux', 20:15:01 INFO - 'TMOUT': '86400', 20:15:01 INFO - 'USER': 'cltbld', 20:15:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:01 INFO - '_': '/tools/buildbot/bin/python'} 20:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:02 INFO - Downloading/unpacking flake8 20:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:15:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:15:03 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 20:15:03 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 20:15:03 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 20:15:03 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 20:15:03 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 20:15:03 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 20:15:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:15:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:15:04 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 20:15:04 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 20:15:04 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 20:15:04 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 20:15:04 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 20:15:04 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 20:15:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:15:04 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 20:15:04 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 20:15:04 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 20:15:04 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 20:15:04 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 20:15:04 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 20:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:15:04 INFO - no previously-included directories found matching 'docs/_build' 20:15:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:15:04 INFO - Running setup.py install for pep8 20:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:15:04 INFO - no previously-included directories found matching 'docs/_build' 20:15:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:15:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:15:04 INFO - Cleaning up... 20:15:04 INFO - Return code: 0 20:15:04 INFO - Running post-action listener: _resource_record_post_action 20:15:04 INFO - Running post-action listener: _start_resource_monitoring 20:15:04 INFO - Starting resource monitoring. 20:15:04 INFO - ##### 20:15:04 INFO - ##### Finished create-virtualenv step (success) 20:15:04 INFO - ##### 20:15:04 INFO - ##### 20:15:04 INFO - ##### Running install step. 20:15:04 INFO - ##### 20:15:04 INFO - Running pre-action listener: _resource_record_pre_action 20:15:04 INFO - Running main action method: install 20:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:05 INFO - Reading from file tmpfile_stdout 20:15:05 INFO - Detecting whether we're running mozinstall >=1.0... 20:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:15:05 INFO - Reading from file tmpfile_stdout 20:15:05 INFO - Output received: 20:15:05 INFO - Usage: mozinstall [options] installer 20:15:05 INFO - Options: 20:15:05 INFO - -h, --help show this help message and exit 20:15:05 INFO - -d DEST, --destination=DEST 20:15:05 INFO - Directory to install application into. [default: 20:15:05 INFO - "/builds/slave/test"] 20:15:05 INFO - --app=APP Application being installed. [default: firefox] 20:15:05 INFO - mkdir: /builds/slave/test/build/application 20:15:05 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'] 20:15:05 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 20:15:25 INFO - Reading from file tmpfile_stdout 20:15:25 INFO - Output received: 20:15:25 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:25 INFO - Running post-action listener: _resource_record_post_action 20:15:25 INFO - ##### 20:15:25 INFO - ##### Finished install step (success) 20:15:25 INFO - ##### 20:15:25 INFO - ##### 20:15:25 INFO - ##### Running run-tests step. 20:15:25 INFO - ##### 20:15:25 INFO - Running pre-action listener: _resource_record_pre_action 20:15:25 INFO - Running main action method: run_tests 20:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:25 INFO - Python 2.7.3 20:15:25 INFO - Return code: 0 20:15:25 INFO - grabbing minidump binary from tooltool 20:15:25 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')]} 20:15:25 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 0x12fe990>, '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 0x126a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:25 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 20:15:25 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 20:15:25 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 20:15:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:25 INFO - Return code: 0 20:15:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:15:26 INFO - Return code: 0 20:15:26 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:15:26 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:15:26 INFO - Using env: {'DISPLAY': ':0', 20:15:26 INFO - 'HOME': '/home/cltbld', 20:15:26 INFO - 'LANG': 'en_US.UTF-8', 20:15:26 INFO - 'LANGUAGE': 'en_US:en', 20:15:26 INFO - 'LOGNAME': 'cltbld', 20:15:26 INFO - 'MAIL': '/var/mail/cltbld', 20:15:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:26 INFO - 'MOZ_NO_REMOTE': '1', 20:15:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:26 INFO - 'NO_EM_RESTART': '1', 20:15:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:26 INFO - 'PWD': '/builds/slave/test', 20:15:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:26 INFO - 'SHELL': '/bin/bash', 20:15:26 INFO - 'SHLVL': '1', 20:15:26 INFO - 'TERM': 'linux', 20:15:26 INFO - 'TMOUT': '86400', 20:15:26 INFO - 'USER': 'cltbld', 20:15:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304', 20:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:26 INFO - '_': '/tools/buildbot/bin/python'} 20:15:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:15:26 INFO - mozversion application_buildid: 20160614171307 20:15:26 INFO - mozversion application_changeset: cf14f77f4f1def6ad4822f5829d1a7d0f6f7948b 20:15:26 INFO - mozversion application_display_name: Nightly 20:15:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:26 INFO - mozversion application_name: Firefox 20:15:26 INFO - mozversion application_remotingname: firefox 20:15:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:15:26 INFO - mozversion application_vendor: Mozilla 20:15:26 INFO - mozversion application_version: 50.0a1 20:15:26 INFO - mozversion platform_buildid: 20160614171307 20:15:26 INFO - mozversion platform_changeset: cf14f77f4f1def6ad4822f5829d1a7d0f6f7948b 20:15:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:15:26 INFO - mozversion platform_version: 50.0a1 20:15:26 INFO - using testdate: 1465960526 20:15:26 INFO - actual date: 1465960526 20:15:26 INFO - starting webserver on 'localhost:37149' 20:15:26 INFO - SUITE-START | Running 2 tests 20:15:26 INFO - TEST-START | dromaeo_css 20:15:26 INFO - operating with platform_type : linux_ 20:15:26 INFO - Initialising browser for dromaeo_css test... 20:15:26 INFO - TEST-INFO | started process 25771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxUPlV/profile http://localhost:37149/getInfo.html) 20:15:33 INFO - PROCESS | 25771 | __metrics Screen width/height:1600/1200 20:15:33 INFO - PROCESS | 25771 | colorDepth:24 20:15:33 INFO - PROCESS | 25771 | Browser inner width/height: 1024/697 20:15:33 INFO - PROCESS | 25771 | __metrics 20:15:34 ERROR - PROCESS | 25771 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 20:15:35 INFO - TEST-INFO | 25771: exit 0 20:15:35 INFO - Browser initialized. 20:15:35 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:35 INFO - TEST-INFO | started process 25891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxUPlV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:47 INFO - PROCESS | 25891 | RSS: Main: 184500224 20:15:47 INFO - PROCESS | 25891 | 20:16:36 INFO - PROCESS | 25891 | 1465960596690 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] 20:18:45 INFO - PROCESS | 25891 | Cycle 1(1): loaded http://localhost:37149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37149/tests/dromaeo/cssquery-ext.html) 20:18:46 INFO - PROCESS | 25891 | RSS: Main: 189419520 20:18:46 INFO - PROCESS | 25891 | 20:21:48 INFO - PROCESS | 25891 | Cycle 1(1): loaded http://localhost:37149/tests/dromaeo/cssquery-ext.html (next: http://localhost:37149/tests/dromaeo/cssquery-jquery.html) 20:21:48 INFO - PROCESS | 25891 | RSS: Main: 187215872 20:21:48 INFO - PROCESS | 25891 | 20:24:50 INFO - PROCESS | 25891 | Cycle 1(1): loaded http://localhost:37149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37149/tests/dromaeo/cssquery-mootools.html) 20:24:51 INFO - PROCESS | 25891 | RSS: Main: 188948480 20:24:51 INFO - PROCESS | 25891 | 20:27:53 INFO - PROCESS | 25891 | Cycle 1(1): loaded http://localhost:37149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37149/tests/dromaeo/cssquery-prototype.html) 20:27:53 INFO - PROCESS | 25891 | RSS: Main: 186687488 20:27:53 INFO - PROCESS | 25891 | 20:30:56 INFO - PROCESS | 25891 | Cycle 1(1): loaded http://localhost:37149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37149/tests/dromaeo/cssquery-yui.html) 20:30:56 INFO - PROCESS | 25891 | RSS: Main: 189157376 20:30:56 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | Cycle 1(1): loaded http://localhost:37149/tests/dromaeo/cssquery-yui.html (next: http://localhost:37149/tests/dromaeo/cssquery-dojo.html) 20:33:59 INFO - PROCESS | 25891 | RSS: Main: 189685760 20:33:59 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | __start_tp_report 20:33:59 INFO - PROCESS | 25891 | _x_x_mozilla_page_load 20:33:59 INFO - PROCESS | 25891 | _x_x_mozilla_page_load_details 20:33:59 INFO - PROCESS | 25891 | |i|pagename|runs| 20:33:59 INFO - PROCESS | 25891 | |0;dojo.html;3118.7504999600033;3185.1877771168365;3195.8561864716094;3199.1202419334695;3215.8713651453945;5459.563234941205;5470.179473079035;5492.148716948869;5556.111022236443;5557.861053473665;5396.730163491829;5397.163439666848;5418.133098704208;5448.509634132927;5486.725663716818;4864.829730959408;4906.190478571031;4968.428630707461;5037.924431133536;5077.822276220333;718.8123895420014;4967.205247160455;5029.547340739333;5036.445990940993;5100.617453690988;4999.9500004999845;5005.299258103868;5028.874278143039;5042.520960508746;5100.158473851847;4939.827106051271;5022.77397517109;5043.873903152414;5048.5203905628905;5069.290299358093;4984.177610694231;4999.675021123615;5012.899742005139;5036.84889453317;5083.923741143886;5555.972220138914;5575.5539556835765;5577.247071645316;5592.049351610236;5592.356878958931;5673.943260567383;5750.252467179282;5814.709264536798;5917.704114794243;5921.289445266552;5879.794207202727;5903.291605007426;5933.228680271537;5945.256842894638;5965.8806823863715;5544.417836127229;5553.8333849984565;5554.028045092133;5554.389017208104;5555.555555555546;5932.228810254725;6028.306744724413;6039.486643635252;6048.969755151196;6095.045420286402;5615.129654903497;5616.410276920865;5620.241267428844;5641.492265696107;5700.144978253295;5695.829125126253;5720.342160651495;5722.484976352148;5726.627769194989;5765.567582431335;5524.447555244524;5806.68063256525;5882.617629854131;5905.232319798484;5912.556558258148;5645.943540564624;5753.568482363756;5754.05058165398;5841.474267315962;5913.083472061838;4399.670024748157;4446.777661116931;4459.509453960061;4461.888452788707;4495.280755079171;3894.0264933766557;3957.3470377387985;3960.34654282046;3963.504561929759;4042.7776472293717;5649.350324712711;5651.095824668033;5668.57485688575;5672.461116193955;5676.432356764373;5930.7924222652;5995.760169593254;5998.220231369894;6004.909926351108;6021.42796434338;5470.370907345627;5516.089845175581;5545.417731138253;5584.86037849057;5590.944090559043;4969.676970996874;4991.875203119951;4996.300517927493;5006.4492905780335;5062.721550314768;5951.583389162717;6101.115338275925;6112;6115.143879856823;6116.990696535022;5918.644881307221;5964.821055368346;5971.223740913653;5989.610675306091;6011.639301641915;6104.511639068775;6143.877122457437;6148.754049837957;6162.630242185483;6189.721462534287;5633.352164501135;5671.461211184931;5817.447342502455;5822.505087067647;5830.416958304136;5804.970975145097;5816.796412125555;5829.8251052468495;5852.209951656472;5905.35041145465;5742.856428589152;5747.942520574908;5752.223449834219;5754.4533269339345;5757.453041961007;5587.161925711176;5658;5684.204211410323;5721.427857214412;5731.512821410227;5571.275734154534;5607.271054762855;5632.88734225305;5654.434556544313;5741.081426971665;5772.913406298825;5789.681567513659;5789.739461724317;5791.276090488689;5793.681347525927;5481.917771233355;5551.056320425457;5610.85972850682;5655.123455864347;5661.179129026351 20:33:59 INFO - PROCESS | 25891 | |1;ext.html;567.6792612174121;609.9481544068755;622.3807311724835;624.8843963866682;650.6486497291461;42788.99999999996;43974.560254397446;44018.33972490415;44068.338974915365;47002.29496557546;44467.77766111165;44899;44965.55034449654;45074.549254507525;45103.32345014827;9098.31762617803;9261.6295348186;9289.814203715921;9303.860442093373;9311.674091406801;9025.330313891918;9053.50205738684;9107.316951228651;9162.816743665122;9187.678431254908;9121.270298376114;9186.86219706705;9189.1729744323;9190.172884440399;9191.494467804268;9103.908960910372;9183.403078799856;9210.631574737003;9228.307876909224;9246.167844893991;9142.131497507726;9179.862302065474;9245;9257.472517034681;9270.675526356612;43177.56822431798;43228.78385608083;43398;43483.56516434827;43800.56199437997;3548.361294966905;3614.9096272593133;3628.6189950055127;3651.6348365163535;3697.8823202748836;32331.838340808146;32449.188770280933;32816.1795955103;32990.17524561881;33015.17462063444;4332.805023773938;4375.8249670013165;4381.846635367747;4408.581184787472;4556.724117247176;353911;354195;354648;356080.2195989029;356271;35846.46230306548;36918.815405922796;58795;59366.703166483894;60099.39900601025;38088.809555952044;38374.61625383766;38394;38413.23173536514;38667;14653.68116869487;14691.706165876836;14789.778153327708;14790.334434950453;14905.478308259158;12612.873871261354;12636.620901372973;12718.9364053181;12721.363931803373;12831.615051548468;8839.779005524784;8853.73438796837;8880.955595222113;8914.197722205032;8968.820623587491;3461.2904354607244;3485.320362529333;3487.982560087183;3501.142220156078;3564.144605294711;1061.8938106189473;1074.7904158689137;1122.9831552526718;1126.4536699700639;1156.7166044319197;32388.514172287436;32624.510632340534;32810.50784238238;32821;33598.832005840304;1122.887711228887;1124.3254047571393;1144.713821544614;1146.31221267239;1240.6353011687252;16577.17114144288;17072.57318567046;17109.486715398558;17112.315507379815;17139.828601714074;542759;543690;546081;547373;550156;59413;59998;60286.39713602896;60333.39666603278;60337.69831150904;1308.7971364438527;1360.5238166641595;1375.4291968833022;1400.509821562445;1401.1172961034483;29927.251818704706;31066.844665776527;31108.533371998987;31730.365392692478;31844.203894902814;49897;50469.74765126151;50516.49483505118;50525.242121367475;50768.74615626898;421907;423905;424539;425309;427645;28756.42487150287;29963.400731984802;29967;29974;29980.250493737833;48320.5167948316;49138.75430622824;49294.4158122848;49413.75293123511;50596.24105638345;41752;41896;42060.15879682451;42828;42884;36350.63649363472;36368.45447318239;36372.18139092982;36388.27223455569;36454.27091458103;40720;40756.1848763029;41583.37624935568;41615;41710.791446042575;35257.82371088128;37616.81191594025;37789.62210377971;37921;38247.61752382552;28195.43609127765;28641.42717145604;28659.14022579326;28713.42573148567;28983.7101628981 20:33:59 INFO - PROCESS | 25891 | |2;jquery.html;405.3494141902249;407.66367746609046;414.2770864840853;416.80826819662957;424.46517388090996;14340.784888226684;17747.201375938082;19482.318118865842;19801.702974455377;19859.602807943833;16593.585160370996;16858;16914.23885925133;17787;17933.282668693268;5750.971245143768;5756.510696590794;5897.7346019429015;5899.085641725518;6002.549808764338;5788.044972579541;5825.417458254183;5851.15158302046;5852.502537284336;5871.765129394819;5691.686957217351;5718.1136923776885;5794.536437085023;5810.970945145268;5824.184614154022;5736.483716465496;5776.884462310731;5785.074388097926;5792.189093526909;5856.121581762748;5155.9742201288755;5203.271541984125;5243.2659427680155;5244.423113457517;5261.789528418859;22318.330450086523;23255.767442325698;23617.88191059051;24054.398640033964;24064.879675601685;2417.7340492545804;2439.9634005489756;2491.352248415407;2511.836730612504;3048.2988912550018;14713.190774507399;14917.70164596702;15169.317380717894;15320.693586128327;15397.923010384988;1966.6558352288434;1974.5063734066484;2021;2029.9594008119755;2032.6950957356366;56410;70863;75289;77117.99999999943;84502;11138.832917506244;11358.409822624839;11382.94308528452;11606.651800446;11756.823647645293;16305.184740762914;16346.019238845469;16353.83646163547;16416.09711465857;16425.09661968579;7815.413843961725;7856.25365590268;8008.959955200186;8052.959735201286;8518.57407129641;7330.486865919334;7449.068866391701;7811.179826118176;8082.838343233102;8162.30620397261;4867.367242258554;4924.926126108111;4930.975345123252;5089;5093.898122037538;1960.725498430221;1987.522994481314;1990.333238365135;2019.9495012624802;2026.8175864172294;904.968326108583;939.1068072847726;986.9309148359689;996.880374355082;1023.4268809466722;18927.52681182954;19278.903605481883;19534.218631254877;19730.210791568177;19824;1018.3431686562274;1028.3521381529588;1071.9785604288027;1076.520948178069;1077.7467295185625;10218;10998.560057597766;11074.944625276821;11115.888841111486;11132.944335278271;375417;390056;404040;404465;404683;56082.1587676177;65383;84566.57716711378;84747;94163.52918235365;986.0730912941812;996.8205722969935;1010.7574182196367;1012.427978192319;1014.3153371474373;17941.102944852442;18072.90963545174;18191.45425637233;18237.270509179485;18406.81593184051;41550.792246038574;42031.7898410506;42073.579264206965;42452.787736061124;42751.14497709966;58176;58303.12545311739;59305;60888;61238;9007.819843603222;9052.592633331647;9215.907840921505;9252.215473463944;9347.158755712018;12180.512779489076;13528;13536.661583460493;13651.795223071464;13780.517681881087;11679.708007299885;11822.82265765997;11946.522139114339;12090.576829810914;12315.876841231473;11466;11657.53369865196;11657.533698652298;11676.591319303783;11683.532658693557;12003.81994270104;12148.331841748788;12240.081993850676;12403.077522983953;12513.687157821127;8974.86537701948;8989.775255618662;9036;9197.540122993958;9232.676856309998;11740.58907938218;11866.228695134789;12090.75818483643;12129.818052729393;12258.632241032783 20:33:59 INFO - PROCESS | 25891 | |3;mootools.html;1467.4130347860857;1474.8893832962526;1583.8020247469067;1727.3090763694513;1778.8843725157865;7955.960220198891;8237.17628237176;8648.567571621425;9326.90673093269;9338.766530836723;8363.498190108598;8527.829443411129;8852.645894164225;8857.025727170007;8897.510636914967;2357.3517282747252;2423.9272821815284;2424.1757802347197;2424.903003879843;2425.648280999254;2291.633338665814;2331.4987277735286;2336.158982766203;2337.1703045418885;2355.211004313557;2313.35226136682;2325.05835136769;2347.7417484076736;2400.7239167495786;2408.89159987801;2298.230092918874;2308.595995700746;2315.5137421141667;2316.4903721181313;2325.5581439526436;2294.6328587425933;2309.6881920940796;2318.8260880434036;2320.0719712115288;2324.8605083694865;8933.46399216049;8972.775680607972;8986.685466008723;8994.460332380078;9011.143941325563;5229.346331708536;5248.501392367719;5326.733663316857;5343.625946183769;5356.758945847446;3313.3373325334787;3339.5825521809775;3339.883104091345;3411.778234414755;3427.7086447651977;1135.931844089349;1159.1190695071807;1164.5982136163095;1191.9702007449796;1198.7183011992174;12553.184043037265;12794.48822047117;12821.615351539469;12850.485980560767;12851.228926264454;4770.6568643119235;4828.396450443694;4855.562999330077;4898.338724272249;4923.507649235048;10779.407132607781;10822.08012318946;10837.349759014485;10879.075278601407;10883.78232435347;5446.673199608036;5447.754851031634;5454.754536045887;5462.590305727086;5464.3442786865835;4311.4395128633705;4709.670323077352;4769.499202583748;4836.661433699607;4838.250071238964;4138.275801734744;4171.749695018309;4178.91642167155;4195.643370313496;4229.344451610005;1301.6355420482091;1327.7278157977591;1337.625464869838;1346.9730605388033;1357.8099066130749;978.9412635241908;1005.0803514784037;1019.0828254570946;1021.356545376423;1034.9172066234682;6266.154069200691;6339.619622822645;6350.555461117678;6408.134901788292;6430.646314452656;448.1887783112577;452.1928357881166;455.562659846551;456.6871692890381;461.79680940386123;4164.416981622575;4394.1870753910625;4436.600705936481;4478.932816007762;4487.057717879216;10635.840462393071;11015.614453494089;11057.281276716987;11097.889021109848;11097.889021109848;10662.94668526668;11010.953959373846;11049.392283424328;11096.61161859331;11300.717482063013;8092;8199.672013119409;8232.464889782144;8299.709510167237;8345.499270043816;6095.695215239309;6122;6304.873902522016;6308.747650094128;6355.87288254223;9896.059874311928;9932.90738018803;9969.800603988024;10035.69892903214;10135.341202821794;9765.316427850266;10158.034986676254;10186.439745814052;10392.37645741258;10450.843237351597;7049.859002819812;7678.577678227751;7828.804279893048;7878.960605196938;8090.393220508367;8387.706430274911;8445.746627601182;8454.91545084566;8482;8532.91467085346;7581.431392645463;7824.139344672195;7902.130765615662;7915.208479152269;7966.840663186588;7637.198094200029;7662.157162712208;7674.8081297968;7676.078870535572;7864.803379915319;7282.963585182252;7285.307895749896;7285.708571657075;7347.08161479815;7348.77953661391;5335;5412.431694672003;5489.231507589021;5527.060399731975;5620.26936498269;5461.9180712290145;5466.1527463243265;5466.617336786387;5469.2616496772425;5535.944640553704 20:33:59 INFO - PROCESS | 25891 | |4;prototype.html;343.982800859957;344.746611240738;345.9792412455253;349.4600841699574;349.7534238361955;5583.190437386576;5633.71831408429;5666.9433305666935;5681.147827825823;5683.3464151622575;5568.1091025435935;5574.773549819033;5601.131824567188;5612.831615051545;5666.688332141731;4189.832406703728;4224.514180869209;4326.286162783137;4327.480702315726;4344.174606824693;4339.067100573376;4353.847615333464;4356.629686476654;4359;4372.12557488502;4290.69965102443;4306.5262821089655;4312.590303921138;4313.978430107861;4345.3047512398025;4194.0982688721915;4259.978700106495;4360.978195109036;4364.363363738598;4365.519792822787;3783.4461738326518;3820.911040353486;3833.275026238204;3841.615838416164;3841.8463261469506;5325.840224793224;5420.620556561043;5443.618946673734;5462.562994960394;5520.089185284463;4886.462489126193;4912.312276281324;4913.385826771653;4944.134776414113;5019.924701129486;5778.104393818965;5832.650040997553;5866.298773355722;5866.794662186846;5893.941060589425;4196.622303992655;4201.264778663722;4232.470941132358;4237.703360764748;4250.638695710868;5791.82624521265;6117.908231376533;6124.35694252106;6134.754609815646;6175.876482470326;4216.494020717533;4234.110836724322;4237.618614324664;4247.49030116388;4263.467066616673;4266.509351424564;4287.828486860491;4290.399344091829;4296.011917258986;4296.5273819879785;4735.384400028043;4879.194932836042;4889.877753056131;4892.510748925079;4948.158813001798;5821;5947.256592925884;5951.732172052268;5952.9107063394085;5993.31076926159;1475.3729664892592;1487.7056960444484;1503.7593984962573;1506.435086842434;1506.811648543932;965.4110992294694;979.7452662307709;1025.8461230815437;1026.1739299863532;1033.214756784849;5585.860353491195;5592.692401917852;5615.803446879421;5630.943690563124;5659.660420374791;5961.463468287789;6008.639481631116;6014.969925150346;6067.422470157702;6115.235595550556;5382.515573598395;5525.696086715269;5533.363663178706;5563.36021357541;5594.412586678422;3152.574402455685;3167.635721892012;3185.378851124055;3188.1551388881967;3201.1676963989066;6086.573939824169;6155.661438620829;6175.660338681416;6178.258608966953;6207.162033125561;6065.423784740443;6106.786262480792;6116.847078822976;6146.200993870768;6206.72069756862;6016.308124565731;6095.177151084636;6140.004498537993;6187.412195841388;6247.468965137923;5945.286565612154;5959.195508606283;6013.849653758691;6029.698515074141;6040.610659548241;5763.625364351304;5789.697318103393;5890.3226128994;5925.452055616126;5926.318473375617;5826.475617194473;6117.969410153099;6148.262208535004;6155.784547540815;6167.5682702210415;4263.87208383749;4270.829166833416;4274.102438487952;4279.186954478639;4288.549702281215;5821.534277257724;5899.292084949833;5981.282246130492;6024.277086749618;6054.182685337423;5808;5808.332041815245;5856.795012174553;5857.179994800646;5899.970500147643;5644.294463192101;5780.826575202751;5797.5361971041375;5834.241548598655;5870.911936320873;5754.597178197653;5762.366139724711;5764.847030593814;5781.479666830005;5810.186573879576;5921.911171332347;5932.584719069624;5940.405959404025;5956.940430595812;5961.880762384815;5558.777648893999;5771.5671324649975;5823.417658234142;5876.970615146897;5881.529477641864 20:33:59 INFO - PROCESS | 25891 | |5;yui.html;658.3317932298721;696.5054811084133;761.7828918758154;768.3891306411402;840.6301227459917;14235.359408826602;15117.168555729431;15255.542333729978;15408.3836646534;15563.533094007184;14499.927500362483;14681.119132852036;14695.706085878302;14701;14718;671.0906721392516;790.5572879187645;800.3797057280625;814.6944895664126;818.9140140285274;797.7207977207988;802.4743792815685;803.7910143362709;804.8189157439558;805.2551389964289;855.9871601925945;856.1951765340591;856.3662889461784;859.9140085991413;861.1001503428901;845.3575282785066;851.8977722673256;855.8844555984924;856.3106699107216;859.4327743689166;619.0404872447733;619.9442050215503;623.6788054152115;624.8843963866653;626.6678660310043;14764.926175369163;14772.926135369255;14783.186924719135;14936.402543898232;14972.700545989128;13467.259300738455;13672.794908076386;13674.93162534191;13793.517226897011;13900.582982510541;12104.636860894187;12185.207961482476;12232.970978358468;12273.263604183778;12392.81410778839;3776.584575696671;3810.542734871833;3833.6358045985585;3942.5071866016747;3965.861194858166;77861;78028.60985695035;79256.60371698163;80572;81439.18560814376;10057.69826905194;10091.646792362231;10092.293539452168;10245.538950747234;10417.791644167075;21550.568988620453;21817;21880.45298867541;22008.88995555012;22046.779532204473;8544;8610.526421046903;8766.167214114648;8818.382713210141;8832.77918052041;4649.953500464952;4652.092841895866;4656.767161641905;4720.032393359353;4822.517748225219;3229.838508074634;3322.833858307075;3330.6502817204328;3337.1490269981487;3343.21434462901;579.5276849367751;596.0641792385912;596.8060380376395;599.6402158704742;600.1238192239292;630.5082036011918;673.5386260411634;720.2437440687257;748.4573684078999;765.8391737735027;9509.619615215452;9615.23078153746;9690.220813882592;9718.368306060083;9840.311178217456;700.7792545348199;710.3748701142961;718.0772707071388;719.5970256656185;744.5309455043288;4607.262837945913;4656.580907718254;4705.717656940595;4730.645201609824;4771.832985845548;62348.06477902835;63809.68095159494;63838.36161638324;83959.5802020986;105926;60398.69800650969;76710;99311.50344248376;100857.49571252243;101585;53935.73032134814;54177.72911135498;69415;72617.63691181615;88872.5556372227;9369.982147665613;9463.858042129235;9590.616375344907;9627.9037209627;9685.467299298607;48209;48250.51749482601;48671.75664121657;51423.74288128685;55472.72263638656;68427.65786171037;74578.62710686412;76089.23910760821;77792;81439;11872.46573904159;11960.521579136737;12161.452734626786;12440.569334526645;12458.937705311779;13975.30123493801;14591.614565647573;14674.63313417173;14834;15448;12959.287239201934;13269.469221231042;13326.200427974352;13585.388657510633;14395.28023598795;13065.804012939623;13281.136726112773;13519.324033798468;13563.660908477366;13653.590392288248;12397.44211510466;12902.161359511601;13012.804807928078;13622.659433514242;13749.793753093913;10467.371957682564;10790.838137428102;10882.673519794418;11106.888931110585;11261.49323280438;10713.785724285626;10985.670429887115;11170.441477926233;11389.514870855171;11426.600068997544 20:33:59 INFO - PROCESS | 25891 | __end_tp_report 20:33:59 INFO - PROCESS | 25891 | __start_cc_report 20:33:59 INFO - PROCESS | 25891 | _x_x_mozilla_cycle_collect,355 20:33:59 INFO - PROCESS | 25891 | __end_cc_report 20:33:59 INFO - PROCESS | 25891 | __startTimestamp1465961639760__endTimestamp 20:33:59 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | ------- Summary: start ------- 20:33:59 INFO - PROCESS | 25891 | Number of tests: 6 20:33:59 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | [#0] dojo.html Cycles:165 Average:5426.10 Median:5645.94 stddev:722.71 (12.8%) stddev-sans-first:701.89 20:33:59 INFO - PROCESS | 25891 | Values: 3118.8 3185.2 3195.9 3199.1 3215.9 5459.6 5470.2 5492.1 5556.1 5557.9 5396.7 5397.2 5418.1 5448.5 5486.7 4864.8 4906.2 4968.4 5037.9 5077.8 718.8 4967.2 5029.5 5036.4 5100.6 5000.0 5005.3 5028.9 5042.5 5100.2 4939.8 5022.8 5043.9 5048.5 5069.3 4984.2 4999.7 5012.9 5036.8 5083.9 5556.0 5575.6 5577.2 5592.0 5592.4 5673.9 5750.3 5814.7 5917.7 5921.3 5879.8 5903.3 5933.2 5945.3 5965.9 5544.4 5553.8 5554.0 5554.4 5555.6 5932.2 6028.3 6039.5 6049.0 6095.0 5615.1 5616.4 5620.2 5641.5 5700.1 5695.8 5720.3 5722.5 5726.6 5765.6 5524.4 5806.7 5882.6 5905.2 5912.6 5645.9 5753.6 5754.1 5841.5 5913.1 4399.7 4446.8 4459.5 4461.9 4495.3 3894.0 3957.3 3960.3 3963.5 4042.8 5649.4 5651.1 5668.6 5672.5 5676.4 5930.8 5995.8 5998.2 6004.9 6021.4 5470.4 5516.1 5545.4 5584.9 5590.9 4969.7 4991.9 4996.3 5006.4 5062.7 5951.6 6101.1 6112.0 6115.1 6117.0 5918.6 5964.8 5971.2 5989.6 6011.6 6104.5 6143.9 6148.8 6162.6 6189.7 5633.4 5671.5 5817.4 5822.5 5830.4 5805.0 5816.8 5829.8 5852.2 5905.4 5742.9 5747.9 5752.2 5754.5 5757.5 5587.2 5658.0 5684.2 5721.4 5731.5 5571.3 5607.3 5632.9 5654.4 5741.1 5772.9 5789.7 5789.7 5791.3 5793.7 5481.9 5551.1 5610.9 5655.1 5661.2 20:33:59 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | [#1] ext.html Cycles:180 Average:59286.85 Median:41662.90 stddev:119217.65 (286.1%) stddev-sans-first:119470.57 20:33:59 INFO - PROCESS | 25891 | Values: 567.7 609.9 622.4 624.9 650.6 42789.0 43974.6 44018.3 44068.3 47002.3 44467.8 44899.0 44965.6 45074.5 45103.3 9098.3 9261.6 9289.8 9303.9 9311.7 9025.3 9053.5 9107.3 9162.8 9187.7 9121.3 9186.9 9189.2 9190.2 9191.5 9103.9 9183.4 9210.6 9228.3 9246.2 9142.1 9179.9 9245.0 9257.5 9270.7 43177.6 43228.8 43398.0 43483.6 43800.6 3548.4 3614.9 3628.6 3651.6 3697.9 32331.8 32449.2 32816.2 32990.2 33015.2 4332.8 4375.8 4381.8 4408.6 4556.7 353911.0 354195.0 354648.0 356080.2 356271.0 35846.5 36918.8 58795.0 59366.7 60099.4 38088.8 38374.6 38394.0 38413.2 38667.0 14653.7 14691.7 14789.8 14790.3 14905.5 12612.9 12636.6 12718.9 12721.4 12831.6 8839.8 8853.7 8881.0 8914.2 8968.8 3461.3 3485.3 3488.0 3501.1 3564.1 1061.9 1074.8 1123.0 1126.5 1156.7 32388.5 32624.5 32810.5 32821.0 33598.8 1122.9 1124.3 1144.7 1146.3 1240.6 16577.2 17072.6 17109.5 17112.3 17139.8 542759.0 543690.0 546081.0 547373.0 550156.0 59413.0 59998.0 60286.4 60333.4 60337.7 1308.8 1360.5 1375.4 1400.5 1401.1 29927.3 31066.8 31108.5 31730.4 31844.2 49897.0 50469.7 50516.5 50525.2 50768.7 421907.0 423905.0 424539.0 425309.0 427645.0 28756.4 29963.4 29967.0 29974.0 29980.3 48320.5 49138.8 49294.4 49413.8 50596.2 41752.0 41896.0 42060.2 42828.0 42884.0 36350.6 36368.5 36372.2 36388.3 36454.3 40720.0 40756.2 41583.4 41615.0 41710.8 35257.8 37616.8 37789.6 37921.0 38247.6 28195.4 28641.4 28659.1 28713.4 28983.7 20:33:59 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | [#2] jquery.html Cycles:180 Average:26013.17 Median:2465.66 stddev:65398.00 (2652.4%) stddev-sans-first:65553.19 20:33:59 INFO - PROCESS | 25891 | Values: 405.3 407.7 414.3 416.8 424.5 14340.8 17747.2 19482.3 19801.7 19859.6 16593.6 16858.0 16914.2 17787.0 17933.3 5751.0 5756.5 5897.7 5899.1 6002.5 5788.0 5825.4 5851.2 5852.5 5871.8 5691.7 5718.1 5794.5 5811.0 5824.2 5736.5 5776.9 5785.1 5792.2 5856.1 5156.0 5203.3 5243.3 5244.4 5261.8 22318.3 23255.8 23617.9 24054.4 24064.9 2417.7 2440.0 2491.4 2511.8 3048.3 14713.2 14917.7 15169.3 15320.7 15397.9 1966.7 1974.5 2021.0 2030.0 2032.7 56410.0 70863.0 75289.0 77118.0 84502.0 11138.8 11358.4 11382.9 11606.7 11756.8 16305.2 16346.0 16353.8 16416.1 16425.1 7815.4 7856.3 8009.0 8053.0 8518.6 7330.5 7449.1 7811.2 8082.8 8162.3 4867.4 4924.9 4931.0 5089.0 5093.9 1960.7 1987.5 1990.3 2019.9 2026.8 905.0 939.1 986.9 996.9 1023.4 18927.5 19278.9 19534.2 19730.2 19824.0 1018.3 1028.4 1072.0 1076.5 1077.7 10218.0 10998.6 11074.9 11115.9 11132.9 375417.0 390056.0 404040.0 404465.0 404683.0 56082.2 65383.0 84566.6 84747.0 94163.5 986.1 996.8 1010.8 1012.4 1014.3 17941.1 18072.9 18191.5 18237.3 18406.8 41550.8 42031.8 42073.6 42452.8 42751.1 58176.0 58303.1 59305.0 60888.0 61238.0 9007.8 9052.6 9215.9 9252.2 9347.2 12180.5 13528.0 13536.7 13651.8 13780.5 11679.7 11822.8 11946.5 12090.6 12315.9 11466.0 11657.5 11657.5 11676.6 11683.5 12003.8 12148.3 12240.1 12403.1 12513.7 8974.9 8989.8 9036.0 9197.5 9232.7 11740.6 11866.2 12090.8 12129.8 12258.6 20:33:59 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | [#3] mootools.html Cycles:180 Average:5903.89 Median:2585.73 stddev:3354.79 (129.7%) stddev-sans-first:3347.63 20:33:59 INFO - PROCESS | 25891 | Values: 1467.4 1474.9 1583.8 1727.3 1778.9 7956.0 8237.2 8648.6 9326.9 9338.8 8363.5 8527.8 8852.6 8857.0 8897.5 2357.4 2423.9 2424.2 2424.9 2425.6 2291.6 2331.5 2336.2 2337.2 2355.2 2313.4 2325.1 2347.7 2400.7 2408.9 2298.2 2308.6 2315.5 2316.5 2325.6 2294.6 2309.7 2318.8 2320.1 2324.9 8933.5 8972.8 8986.7 8994.5 9011.1 5229.3 5248.5 5326.7 5343.6 5356.8 3313.3 3339.6 3339.9 3411.8 3427.7 1135.9 1159.1 1164.6 1192.0 1198.7 12553.2 12794.5 12821.6 12850.5 12851.2 4770.7 4828.4 4855.6 4898.3 4923.5 10779.4 10822.1 10837.3 10879.1 10883.8 5446.7 5447.8 5454.8 5462.6 5464.3 4311.4 4709.7 4769.5 4836.7 4838.3 4138.3 4171.7 4178.9 4195.6 4229.3 1301.6 1327.7 1337.6 1347.0 1357.8 978.9 1005.1 1019.1 1021.4 1034.9 6266.2 6339.6 6350.6 6408.1 6430.6 448.2 452.2 455.6 456.7 461.8 4164.4 4394.2 4436.6 4478.9 4487.1 10635.8 11015.6 11057.3 11097.9 11097.9 10662.9 11011.0 11049.4 11096.6 11300.7 8092.0 8199.7 8232.5 8299.7 8345.5 6095.7 6122.0 6304.9 6308.7 6355.9 9896.1 9932.9 9969.8 10035.7 10135.3 9765.3 10158.0 10186.4 10392.4 10450.8 7049.9 7678.6 7828.8 7879.0 8090.4 8387.7 8445.7 8454.9 8482.0 8532.9 7581.4 7824.1 7902.1 7915.2 7966.8 7637.2 7662.2 7674.8 7676.1 7864.8 7283.0 7285.3 7285.7 7347.1 7348.8 5335.0 5412.4 5489.2 5527.1 5620.3 5461.9 5466.2 5466.6 5469.3 5535.9 20:33:59 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | [#4] prototype.html Cycles:180 Average:4919.64 Median:5614.32 stddev:1449.12 (25.8%) stddev-sans-first:1411.90 20:33:59 INFO - PROCESS | 25891 | Values: 344.0 344.7 346.0 349.5 349.8 5583.2 5633.7 5666.9 5681.1 5683.3 5568.1 5574.8 5601.1 5612.8 5666.7 4189.8 4224.5 4326.3 4327.5 4344.2 4339.1 4353.8 4356.6 4359.0 4372.1 4290.7 4306.5 4312.6 4314.0 4345.3 4194.1 4260.0 4361.0 4364.4 4365.5 3783.4 3820.9 3833.3 3841.6 3841.8 5325.8 5420.6 5443.6 5462.6 5520.1 4886.5 4912.3 4913.4 4944.1 5019.9 5778.1 5832.7 5866.3 5866.8 5893.9 4196.6 4201.3 4232.5 4237.7 4250.6 5791.8 6117.9 6124.4 6134.8 6175.9 4216.5 4234.1 4237.6 4247.5 4263.5 4266.5 4287.8 4290.4 4296.0 4296.5 4735.4 4879.2 4889.9 4892.5 4948.2 5821.0 5947.3 5951.7 5952.9 5993.3 1475.4 1487.7 1503.8 1506.4 1506.8 965.4 979.7 1025.8 1026.2 1033.2 5585.9 5592.7 5615.8 5630.9 5659.7 5961.5 6008.6 6015.0 6067.4 6115.2 5382.5 5525.7 5533.4 5563.4 5594.4 3152.6 3167.6 3185.4 3188.2 3201.2 6086.6 6155.7 6175.7 6178.3 6207.2 6065.4 6106.8 6116.8 6146.2 6206.7 6016.3 6095.2 6140.0 6187.4 6247.5 5945.3 5959.2 6013.8 6029.7 6040.6 5763.6 5789.7 5890.3 5925.5 5926.3 5826.5 6118.0 6148.3 6155.8 6167.6 4263.9 4270.8 4274.1 4279.2 4288.5 5821.5 5899.3 5981.3 6024.3 6054.2 5808.0 5808.3 5856.8 5857.2 5900.0 5644.3 5780.8 5797.5 5834.2 5870.9 5754.6 5762.4 5764.8 5781.5 5810.2 5921.9 5932.6 5940.4 5956.9 5961.9 5558.8 5771.6 5823.4 5877.0 5881.5 20:33:59 INFO - PROCESS | 25891 | 20:33:59 INFO - PROCESS | 25891 | [#5] yui.html Cycles:180 Average:18884.25 Median:4751.24 stddev:25693.04 (540.8%) stddev-sans-first:25728.66 20:33:59 INFO - PROCESS | 25891 | Values: 658.3 696.5 761.8 768.4 840.6 14235.4 15117.2 15255.5 15408.4 15563.5 14499.9 14681.1 14695.7 14701.0 14718.0 671.1 790.6 800.4 814.7 818.9 797.7 802.5 803.8 804.8 805.3 856.0 856.2 856.4 859.9 861.1 845.4 851.9 855.9 856.3 859.4 619.0 619.9 623.7 624.9 626.7 14764.9 14772.9 14783.2 14936.4 14972.7 13467.3 13672.8 13674.9 13793.5 13900.6 12104.6 12185.2 12233.0 12273.3 12392.8 3776.6 3810.5 3833.6 3942.5 3965.9 77861.0 78028.6 79256.6 80572.0 81439.2 10057.7 10091.6 10092.3 10245.5 10417.8 21550.6 21817.0 21880.5 22008.9 22046.8 8544.0 8610.5 8766.2 8818.4 8832.8 4650.0 4652.1 4656.8 4720.0 4822.5 3229.8 3322.8 3330.7 3337.1 3343.2 579.5 596.1 596.8 599.6 600.1 630.5 673.5 720.2 748.5 765.8 9509.6 9615.2 9690.2 9718.4 9840.3 700.8 710.4 718.1 719.6 744.5 4607.3 4656.6 4705.7 4730.6 4771.8 62348.1 63809.7 63838.4 83959.6 105926.0 60398.7 76710.0 99311.5 100857.5 101585.0 53935.7 54177.7 69415.0 72617.6 88872.6 9370.0 9463.9 9590.6 9627.9 9685.5 48209.0 48250.5 48671.8 51423.7 55472.7 68427.7 74578.6 76089.2 77792.0 81439.0 11872.5 11960.5 12161.5 12440.6 12458.9 13975.3 14591.6 14674.6 14834.0 15448.0 12959.3 13269.5 13326.2 13585.4 14395.3 13065.8 13281.1 13519.3 13563.7 13653.6 12397.4 12902.2 13012.8 13622.7 13749.8 10467.4 10790.8 10882.7 11106.9 11261.5 10713.8 10985.7 11170.4 11389.5 11426.6 20:33:59 INFO - PROCESS | 25891 | -------- Summary: end -------- 20:33:59 INFO - PROCESS | 25891 | 20:34:00 INFO - TEST-INFO | 25891: exit 0 20:34:00 INFO - TEST-OK | dromaeo_css | took 1113882ms 20:34:00 INFO - TEST-START | kraken 20:34:00 INFO - operating with platform_type : linux_ 20:34:00 INFO - Initialising browser for kraken test... 20:34:00 INFO - TEST-INFO | started process 26129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHWcBuW/profile http://localhost:37149/getInfo.html) 20:34:06 INFO - PROCESS | 26129 | __metrics Screen width/height:1600/1200 20:34:06 INFO - PROCESS | 26129 | colorDepth:24 20:34:06 INFO - PROCESS | 26129 | Browser inner width/height: 1024/697 20:34:06 INFO - PROCESS | 26129 | __metrics 20:34:07 ERROR - PROCESS | 26129 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 20:34:08 INFO - TEST-INFO | 26129: exit 0 20:34:08 INFO - Browser initialized. 20:34:08 INFO - Running cycle 1/1 for kraken test... 20:34:08 INFO - TEST-INFO | started process 26247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHWcBuW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:20 INFO - PROCESS | 26247 | RSS: Main: 184885248 20:34:20 INFO - PROCESS | 26247 | 20:34:23 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37149/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:23 INFO - PROCESS | 26247 | RSS: Main: 190296064 20:34:23 INFO - PROCESS | 26247 | 20:34:26 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37149/tests/kraken/driver.html?testName=audio-dft) 20:34:27 INFO - PROCESS | 26247 | RSS: Main: 189681664 20:34:27 INFO - PROCESS | 26247 | 20:34:30 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37149/tests/kraken/driver.html?testName=audio-fft) 20:34:30 INFO - PROCESS | 26247 | RSS: Main: 185430016 20:34:30 INFO - PROCESS | 26247 | 20:34:33 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37149/tests/kraken/driver.html?testName=audio-oscillator) 20:34:33 INFO - PROCESS | 26247 | RSS: Main: 186253312 20:34:33 INFO - PROCESS | 26247 | 20:34:35 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:36 INFO - PROCESS | 26247 | RSS: Main: 186658816 20:34:36 INFO - PROCESS | 26247 | 20:34:39 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37149/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:40 INFO - PROCESS | 26247 | RSS: Main: 187121664 20:34:40 INFO - PROCESS | 26247 | 20:34:43 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37149/tests/kraken/driver.html?testName=imaging-desaturate) 20:34:44 INFO - PROCESS | 26247 | RSS: Main: 183840768 20:34:44 INFO - PROCESS | 26247 | 20:34:47 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37149/tests/kraken/driver.html?testName=json-parse-financial) 20:34:47 INFO - PROCESS | 26247 | RSS: Main: 185487360 20:34:47 INFO - PROCESS | 26247 | 20:34:49 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:34:50 INFO - PROCESS | 26247 | RSS: Main: 185978880 20:34:50 INFO - PROCESS | 26247 | 20:34:51 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37149/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:34:52 INFO - PROCESS | 26247 | RSS: Main: 186175488 20:34:52 INFO - PROCESS | 26247 | 20:34:54 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:34:55 INFO - PROCESS | 26247 | RSS: Main: 186314752 20:34:55 INFO - PROCESS | 26247 | 20:34:57 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:34:58 INFO - PROCESS | 26247 | RSS: Main: 187158528 20:34:58 INFO - PROCESS | 26247 | 20:35:01 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:35:01 INFO - PROCESS | 26247 | RSS: Main: 186638336 20:35:01 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | Cycle 1(1): loaded http://localhost:37149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37149/tests/kraken/driver.html?testName=ai-astar) 20:35:03 INFO - PROCESS | 26247 | RSS: Main: 187465728 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | __start_tp_report 20:35:03 INFO - PROCESS | 26247 | _x_x_mozilla_page_load 20:35:03 INFO - PROCESS | 26247 | _x_x_mozilla_page_load_details 20:35:03 INFO - PROCESS | 26247 | |i|pagename|runs| 20:35:03 INFO - PROCESS | 26247 | |0;ai-astar;111;107;111;110;113;114;109;110;110;113 20:35:03 INFO - PROCESS | 26247 | |1;audio-beat-detection;149;126;162;170;126;154;151;134;199;126 20:35:03 INFO - PROCESS | 26247 | |2;audio-dft;162;162;162;164;167;167;163;164;162;161 20:35:03 INFO - PROCESS | 26247 | |3;audio-fft;74;76;76;154;76;75;75;74;172;75 20:35:03 INFO - PROCESS | 26247 | |4;audio-oscillator;84;84;155;86;85;85;148;85;85;142 20:35:03 INFO - PROCESS | 26247 | |5;imaging-gaussian-blur;118;117;118;117;118;118;117;117;117;119 20:35:03 INFO - PROCESS | 26247 | |6;imaging-darkroom;147;147;147;147;146;147;147;149;148;147 20:35:03 INFO - PROCESS | 26247 | |7;imaging-desaturate;96;96;95;96;96;97;95;96;97;95 20:35:03 INFO - PROCESS | 26247 | |8;json-parse-financial;53;52;54;53;53;56;54;54;54;53 20:35:03 INFO - PROCESS | 26247 | |9;json-stringify-tinderbox;61;61;62;61;62;63;60;61;62;62 20:35:03 INFO - PROCESS | 26247 | |10;stanford-crypto-aes;80;79;79;80;81;81;79;87;112;82 20:35:03 INFO - PROCESS | 26247 | |11;stanford-crypto-ccm;132;126;132;125;121;122;128;132;128;130 20:35:03 INFO - PROCESS | 26247 | |12;stanford-crypto-pbkdf2;163;160;162;160;162;161;160;159;161;157 20:35:03 INFO - PROCESS | 26247 | |13;stanford-crypto-sha256-iterative;64;65;67;65;64;64;66;63;64;64 20:35:03 INFO - PROCESS | 26247 | __end_tp_report 20:35:03 INFO - PROCESS | 26247 | __start_cc_report 20:35:03 INFO - PROCESS | 26247 | _x_x_mozilla_cycle_collect,911 20:35:03 INFO - PROCESS | 26247 | __end_cc_report 20:35:03 INFO - PROCESS | 26247 | __startTimestamp1465961703702__endTimestamp 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | ------- Summary: start ------- 20:35:03 INFO - PROCESS | 26247 | Number of tests: 14 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.10 (1.9%) stddev-sans-first:2.22 20:35:03 INFO - PROCESS | 26247 | Values: 111.0 107.0 111.0 110.0 113.0 114.0 109.0 110.0 110.0 113.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:152.50 stddev:23.44 (15.4%) stddev-sans-first:24.86 20:35:03 INFO - PROCESS | 26247 | Values: 149.0 126.0 162.0 170.0 126.0 154.0 151.0 134.0 199.0 126.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.12 (1.3%) stddev-sans-first:2.19 20:35:03 INFO - PROCESS | 26247 | Values: 162.0 162.0 162.0 164.0 167.0 167.0 163.0 164.0 162.0 161.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:37.30 (49.7%) stddev-sans-first:38.94 20:35:03 INFO - PROCESS | 26247 | Values: 74.0 76.0 76.0 154.0 76.0 75.0 75.0 74.0 172.0 75.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:85.00 stddev:30.82 (36.3%) stddev-sans-first:31.84 20:35:03 INFO - PROCESS | 26247 | Values: 84.0 84.0 155.0 86.0 85.0 85.0 148.0 85.0 85.0 142.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 20:35:03 INFO - PROCESS | 26247 | Values: 118.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 119.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 20:35:03 INFO - PROCESS | 26247 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 147.0 149.0 148.0 147.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 20:35:03 INFO - PROCESS | 26247 | Values: 96.0 96.0 95.0 96.0 96.0 97.0 95.0 96.0 97.0 95.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.07 (2.0%) stddev-sans-first:1.12 20:35:03 INFO - PROCESS | 26247 | Values: 53.0 52.0 54.0 53.0 53.0 56.0 54.0 54.0 54.0 53.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 20:35:03 INFO - PROCESS | 26247 | Values: 61.0 61.0 62.0 61.0 62.0 63.0 60.0 61.0 62.0 62.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:80.50 stddev:10.12 (12.6%) stddev-sans-first:10.63 20:35:03 INFO - PROCESS | 26247 | Values: 80.0 79.0 79.0 80.0 81.0 81.0 79.0 87.0 112.0 82.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.00 stddev:4.06 (3.1%) stddev-sans-first:3.98 20:35:03 INFO - PROCESS | 26247 | Values: 132.0 126.0 132.0 125.0 121.0 122.0 128.0 132.0 128.0 130.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:1.72 (1.1%) stddev-sans-first:1.56 20:35:03 INFO - PROCESS | 26247 | Values: 163.0 160.0 162.0 160.0 162.0 161.0 160.0 159.0 161.0 157.0 20:35:03 INFO - PROCESS | 26247 | 20:35:03 INFO - PROCESS | 26247 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 20:35:03 INFO - PROCESS | 26247 | Values: 64.0 65.0 67.0 65.0 64.0 64.0 66.0 63.0 64.0 64.0 20:35:03 INFO - PROCESS | 26247 | -------- Summary: end -------- 20:35:03 INFO - PROCESS | 26247 | 20:35:04 INFO - TEST-INFO | 26247: exit 0 20:35:04 INFO - TEST-OK | kraken | took 64378ms 20:35:04 INFO - SUITE-END | took 1178s 20:35:05 INFO - Completed test suite (00:19:38) 20:35:05 INFO - javascript benchmark 20:35:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7258.590892645013, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.7504999600033, 3185.1877771168365, 3195.8561864716094, 3199.1202419334695, 3215.8713651453945, 5459.563234941205, 5470.179473079035, 5492.148716948869, 5556.111022236443, 5557.861053473665, 5396.730163491829, 5397.163439666848, 5418.133098704208, 5448.509634132927, 5486.725663716818, 4864.829730959408, 4906.190478571031, 4968.428630707461, 5037.924431133536, 5077.822276220333, 718.8123895420014, 4967.205247160455, 5029.547340739333, 5036.445990940993, 5100.617453690988, 4999.9500004999845, 5005.299258103868, 5028.874278143039, 5042.520960508746, 5100.158473851847, 4939.827106051271, 5022.77397517109, 5043.873903152414, 5048.5203905628905, 5069.290299358093, 4984.177610694231, 4999.675021123615, 5012.899742005139, 5036.84889453317, 5083.923741143886, 5555.972220138914, 5575.5539556835765, 5577.247071645316, 5592.049351610236, 5592.356878958931, 5673.943260567383, 5750.252467179282, 5814.709264536798, 5917.704114794243, 5921.289445266552, 5879.794207202727, 5903.291605007426, 5933.228680271537, 5945.256842894638, 5965.8806823863715, 5544.417836127229, 5553.8333849984565, 5554.028045092133, 5554.389017208104, 5555.555555555546, 5932.228810254725, 6028.306744724413, 6039.486643635252, 6048.969755151196, 6095.045420286402, 5615.129654903497, 5616.410276920865, 5620.241267428844, 5641.492265696107, 5700.144978253295, 5695.829125126253, 5720.342160651495, 5722.484976352148, 5726.627769194989, 5765.567582431335, 5524.447555244524, 5806.68063256525, 5882.617629854131, 5905.232319798484, 5912.556558258148, 5645.943540564624, 5753.568482363756, 5754.05058165398, 5841.474267315962, 5913.083472061838, 4399.670024748157, 4446.777661116931, 4459.509453960061, 4461.888452788707, 4495.280755079171, 3894.0264933766557, 3957.3470377387985, 3960.34654282046, 3963.504561929759, 4042.7776472293717, 5649.350324712711, 5651.095824668033, 5668.57485688575, 5672.461116193955, 5676.432356764373, 5930.7924222652, 5995.760169593254, 5998.220231369894, 6004.909926351108, 6021.42796434338, 5470.370907345627, 5516.089845175581, 5545.417731138253, 5584.86037849057, 5590.944090559043, 4969.676970996874, 4991.875203119951, 4996.300517927493, 5006.4492905780335, 5062.721550314768, 5951.583389162717, 6101.115338275925, 6112.0, 6115.143879856823, 6116.990696535022, 5918.644881307221, 5964.821055368346, 5971.223740913653, 5989.610675306091, 6011.639301641915, 6104.511639068775, 6143.877122457437, 6148.754049837957, 6162.630242185483, 6189.721462534287, 5633.352164501135, 5671.461211184931, 5817.447342502455, 5822.505087067647, 5830.416958304136, 5804.970975145097, 5816.796412125555, 5829.8251052468495, 5852.209951656472, 5905.35041145465, 5742.856428589152, 5747.942520574908, 5752.223449834219, 5754.4533269339345, 5757.453041961007, 5587.161925711176, 5658.0, 5684.204211410323, 5721.427857214412, 5731.512821410227, 5571.275734154534, 5607.271054762855, 5632.88734225305, 5654.434556544313, 5741.081426971665, 5772.913406298825, 5789.681567513659, 5789.739461724317, 5791.276090488689, 5793.681347525927, 5481.917771233355, 5551.056320425457, 5610.85972850682, 5655.123455864347, 5661.179129026351], "value": 5379.263375700377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6792612174121, 609.9481544068755, 622.3807311724835, 624.8843963866682, 650.6486497291461, 42788.99999999996, 43974.560254397446, 44018.33972490415, 44068.338974915365, 47002.29496557546, 44467.77766111165, 44899.0, 44965.55034449654, 45074.549254507525, 45103.32345014827, 9098.31762617803, 9261.6295348186, 9289.814203715921, 9303.860442093373, 9311.674091406801, 9025.330313891918, 9053.50205738684, 9107.316951228651, 9162.816743665122, 9187.678431254908, 9121.270298376114, 9186.86219706705, 9189.1729744323, 9190.172884440399, 9191.494467804268, 9103.908960910372, 9183.403078799856, 9210.631574737003, 9228.307876909224, 9246.167844893991, 9142.131497507726, 9179.862302065474, 9245.0, 9257.472517034681, 9270.675526356612, 43177.56822431798, 43228.78385608083, 43398.0, 43483.56516434827, 43800.56199437997, 3548.361294966905, 3614.9096272593133, 3628.6189950055127, 3651.6348365163535, 3697.8823202748836, 32331.838340808146, 32449.188770280933, 32816.1795955103, 32990.17524561881, 33015.17462063444, 4332.805023773938, 4375.8249670013165, 4381.846635367747, 4408.581184787472, 4556.724117247176, 353911.0, 354195.0, 354648.0, 356080.2195989029, 356271.0, 35846.46230306548, 36918.815405922796, 58795.0, 59366.703166483894, 60099.39900601025, 38088.809555952044, 38374.61625383766, 38394.0, 38413.23173536514, 38667.0, 14653.68116869487, 14691.706165876836, 14789.778153327708, 14790.334434950453, 14905.478308259158, 12612.873871261354, 12636.620901372973, 12718.9364053181, 12721.363931803373, 12831.615051548468, 8839.779005524784, 8853.73438796837, 8880.955595222113, 8914.197722205032, 8968.820623587491, 3461.2904354607244, 3485.320362529333, 3487.982560087183, 3501.142220156078, 3564.144605294711, 1061.8938106189473, 1074.7904158689137, 1122.9831552526718, 1126.4536699700639, 1156.7166044319197, 32388.514172287436, 32624.510632340534, 32810.50784238238, 32821.0, 33598.832005840304, 1122.887711228887, 1124.3254047571393, 1144.713821544614, 1146.31221267239, 1240.6353011687252, 16577.17114144288, 17072.57318567046, 17109.486715398558, 17112.315507379815, 17139.828601714074, 542759.0, 543690.0, 546081.0, 547373.0, 550156.0, 59413.0, 59998.0, 60286.39713602896, 60333.39666603278, 60337.69831150904, 1308.7971364438527, 1360.5238166641595, 1375.4291968833022, 1400.509821562445, 1401.1172961034483, 29927.251818704706, 31066.844665776527, 31108.533371998987, 31730.365392692478, 31844.203894902814, 49897.0, 50469.74765126151, 50516.49483505118, 50525.242121367475, 50768.74615626898, 421907.0, 423905.0, 424539.0, 425309.0, 427645.0, 28756.42487150287, 29963.400731984802, 29967.0, 29974.0, 29980.250493737833, 48320.5167948316, 49138.75430622824, 49294.4158122848, 49413.75293123511, 50596.24105638345, 41752.0, 41896.0, 42060.15879682451, 42828.0, 42884.0, 36350.63649363472, 36368.45447318239, 36372.18139092982, 36388.27223455569, 36454.27091458103, 40720.0, 40756.1848763029, 41583.37624935568, 41615.0, 41710.791446042575, 35257.82371088128, 37616.81191594025, 37789.62210377971, 37921.0, 38247.61752382552, 28195.43609127765, 28641.42717145604, 28659.14022579326, 28713.42573148567, 28983.7101628981], "value": 19194.954989631202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.3494141902249, 407.66367746609046, 414.2770864840853, 416.80826819662957, 424.46517388090996, 14340.784888226684, 17747.201375938082, 19482.318118865842, 19801.702974455377, 19859.602807943833, 16593.585160370996, 16858.0, 16914.23885925133, 17787.0, 17933.282668693268, 5750.971245143768, 5756.510696590794, 5897.7346019429015, 5899.085641725518, 6002.549808764338, 5788.044972579541, 5825.417458254183, 5851.15158302046, 5852.502537284336, 5871.765129394819, 5691.686957217351, 5718.1136923776885, 5794.536437085023, 5810.970945145268, 5824.184614154022, 5736.483716465496, 5776.884462310731, 5785.074388097926, 5792.189093526909, 5856.121581762748, 5155.9742201288755, 5203.271541984125, 5243.2659427680155, 5244.423113457517, 5261.789528418859, 22318.330450086523, 23255.767442325698, 23617.88191059051, 24054.398640033964, 24064.879675601685, 2417.7340492545804, 2439.9634005489756, 2491.352248415407, 2511.836730612504, 3048.2988912550018, 14713.190774507399, 14917.70164596702, 15169.317380717894, 15320.693586128327, 15397.923010384988, 1966.6558352288434, 1974.5063734066484, 2021.0, 2029.9594008119755, 2032.6950957356366, 56410.0, 70863.0, 75289.0, 77117.99999999943, 84502.0, 11138.832917506244, 11358.409822624839, 11382.94308528452, 11606.651800446, 11756.823647645293, 16305.184740762914, 16346.019238845469, 16353.83646163547, 16416.09711465857, 16425.09661968579, 7815.413843961725, 7856.25365590268, 8008.959955200186, 8052.959735201286, 8518.57407129641, 7330.486865919334, 7449.068866391701, 7811.179826118176, 8082.838343233102, 8162.30620397261, 4867.367242258554, 4924.926126108111, 4930.975345123252, 5089.0, 5093.898122037538, 1960.725498430221, 1987.522994481314, 1990.333238365135, 2019.9495012624802, 2026.8175864172294, 904.968326108583, 939.1068072847726, 986.9309148359689, 996.880374355082, 1023.4268809466722, 18927.52681182954, 19278.903605481883, 19534.218631254877, 19730.210791568177, 19824.0, 1018.3431686562274, 1028.3521381529588, 1071.9785604288027, 1076.520948178069, 1077.7467295185625, 10218.0, 10998.560057597766, 11074.944625276821, 11115.888841111486, 11132.944335278271, 375417.0, 390056.0, 404040.0, 404465.0, 404683.0, 56082.1587676177, 65383.0, 84566.57716711378, 84747.0, 94163.52918235365, 986.0730912941812, 996.8205722969935, 1010.7574182196367, 1012.427978192319, 1014.3153371474373, 17941.102944852442, 18072.90963545174, 18191.45425637233, 18237.270509179485, 18406.81593184051, 41550.792246038574, 42031.7898410506, 42073.579264206965, 42452.787736061124, 42751.14497709966, 58176.0, 58303.12545311739, 59305.0, 60888.0, 61238.0, 9007.819843603222, 9052.592633331647, 9215.907840921505, 9252.215473463944, 9347.158755712018, 12180.512779489076, 13528.0, 13536.661583460493, 13651.795223071464, 13780.517681881087, 11679.708007299885, 11822.82265765997, 11946.522139114339, 12090.576829810914, 12315.876841231473, 11466.0, 11657.53369865196, 11657.533698652298, 11676.591319303783, 11683.532658693557, 12003.81994270104, 12148.331841748788, 12240.081993850676, 12403.077522983953, 12513.687157821127, 8974.86537701948, 8989.775255618662, 9036.0, 9197.540122993958, 9232.676856309998, 11740.58907938218, 11866.228695134789, 12090.75818483643, 12129.818052729393, 12258.632241032783], "value": 9335.119722673962, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.4130347860857, 1474.8893832962526, 1583.8020247469067, 1727.3090763694513, 1778.8843725157865, 7955.960220198891, 8237.17628237176, 8648.567571621425, 9326.90673093269, 9338.766530836723, 8363.498190108598, 8527.829443411129, 8852.645894164225, 8857.025727170007, 8897.510636914967, 2357.3517282747252, 2423.9272821815284, 2424.1757802347197, 2424.903003879843, 2425.648280999254, 2291.633338665814, 2331.4987277735286, 2336.158982766203, 2337.1703045418885, 2355.211004313557, 2313.35226136682, 2325.05835136769, 2347.7417484076736, 2400.7239167495786, 2408.89159987801, 2298.230092918874, 2308.595995700746, 2315.5137421141667, 2316.4903721181313, 2325.5581439526436, 2294.6328587425933, 2309.6881920940796, 2318.8260880434036, 2320.0719712115288, 2324.8605083694865, 8933.46399216049, 8972.775680607972, 8986.685466008723, 8994.460332380078, 9011.143941325563, 5229.346331708536, 5248.501392367719, 5326.733663316857, 5343.625946183769, 5356.758945847446, 3313.3373325334787, 3339.5825521809775, 3339.883104091345, 3411.778234414755, 3427.7086447651977, 1135.931844089349, 1159.1190695071807, 1164.5982136163095, 1191.9702007449796, 1198.7183011992174, 12553.184043037265, 12794.48822047117, 12821.615351539469, 12850.485980560767, 12851.228926264454, 4770.6568643119235, 4828.396450443694, 4855.562999330077, 4898.338724272249, 4923.507649235048, 10779.407132607781, 10822.08012318946, 10837.349759014485, 10879.075278601407, 10883.78232435347, 5446.673199608036, 5447.754851031634, 5454.754536045887, 5462.590305727086, 5464.3442786865835, 4311.4395128633705, 4709.670323077352, 4769.499202583748, 4836.661433699607, 4838.250071238964, 4138.275801734744, 4171.749695018309, 4178.91642167155, 4195.643370313496, 4229.344451610005, 1301.6355420482091, 1327.7278157977591, 1337.625464869838, 1346.9730605388033, 1357.8099066130749, 978.9412635241908, 1005.0803514784037, 1019.0828254570946, 1021.356545376423, 1034.9172066234682, 6266.154069200691, 6339.619622822645, 6350.555461117678, 6408.134901788292, 6430.646314452656, 448.1887783112577, 452.1928357881166, 455.562659846551, 456.6871692890381, 461.79680940386123, 4164.416981622575, 4394.1870753910625, 4436.600705936481, 4478.932816007762, 4487.057717879216, 10635.840462393071, 11015.614453494089, 11057.281276716987, 11097.889021109848, 11097.889021109848, 10662.94668526668, 11010.953959373846, 11049.392283424328, 11096.61161859331, 11300.717482063013, 8092.0, 8199.672013119409, 8232.464889782144, 8299.709510167237, 8345.499270043816, 6095.695215239309, 6122.0, 6304.873902522016, 6308.747650094128, 6355.87288254223, 9896.059874311928, 9932.90738018803, 9969.800603988024, 10035.69892903214, 10135.341202821794, 9765.316427850266, 10158.034986676254, 10186.439745814052, 10392.37645741258, 10450.843237351597, 7049.859002819812, 7678.577678227751, 7828.804279893048, 7878.960605196938, 8090.393220508367, 8387.706430274911, 8445.746627601182, 8454.91545084566, 8482.0, 8532.91467085346, 7581.431392645463, 7824.139344672195, 7902.130765615662, 7915.208479152269, 7966.840663186588, 7637.198094200029, 7662.157162712208, 7674.8081297968, 7676.078870535572, 7864.803379915319, 7282.963585182252, 7285.307895749896, 7285.708571657075, 7347.08161479815, 7348.77953661391, 5335.0, 5412.431694672003, 5489.231507589021, 5527.060399731975, 5620.26936498269, 5461.9180712290145, 5466.1527463243265, 5466.617336786387, 5469.2616496772425, 5535.944640553704], "value": 4653.4626801308505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.982800859957, 344.746611240738, 345.9792412455253, 349.4600841699574, 349.7534238361955, 5583.190437386576, 5633.71831408429, 5666.9433305666935, 5681.147827825823, 5683.3464151622575, 5568.1091025435935, 5574.773549819033, 5601.131824567188, 5612.831615051545, 5666.688332141731, 4189.832406703728, 4224.514180869209, 4326.286162783137, 4327.480702315726, 4344.174606824693, 4339.067100573376, 4353.847615333464, 4356.629686476654, 4359.0, 4372.12557488502, 4290.69965102443, 4306.5262821089655, 4312.590303921138, 4313.978430107861, 4345.3047512398025, 4194.0982688721915, 4259.978700106495, 4360.978195109036, 4364.363363738598, 4365.519792822787, 3783.4461738326518, 3820.911040353486, 3833.275026238204, 3841.615838416164, 3841.8463261469506, 5325.840224793224, 5420.620556561043, 5443.618946673734, 5462.562994960394, 5520.089185284463, 4886.462489126193, 4912.312276281324, 4913.385826771653, 4944.134776414113, 5019.924701129486, 5778.104393818965, 5832.650040997553, 5866.298773355722, 5866.794662186846, 5893.941060589425, 4196.622303992655, 4201.264778663722, 4232.470941132358, 4237.703360764748, 4250.638695710868, 5791.82624521265, 6117.908231376533, 6124.35694252106, 6134.754609815646, 6175.876482470326, 4216.494020717533, 4234.110836724322, 4237.618614324664, 4247.49030116388, 4263.467066616673, 4266.509351424564, 4287.828486860491, 4290.399344091829, 4296.011917258986, 4296.5273819879785, 4735.384400028043, 4879.194932836042, 4889.877753056131, 4892.510748925079, 4948.158813001798, 5821.0, 5947.256592925884, 5951.732172052268, 5952.9107063394085, 5993.31076926159, 1475.3729664892592, 1487.7056960444484, 1503.7593984962573, 1506.435086842434, 1506.811648543932, 965.4110992294694, 979.7452662307709, 1025.8461230815437, 1026.1739299863532, 1033.214756784849, 5585.860353491195, 5592.692401917852, 5615.803446879421, 5630.943690563124, 5659.660420374791, 5961.463468287789, 6008.639481631116, 6014.969925150346, 6067.422470157702, 6115.235595550556, 5382.515573598395, 5525.696086715269, 5533.363663178706, 5563.36021357541, 5594.412586678422, 3152.574402455685, 3167.635721892012, 3185.378851124055, 3188.1551388881967, 3201.1676963989066, 6086.573939824169, 6155.661438620829, 6175.660338681416, 6178.258608966953, 6207.162033125561, 6065.423784740443, 6106.786262480792, 6116.847078822976, 6146.200993870768, 6206.72069756862, 6016.308124565731, 6095.177151084636, 6140.004498537993, 6187.412195841388, 6247.468965137923, 5945.286565612154, 5959.195508606283, 6013.849653758691, 6029.698515074141, 6040.610659548241, 5763.625364351304, 5789.697318103393, 5890.3226128994, 5925.452055616126, 5926.318473375617, 5826.475617194473, 6117.969410153099, 6148.262208535004, 6155.784547540815, 6167.5682702210415, 4263.87208383749, 4270.829166833416, 4274.102438487952, 4279.186954478639, 4288.549702281215, 5821.534277257724, 5899.292084949833, 5981.282246130492, 6024.277086749618, 6054.182685337423, 5808.0, 5808.332041815245, 5856.795012174553, 5857.179994800646, 5899.970500147643, 5644.294463192101, 5780.826575202751, 5797.5361971041375, 5834.241548598655, 5870.911936320873, 5754.597178197653, 5762.366139724711, 5764.847030593814, 5781.479666830005, 5810.186573879576, 5921.911171332347, 5932.584719069624, 5940.405959404025, 5956.940430595812, 5961.880762384815, 5558.777648893999, 5771.5671324649975, 5823.417658234142, 5876.970615146897, 5881.529477641864], "value": 4457.856074361885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.3317932298721, 696.5054811084133, 761.7828918758154, 768.3891306411402, 840.6301227459917, 14235.359408826602, 15117.168555729431, 15255.542333729978, 15408.3836646534, 15563.533094007184, 14499.927500362483, 14681.119132852036, 14695.706085878302, 14701.0, 14718.0, 671.0906721392516, 790.5572879187645, 800.3797057280625, 814.6944895664126, 818.9140140285274, 797.7207977207988, 802.4743792815685, 803.7910143362709, 804.8189157439558, 805.2551389964289, 855.9871601925945, 856.1951765340591, 856.3662889461784, 859.9140085991413, 861.1001503428901, 845.3575282785066, 851.8977722673256, 855.8844555984924, 856.3106699107216, 859.4327743689166, 619.0404872447733, 619.9442050215503, 623.6788054152115, 624.8843963866653, 626.6678660310043, 14764.926175369163, 14772.926135369255, 14783.186924719135, 14936.402543898232, 14972.700545989128, 13467.259300738455, 13672.794908076386, 13674.93162534191, 13793.517226897011, 13900.582982510541, 12104.636860894187, 12185.207961482476, 12232.970978358468, 12273.263604183778, 12392.81410778839, 3776.584575696671, 3810.542734871833, 3833.6358045985585, 3942.5071866016747, 3965.861194858166, 77861.0, 78028.60985695035, 79256.60371698163, 80572.0, 81439.18560814376, 10057.69826905194, 10091.646792362231, 10092.293539452168, 10245.538950747234, 10417.791644167075, 21550.568988620453, 21817.0, 21880.45298867541, 22008.88995555012, 22046.779532204473, 8544.0, 8610.526421046903, 8766.167214114648, 8818.382713210141, 8832.77918052041, 4649.953500464952, 4652.092841895866, 4656.767161641905, 4720.032393359353, 4822.517748225219, 3229.838508074634, 3322.833858307075, 3330.6502817204328, 3337.1490269981487, 3343.21434462901, 579.5276849367751, 596.0641792385912, 596.8060380376395, 599.6402158704742, 600.1238192239292, 630.5082036011918, 673.5386260411634, 720.2437440687257, 748.4573684078999, 765.8391737735027, 9509.619615215452, 9615.23078153746, 9690.220813882592, 9718.368306060083, 9840.311178217456, 700.7792545348199, 710.3748701142961, 718.0772707071388, 719.5970256656185, 744.5309455043288, 4607.262837945913, 4656.580907718254, 4705.717656940595, 4730.645201609824, 4771.832985845548, 62348.06477902835, 63809.68095159494, 63838.36161638324, 83959.5802020986, 105926.0, 60398.69800650969, 76710.0, 99311.50344248376, 100857.49571252243, 101585.0, 53935.73032134814, 54177.72911135498, 69415.0, 72617.63691181615, 88872.5556372227, 9369.982147665613, 9463.858042129235, 9590.616375344907, 9627.9037209627, 9685.467299298607, 48209.0, 48250.51749482601, 48671.75664121657, 51423.74288128685, 55472.72263638656, 68427.65786171037, 74578.62710686412, 76089.23910760821, 77792.0, 81439.0, 11872.46573904159, 11960.521579136737, 12161.452734626786, 12440.569334526645, 12458.937705311779, 13975.30123493801, 14591.614565647573, 14674.63313417173, 14834.0, 15448.0, 12959.287239201934, 13269.469221231042, 13326.200427974352, 13585.388657510633, 14395.28023598795, 13065.804012939623, 13281.136726112773, 13519.324033798468, 13563.660908477366, 13653.590392288248, 12397.44211510466, 12902.161359511601, 13012.804807928078, 13622.659433514242, 13749.793753093913, 10467.371957682564, 10790.838137428102, 10882.673519794418, 11106.888931110585, 11261.49323280438, 10713.785724285626, 10985.670429887115, 11170.441477926233, 11389.514870855171, 11426.600068997544], "value": 7313.762085194986, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 111.0, 110.0, 113.0, 114.0, 109.0, 110.0, 110.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 162.0, 170.0, 126.0, 154.0, 151.0, 134.0, 199.0, 126.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 164.0, 167.0, 167.0, 163.0, 164.0, 162.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 154.0, 76.0, 75.0, 75.0, 74.0, 172.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 86.0, 85.0, 85.0, 148.0, 85.0, 85.0, 142.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 149.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 95.0, 96.0, 97.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 53.0, 53.0, 56.0, 54.0, 54.0, 54.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 63.0, 60.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 81.0, 81.0, 79.0, 87.0, 112.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 126.0, 132.0, 125.0, 121.0, 122.0, 128.0, 132.0, 128.0, 130.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 160.0, 162.0, 161.0, 160.0, 159.0, 161.0, 157.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 65.0, 64.0, 64.0, 66.0, 63.0, 64.0, 64.0], "value": 64.6, "unit": "score"}]}]} 20:35:05 INFO - Return code: 0 20:35:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:35:05 ERROR - # TBPL SUCCESS # 20:35:05 INFO - Running post-action listener: _resource_record_post_action 20:35:05 INFO - ##### 20:35:05 INFO - ##### Finished run-tests step (success) 20:35:05 INFO - ##### 20:35:05 INFO - Running post-run listener: _resource_record_post_run 20:35:05 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 4096; Write bytes: 566501376; Read time: 12; Write time: 2291336 20:35:05 INFO - TinderboxPrint: CPU usage
13.7% 20:35:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:35:05 INFO - TinderboxPrint: I/O write bytes / time
566,501,376 / 2,291,336 20:35:05 INFO - TinderboxPrint: CPU idle
8,263.4 (86.3%) 20:35:05 INFO - TinderboxPrint: CPU user
1,224.7 (12.8%) 20:35:05 INFO - TinderboxPrint: Swap in / out
0 / 0 20:35:05 INFO - install - Wall time: 20s; CPU: 21.0%; Read bytes: 0; Write bytes: 255459328; Read time: 0; Write time: 1447484 20:35:05 INFO - run-tests - Wall time: 1180s; CPU: 14.0%; Read bytes: 4096; Write bytes: 295755776; Read time: 12; Write time: 832460 20:35:06 INFO - Running post-run listener: _upload_blobber_files 20:35:06 INFO - Blob upload gear active. 20:35:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:35:06 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 20:35:06 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'] 20:35:06 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 20:35:06 INFO - (blobuploader) - INFO - Open directory for files ... 20:35:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:35:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:35:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:07 INFO - (blobuploader) - INFO - Done attempting. 20:35:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:35:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:11 INFO - (blobuploader) - INFO - Done attempting. 20:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:11 INFO - (blobuploader) - INFO - Done attempting. 20:35:11 INFO - (blobuploader) - INFO - Iteration through files over. 20:35:11 INFO - Return code: 0 20:35:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:35:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:35:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9b64653ada1d8d7527a4f158654dcffc57082aa48f5ca9175b221e463e1de1416c804808ebafa6a30ef0df9a00083c2c3bc443cd3bc4bb82dcf806657098e81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/284ef814834a7d36cba64594f8df0e3058427a0988e1b2f77486cf3e6df3fa8d88971e5efef2ab6a28ee6ef0a88df4cf5d8a9f5a7776f4e3a62b1093d7e46f45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/202f091be4d505644029117afd1b162aff28cfc6eca7c3165405aa7b1d1fb3fb547f98afb87ced9fd66abbb1e55b670fad3439ef29732f89ee5248fd8cbff02d"} 20:35:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:35:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:35:11 INFO - Contents: 20:35:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9b64653ada1d8d7527a4f158654dcffc57082aa48f5ca9175b221e463e1de1416c804808ebafa6a30ef0df9a00083c2c3bc443cd3bc4bb82dcf806657098e81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/284ef814834a7d36cba64594f8df0e3058427a0988e1b2f77486cf3e6df3fa8d88971e5efef2ab6a28ee6ef0a88df4cf5d8a9f5a7776f4e3a62b1093d7e46f45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/202f091be4d505644029117afd1b162aff28cfc6eca7c3165405aa7b1d1fb3fb547f98afb87ced9fd66abbb1e55b670fad3439ef29732f89ee5248fd8cbff02d"} 20:35:11 INFO - Running post-run listener: copy_logs_to_upload_dir 20:35:11 INFO - Copying logs to upload dir... 20:35:11 INFO - mkdir: /builds/slave/test/build/upload/logs 20:35:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.314682 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-14 20:35:11.824791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 20:35:11.828027) ========= 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=8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9b64653ada1d8d7527a4f158654dcffc57082aa48f5ca9175b221e463e1de1416c804808ebafa6a30ef0df9a00083c2c3bc443cd3bc4bb82dcf806657098e81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/284ef814834a7d36cba64594f8df0e3058427a0988e1b2f77486cf3e6df3fa8d88971e5efef2ab6a28ee6ef0a88df4cf5d8a9f5a7776f4e3a62b1093d7e46f45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/202f091be4d505644029117afd1b162aff28cfc6eca7c3165405aa7b1d1fb3fb547f98afb87ced9fd66abbb1e55b670fad3439ef29732f89ee5248fd8cbff02d"} build_url:https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/RXlXUSD5Q52nbOSLFKj_MQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9b64653ada1d8d7527a4f158654dcffc57082aa48f5ca9175b221e463e1de1416c804808ebafa6a30ef0df9a00083c2c3bc443cd3bc4bb82dcf806657098e81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/284ef814834a7d36cba64594f8df0e3058427a0988e1b2f77486cf3e6df3fa8d88971e5efef2ab6a28ee6ef0a88df4cf5d8a9f5a7776f4e3a62b1093d7e46f45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/202f091be4d505644029117afd1b162aff28cfc6eca7c3165405aa7b1d1fb3fb547f98afb87ced9fd66abbb1e55b670fad3439ef29732f89ee5248fd8cbff02d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 20:35:11.854531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:35:11.854903) ========= 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=8783db0840cc980e80bb0bd400000236-1465954830.52777-418898304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:35:11.937875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 20:35:11.938232) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 20:35:11.938577) ========= ========= Total master_lag: 0.17 =========