builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1465431113.74 results: success (0) buildid: 20160608143002 builduid: 97e75280e81449e3b3a4410e9740a2e3 revision: 97074800423c429ca7ae01ca5db8c2e61b0fee17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:53.745144) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:53.745594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:53.745890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:53.761057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:53.761395) ========= 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=745a4373a2a16df560f216e000000264-1465431113.347518-1666325503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 17:11:54-- 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% 46.6M=0s 2016-06-08 17:11:54 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.330066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:54.105207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:54.108585) ========= 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=745a4373a2a16df560f216e000000264-1465431113.347518-1666325503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017567 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:54.158435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 17:11:54.161848) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 97074800423c429ca7ae01ca5db8c2e61b0fee17 --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 97074800423c429ca7ae01ca5db8c2e61b0fee17 --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=745a4373a2a16df560f216e000000264-1465431113.347518-1666325503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 17:11:54,451 truncating revision to first 12 chars 2016-06-08 17:11:54,451 Setting DEBUG logging. 2016-06-08 17:11:54,451 attempt 1/10 2016-06-08 17:11:54,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/97074800423c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 17:11:55,274 unpacking tar archive at: fx-team-97074800423c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.130342 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 17:11:55.412140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:55.412487) ========= script_repo_revision: 97074800423c429ca7ae01ca5db8c2e61b0fee17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:55.412893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:55.413168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:11:55.427756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-08 17:11:55.428142) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1465431113.347518-1666325503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:11:55 INFO - MultiFileLogger online at 20160608 17:11:55 in /builds/slave/test 17:11:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:11:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:11:55 INFO - {'append_to_log': False, 17:11:55 INFO - 'base_work_dir': '/builds/slave/test', 17:11:55 INFO - 'blob_upload_branch': 'Fx-Team', 17:11:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:11:55 INFO - 'branch': 'Fx-Team', 17:11:55 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:55 INFO - 'config_files': ('talos/linux_config.py',), 17:11:55 INFO - 'default_actions': ('clobber', 17:11:55 INFO - 'read-buildbot-config', 17:11:55 INFO - 'download-and-extract', 17:11:55 INFO - 'populate-webroot', 17:11:55 INFO - 'create-virtualenv', 17:11:55 INFO - 'install', 17:11:55 INFO - 'run-tests'), 17:11:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:55 INFO - 'download_minidump_stackwalk': True, 17:11:55 INFO - 'download_symbols': 'ondemand', 17:11:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:11:55 INFO - 'tooltool.py': '/tools/tooltool.py', 17:11:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:11:55 INFO - '/tools/misc-python/virtualenv.py')}, 17:11:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:55 INFO - 'installer_path': 'installer.exe', 17:11:55 INFO - 'log_level': 'info', 17:11:55 INFO - 'log_name': 'talos', 17:11:55 INFO - 'log_to_console': True, 17:11:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:11:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:11:55 INFO - 'opt_config_files': (), 17:11:55 INFO - 'pip_index': False, 17:11:55 INFO - 'sps_profile': False, 17:11:55 INFO - 'sps_profile_interval': 0, 17:11:55 INFO - 'suite': 'dromaeojs', 17:11:55 INFO - 'system_bits': '32', 17:11:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:55 INFO - 'title': 'talos-linux64-ix-032', 17:11:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:55 INFO - 'use_talos_json': True, 17:11:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:11:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:55 INFO - 'work_dir': 'build'} 17:11:55 INFO - ##### 17:11:55 INFO - ##### Running clobber step. 17:11:55 INFO - ##### 17:11:55 INFO - Running pre-action listener: _resource_record_pre_action 17:11:55 INFO - Running main action method: clobber 17:11:55 INFO - rmtree: /builds/slave/test/build 17:11:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:11:56 INFO - Running post-action listener: _resource_record_post_action 17:11:56 INFO - ##### 17:11:56 INFO - ##### Finished clobber step (success) 17:11:56 INFO - ##### 17:11:56 INFO - ##### 17:11:56 INFO - ##### Running read-buildbot-config step. 17:11:56 INFO - ##### 17:11:56 INFO - Running pre-action listener: _resource_record_pre_action 17:11:56 INFO - Running main action method: read_buildbot_config 17:11:56 INFO - Using buildbot properties: 17:11:56 INFO - { 17:11:56 INFO - "project": "", 17:11:56 INFO - "product": "firefox", 17:11:56 INFO - "script_repo_revision": "production", 17:11:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:11:56 INFO - "repository": "", 17:11:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:11:56 INFO - "buildid": "20160608143002", 17:11:56 INFO - "pgo_build": "True", 17:11:56 INFO - "basedir": "/builds/slave/test", 17:11:56 INFO - "buildnumber": 1241, 17:11:56 INFO - "slavename": "talos-linux64-ix-032", 17:11:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:11:56 INFO - "platform": "ubuntu64_hw", 17:11:56 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:11:56 INFO - "branch": "fx-team", 17:11:56 INFO - "repo_path": "integration/fx-team", 17:11:56 INFO - "revision": "97074800423c429ca7ae01ca5db8c2e61b0fee17", 17:11:56 INFO - "stage_platform": "linux64-pgo", 17:11:56 INFO - "builduid": "97e75280e81449e3b3a4410e9740a2e3", 17:11:56 INFO - "slavebuilddir": "test" 17:11:56 INFO - } 17:11:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:11:56 INFO - Running post-action listener: _resource_record_post_action 17:11:56 INFO - ##### 17:11:56 INFO - ##### Finished read-buildbot-config step (success) 17:11:56 INFO - ##### 17:11:56 INFO - ##### 17:11:56 INFO - ##### Running download-and-extract step. 17:11:56 INFO - ##### 17:11:56 INFO - Running pre-action listener: _resource_record_pre_action 17:11:56 INFO - Running main action method: download_and_extract 17:11:56 INFO - mkdir: /builds/slave/test/build/tests 17:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:56 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:11:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:11:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:11:57 INFO - Downloaded 1361 bytes. 17:11:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:57 INFO - Using the following test package requirements: 17:11:57 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:11:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:11:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:57 INFO - u'jsshell-linux-x86_64.zip'], 17:11:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:11:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:11:57 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:11:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:11:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:11:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:11: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')]} 17:11:57 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:11:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:11:58 INFO - Downloaded 24450461 bytes. 17:11:58 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'] 17:11:58 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 17:11:59 INFO - Return code: 0 17:11:59 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 17:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:59 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:12:00 INFO - Downloaded 24450461 bytes. 17:12:00 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'] 17:12:00 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 17:12:02 INFO - Return code: 0 17:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:02 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:12:03 INFO - Downloaded 10833369 bytes. 17:12:03 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'] 17:12:03 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 17:12:03 INFO - Return code: 0 17:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:03 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/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 17:12:05 INFO - Downloaded 59325241 bytes. 17:12:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:05 INFO - mkdir: /builds/slave/test/properties 17:12:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:05 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:05 INFO - Contents: 17:12:05 INFO - build_url:https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:06 INFO - Running post-action listener: _resource_record_post_action 17:12:06 INFO - Running post-action listener: set_extra_try_arguments 17:12:06 INFO - ##### 17:12:06 INFO - ##### Finished download-and-extract step (success) 17:12:06 INFO - ##### 17:12:06 INFO - ##### 17:12:06 INFO - ##### Running populate-webroot step. 17:12:06 INFO - ##### 17:12:06 INFO - Running pre-action listener: _resource_record_pre_action 17:12:06 INFO - Running main action method: populate_webroot 17:12:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:06 INFO - '--tppagecycles', 17:12:06 INFO - '7'], 17:12:06 INFO - 'tests': ['tsvgm']}}, 17:12:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:06 INFO - 'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:06 INFO - 'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['damp', 'tps']}, 17:12:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:06 INFO - 'tests': ['damp', 'tps']}, 17:12:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['dromaeo_dom']}, 17:12:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['a11yr', 17:12:06 INFO - 'ts_paint', 17:12:06 INFO - 'tpaint', 17:12:06 INFO - 'sessionrestore', 17:12:06 INFO - 'sessionrestore_no_auto_restore', 17:12:06 INFO - 'tabpaint']}, 17:12:06 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:06 INFO - 'ts_paint', 17:12:06 INFO - 'tpaint', 17:12:06 INFO - 'sessionrestore', 17:12:06 INFO - 'sessionrestore_no_auto_restore', 17:12:06 INFO - 'tabpaint']}, 17:12:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:12:06 INFO - 'ts_paint', 17:12:06 INFO - 'tpaint', 17:12:06 INFO - 'sessionrestore', 17:12:06 INFO - 'sessionrestore_no_auto_restore', 17:12:06 INFO - 'tabpaint']}, 17:12:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:12:06 INFO - 'ts_paint', 17:12:06 INFO - 'tpaint', 17:12:06 INFO - 'sessionrestore', 17:12:06 INFO - 'sessionrestore_no_auto_restore', 17:12:06 INFO - 'tabpaint']}, 17:12:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['a11yr', 17:12:06 INFO - 'ts_paint', 17:12:06 INFO - 'tpaint', 17:12:06 INFO - 'sessionrestore', 17:12:06 INFO - 'sessionrestore_no_auto_restore', 17:12:06 INFO - 'tabpaint']}, 17:12:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['a11yr', 17:12:06 INFO - 'ts_paint', 17:12:06 INFO - 'tpaint', 17:12:06 INFO - 'sessionrestore', 17:12:06 INFO - 'sessionrestore_no_auto_restore', 17:12:06 INFO - 'tabpaint']}, 17:12:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['tsvgx', 17:12:06 INFO - 'tsvgr_opacity', 17:12:06 INFO - 'tart', 17:12:06 INFO - 'tscrollx', 17:12:06 INFO - 'cart']}, 17:12:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:06 INFO - 'tsvgr_opacity', 17:12:06 INFO - 'tart', 17:12:06 INFO - 'tscrollx', 17:12:06 INFO - 'cart']}, 17:12:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:06 INFO - 'talos_options': ['--disable-e10s'], 17:12:06 INFO - 'tests': ['tp5o']}, 17:12:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:06 INFO - 'tests': ['tp5o']}, 17:12:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:06 INFO - 'talos_options': ['--disable-e10s', 17:12:06 INFO - '--xperf_path', 17:12:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:06 INFO - 'tests': ['tp5n']}, 17:12:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:06 INFO - 'talos_options': ['--xperf_path', 17:12:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:06 INFO - 'tests': ['tp5n']}}, 17:12:06 INFO - 'talos.zip': {'path': '', 17:12:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:06 INFO - Running post-action listener: _resource_record_post_action 17:12:06 INFO - ##### 17:12:06 INFO - ##### Finished populate-webroot step (success) 17:12:06 INFO - ##### 17:12:06 INFO - ##### 17:12:06 INFO - ##### Running create-virtualenv step. 17:12:06 INFO - ##### 17:12:06 INFO - Running pre-action listener: _resource_record_pre_action 17:12:06 INFO - Running main action method: create_virtualenv 17:12:06 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:12:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:06 INFO - Using real prefix '/usr' 17:12:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:06 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:08 INFO - Installing pip.................done. 17:12:08 INFO - Return code: 0 17:12:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:08 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 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:12:08 INFO - Using env: {'DISPLAY': ':0', 17:12:08 INFO - 'HOME': '/home/cltbld', 17:12:08 INFO - 'LANG': 'en_US.UTF-8', 17:12:08 INFO - 'LANGUAGE': 'en_US:en', 17:12:08 INFO - 'LOGNAME': 'cltbld', 17:12:08 INFO - 'MAIL': '/var/mail/cltbld', 17:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:08 INFO - 'MOZ_NO_REMOTE': '1', 17:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:08 INFO - 'NO_EM_RESTART': '1', 17:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:08 INFO - 'PWD': '/builds/slave/test', 17:12:08 INFO - 'SHELL': '/bin/bash', 17:12:08 INFO - 'SHLVL': '1', 17:12:08 INFO - 'TERM': 'linux', 17:12:08 INFO - 'TMOUT': '86400', 17:12:08 INFO - 'USER': 'cltbld', 17:12:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:08 INFO - '_': '/tools/buildbot/bin/python'} 17:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:12:08 INFO - Cleaning up... 17:12:08 INFO - Return code: 0 17:12:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:08 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 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:08 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 17:12:08 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 17:12:08 INFO - Using env: {'DISPLAY': ':0', 17:12:08 INFO - 'HOME': '/home/cltbld', 17:12:08 INFO - 'LANG': 'en_US.UTF-8', 17:12:08 INFO - 'LANGUAGE': 'en_US:en', 17:12:08 INFO - 'LOGNAME': 'cltbld', 17:12:08 INFO - 'MAIL': '/var/mail/cltbld', 17:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:08 INFO - 'MOZ_NO_REMOTE': '1', 17:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:08 INFO - 'NO_EM_RESTART': '1', 17:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:08 INFO - 'PWD': '/builds/slave/test', 17:12:08 INFO - 'SHELL': '/bin/bash', 17:12:08 INFO - 'SHLVL': '1', 17:12:08 INFO - 'TERM': 'linux', 17:12:08 INFO - 'TMOUT': '86400', 17:12:08 INFO - 'USER': 'cltbld', 17:12:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:08 INFO - '_': '/tools/buildbot/bin/python'} 17:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:09 INFO - Downloading/unpacking psutil>=3.1.1 17:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:11 INFO - Installing collected packages: psutil 17:12:11 INFO - Running setup.py install for psutil 17:12:11 INFO - building 'psutil._psutil_linux' extension 17:12:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:12:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:12:11 INFO - building 'psutil._psutil_posix' extension 17:12:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:12:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:12:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:11 INFO - Successfully installed psutil 17:12:11 INFO - Cleaning up... 17:12:11 INFO - Return code: 0 17:12:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:11 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 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:11 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 17:12:11 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 17:12:11 INFO - Using env: {'DISPLAY': ':0', 17:12:11 INFO - 'HOME': '/home/cltbld', 17:12:11 INFO - 'LANG': 'en_US.UTF-8', 17:12:11 INFO - 'LANGUAGE': 'en_US:en', 17:12:11 INFO - 'LOGNAME': 'cltbld', 17:12:11 INFO - 'MAIL': '/var/mail/cltbld', 17:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:11 INFO - 'MOZ_NO_REMOTE': '1', 17:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:11 INFO - 'NO_EM_RESTART': '1', 17:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:11 INFO - 'PWD': '/builds/slave/test', 17:12:11 INFO - 'SHELL': '/bin/bash', 17:12:11 INFO - 'SHLVL': '1', 17:12:11 INFO - 'TERM': 'linux', 17:12:11 INFO - 'TMOUT': '86400', 17:12:11 INFO - 'USER': 'cltbld', 17:12:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:11 INFO - '_': '/tools/buildbot/bin/python'} 17:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:12:13 INFO - Installing collected packages: mozsystemmonitor 17:12:13 INFO - Running setup.py install for mozsystemmonitor 17:12:14 INFO - Successfully installed mozsystemmonitor 17:12:14 INFO - Cleaning up... 17:12:14 INFO - Return code: 0 17:12:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:14 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 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:14 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 17:12:14 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 17:12:14 INFO - Using env: {'DISPLAY': ':0', 17:12:14 INFO - 'HOME': '/home/cltbld', 17:12:14 INFO - 'LANG': 'en_US.UTF-8', 17:12:14 INFO - 'LANGUAGE': 'en_US:en', 17:12:14 INFO - 'LOGNAME': 'cltbld', 17:12:14 INFO - 'MAIL': '/var/mail/cltbld', 17:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:14 INFO - 'MOZ_NO_REMOTE': '1', 17:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:14 INFO - 'NO_EM_RESTART': '1', 17:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:14 INFO - 'PWD': '/builds/slave/test', 17:12:14 INFO - 'SHELL': '/bin/bash', 17:12:14 INFO - 'SHLVL': '1', 17:12:14 INFO - 'TERM': 'linux', 17:12:14 INFO - 'TMOUT': '86400', 17:12:14 INFO - 'USER': 'cltbld', 17:12:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:14 INFO - '_': '/tools/buildbot/bin/python'} 17:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:14 INFO - Downloading/unpacking jsonschema==2.5.1 17:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:16 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:16 INFO - warning: no files found matching '*.txt' 17:12:16 INFO - no previously-included directories found matching 'build' 17:12:16 INFO - no previously-included directories found matching 'dist' 17:12:16 INFO - no previously-included directories found matching '.git*' 17:12:16 INFO - Installing collected packages: jsonschema, functools32 17:12:16 INFO - Running setup.py install for functools32 17:12:16 INFO - warning: no files found matching '*.txt' 17:12:16 INFO - no previously-included directories found matching 'build' 17:12:16 INFO - no previously-included directories found matching 'dist' 17:12:16 INFO - no previously-included directories found matching '.git*' 17:12:16 INFO - Successfully installed jsonschema functools32 17:12:16 INFO - Cleaning up... 17:12:16 INFO - Return code: 0 17:12:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:16 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 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:12:16 INFO - Using env: {'DISPLAY': ':0', 17:12:16 INFO - 'HOME': '/home/cltbld', 17:12:16 INFO - 'LANG': 'en_US.UTF-8', 17:12:16 INFO - 'LANGUAGE': 'en_US:en', 17:12:16 INFO - 'LOGNAME': 'cltbld', 17:12:16 INFO - 'MAIL': '/var/mail/cltbld', 17:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:16 INFO - 'MOZ_NO_REMOTE': '1', 17:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:16 INFO - 'NO_EM_RESTART': '1', 17:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:16 INFO - 'PWD': '/builds/slave/test', 17:12:16 INFO - 'SHELL': '/bin/bash', 17:12:16 INFO - 'SHLVL': '1', 17:12:16 INFO - 'TERM': 'linux', 17:12:16 INFO - 'TMOUT': '86400', 17:12:16 INFO - 'USER': 'cltbld', 17:12:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:16 INFO - '_': '/tools/buildbot/bin/python'} 17:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:16 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:18 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:19 INFO - Downloading docopt-0.6.1.tar.gz 17:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:19 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:19 INFO - Running setup.py install for blobuploader 17:12:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:19 INFO - Running setup.py install for requests 17:12:19 INFO - Running setup.py install for docopt 17:12:19 INFO - Successfully installed blobuploader requests docopt 17:12:19 INFO - Cleaning up... 17:12:20 INFO - Return code: 0 17:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:20 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 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:12:20 INFO - Using env: {'DISPLAY': ':0', 17:12:20 INFO - 'HOME': '/home/cltbld', 17:12:20 INFO - 'LANG': 'en_US.UTF-8', 17:12:20 INFO - 'LANGUAGE': 'en_US:en', 17:12:20 INFO - 'LOGNAME': 'cltbld', 17:12:20 INFO - 'MAIL': '/var/mail/cltbld', 17:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:20 INFO - 'MOZ_NO_REMOTE': '1', 17:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:20 INFO - 'NO_EM_RESTART': '1', 17:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:20 INFO - 'PWD': '/builds/slave/test', 17:12:20 INFO - 'SHELL': '/bin/bash', 17:12:20 INFO - 'SHLVL': '1', 17:12:20 INFO - 'TERM': 'linux', 17:12:20 INFO - 'TMOUT': '86400', 17:12:20 INFO - 'USER': 'cltbld', 17:12:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:20 INFO - '_': '/tools/buildbot/bin/python'} 17:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:20 INFO - Running setup.py (path:/tmp/pip-TNZFJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:20 INFO - Running setup.py (path:/tmp/pip-ZZ3DE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:20 INFO - Running setup.py (path:/tmp/pip-zxtq3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:20 INFO - Running setup.py (path:/tmp/pip-O6GQwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:20 INFO - Running setup.py (path:/tmp/pip-Ivi1EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:20 INFO - Running setup.py (path:/tmp/pip-aoUftI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:20 INFO - Running setup.py (path:/tmp/pip-QdS9JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:20 INFO - Running setup.py (path:/tmp/pip-0PeRP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:20 INFO - Running setup.py (path:/tmp/pip-1c567D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:20 INFO - Running setup.py (path:/tmp/pip-L4wcsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:20 INFO - Running setup.py (path:/tmp/pip-cQSipF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:21 INFO - Running setup.py (path:/tmp/pip-P2HayA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:21 INFO - Running setup.py (path:/tmp/pip-ZW8bvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:21 INFO - Running setup.py (path:/tmp/pip-eKwXsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:21 INFO - Running setup.py (path:/tmp/pip-IDNx16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:21 INFO - Running setup.py (path:/tmp/pip-MKiL3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:21 INFO - Running setup.py (path:/tmp/pip-KmpXfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:21 INFO - Running setup.py install for manifestparser 17:12:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Running setup.py install for mozcrash 17:12:21 INFO - Running setup.py install for mozdebug 17:12:21 INFO - Running setup.py install for mozdevice 17:12:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:21 INFO - Running setup.py install for mozfile 17:12:22 INFO - Running setup.py install for mozhttpd 17:12:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Running setup.py install for mozinfo 17:12:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Running setup.py install for mozInstall 17:12:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Running setup.py install for mozleak 17:12:22 INFO - Running setup.py install for mozlog 17:12:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Running setup.py install for moznetwork 17:12:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Running setup.py install for mozprocess 17:12:22 INFO - Running setup.py install for mozprofile 17:12:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Running setup.py install for mozrunner 17:12:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Running setup.py install for mozscreenshot 17:12:23 INFO - Running setup.py install for moztest 17:12:23 INFO - Running setup.py install for mozversion 17:12:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:12:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:23 INFO - Cleaning up... 17:12:23 INFO - Return code: 0 17:12:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:23 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 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:12:23 INFO - Using env: {'DISPLAY': ':0', 17:12:23 INFO - 'HOME': '/home/cltbld', 17:12:23 INFO - 'LANG': 'en_US.UTF-8', 17:12:23 INFO - 'LANGUAGE': 'en_US:en', 17:12:23 INFO - 'LOGNAME': 'cltbld', 17:12:23 INFO - 'MAIL': '/var/mail/cltbld', 17:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:23 INFO - 'MOZ_NO_REMOTE': '1', 17:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:23 INFO - 'NO_EM_RESTART': '1', 17:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:23 INFO - 'PWD': '/builds/slave/test', 17:12:23 INFO - 'SHELL': '/bin/bash', 17:12:23 INFO - 'SHLVL': '1', 17:12:23 INFO - 'TERM': 'linux', 17:12:23 INFO - 'TMOUT': '86400', 17:12:23 INFO - 'USER': 'cltbld', 17:12:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:23 INFO - '_': '/tools/buildbot/bin/python'} 17:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:23 INFO - Running setup.py (path:/tmp/pip-U_eK5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:23 INFO - Running setup.py (path:/tmp/pip-vyNhl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:23 INFO - Running setup.py (path:/tmp/pip-1TtVT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:23 INFO - Running setup.py (path:/tmp/pip-Awggsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:23 INFO - Running setup.py (path:/tmp/pip-utBHLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:23 INFO - Running setup.py (path:/tmp/pip-iSgSl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:23 INFO - Running setup.py (path:/tmp/pip-V0xBE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:23 INFO - Running setup.py (path:/tmp/pip-a47FfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:24 INFO - Running setup.py (path:/tmp/pip-Xszeuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:24 INFO - Running setup.py (path:/tmp/pip-7TCUj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:24 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)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:24 INFO - Running setup.py (path:/tmp/pip-QhcFK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:24 INFO - Running setup.py (path:/tmp/pip-mrub0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:24 INFO - Running setup.py (path:/tmp/pip-NgHG5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:24 INFO - Running setup.py (path:/tmp/pip-03H9A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:24 INFO - Running setup.py (path:/tmp/pip-8Dal5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:24 INFO - Running setup.py (path:/tmp/pip-H5Gf1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:24 INFO - Running setup.py (path:/tmp/pip-_vSOot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:12:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:26 INFO - Downloading blessings-1.6.tar.gz 17:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:26 INFO - Installing collected packages: blessings 17:12:26 INFO - Running setup.py install for blessings 17:12:26 INFO - Successfully installed blessings 17:12:26 INFO - Cleaning up... 17:12:26 INFO - Return code: 0 17:12:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:27 INFO - Reading from file tmpfile_stdout 17:12:27 INFO - Current package versions: 17:12:27 INFO - argparse == 1.2.1 17:12:27 INFO - blessings == 1.6 17:12:27 INFO - blobuploader == 1.2.4 17:12:27 INFO - docopt == 0.6.1 17:12:27 INFO - functools32 == 3.2.3-2 17:12:27 INFO - jsonschema == 2.5.1 17:12:27 INFO - manifestparser == 1.1 17:12:27 INFO - mozInstall == 1.12 17:12:27 INFO - mozcrash == 0.17 17:12:27 INFO - mozdebug == 0.1 17:12:27 INFO - mozdevice == 0.48 17:12:27 INFO - mozfile == 1.2 17:12:27 INFO - mozhttpd == 0.7 17:12:27 INFO - mozinfo == 0.9 17:12:27 INFO - mozleak == 0.1 17:12:27 INFO - mozlog == 3.2 17:12:27 INFO - moznetwork == 0.27 17:12:27 INFO - mozprocess == 0.22 17:12:27 INFO - mozprofile == 0.28 17:12:27 INFO - mozrunner == 6.11 17:12:27 INFO - mozscreenshot == 0.1 17:12:27 INFO - mozsystemmonitor == 0.3 17:12:27 INFO - moztest == 0.7 17:12:27 INFO - mozversion == 1.4 17:12:27 INFO - psutil == 3.1.1 17:12:27 INFO - requests == 1.2.3 17:12:27 INFO - wsgiref == 0.1.2 17:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:27 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 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:12:27 INFO - Using env: {'DISPLAY': ':0', 17:12:27 INFO - 'HOME': '/home/cltbld', 17:12:27 INFO - 'LANG': 'en_US.UTF-8', 17:12:27 INFO - 'LANGUAGE': 'en_US:en', 17:12:27 INFO - 'LOGNAME': 'cltbld', 17:12:27 INFO - 'MAIL': '/var/mail/cltbld', 17:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:27 INFO - 'MOZ_NO_REMOTE': '1', 17:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:27 INFO - 'NO_EM_RESTART': '1', 17:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:27 INFO - 'PWD': '/builds/slave/test', 17:12:27 INFO - 'SHELL': '/bin/bash', 17:12:27 INFO - 'SHLVL': '1', 17:12:27 INFO - 'TERM': 'linux', 17:12:27 INFO - 'TMOUT': '86400', 17:12:27 INFO - 'USER': 'cltbld', 17:12:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:27 INFO - '_': '/tools/buildbot/bin/python'} 17:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:12:27 INFO - Cleaning up... 17:12:27 INFO - Return code: 0 17:12:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:12:27 INFO - Using env: {'DISPLAY': ':0', 17:12:27 INFO - 'HOME': '/home/cltbld', 17:12:27 INFO - 'LANG': 'en_US.UTF-8', 17:12:27 INFO - 'LANGUAGE': 'en_US:en', 17:12:27 INFO - 'LOGNAME': 'cltbld', 17:12:27 INFO - 'MAIL': '/var/mail/cltbld', 17:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:27 INFO - 'MOZ_NO_REMOTE': '1', 17:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:27 INFO - 'NO_EM_RESTART': '1', 17:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:27 INFO - 'PWD': '/builds/slave/test', 17:12:27 INFO - 'SHELL': '/bin/bash', 17:12:27 INFO - 'SHLVL': '1', 17:12:27 INFO - 'TERM': 'linux', 17:12:27 INFO - 'TMOUT': '86400', 17:12:27 INFO - 'USER': 'cltbld', 17:12:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:27 INFO - '_': '/tools/buildbot/bin/python'} 17:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:12:27 INFO - Cleaning up... 17:12:27 INFO - Return code: 0 17:12:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47aa07ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, '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': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:12:27 INFO - Using env: {'DISPLAY': ':0', 17:12:27 INFO - 'HOME': '/home/cltbld', 17:12:27 INFO - 'LANG': 'en_US.UTF-8', 17:12:27 INFO - 'LANGUAGE': 'en_US:en', 17:12:27 INFO - 'LOGNAME': 'cltbld', 17:12:27 INFO - 'MAIL': '/var/mail/cltbld', 17:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:27 INFO - 'MOZ_NO_REMOTE': '1', 17:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:27 INFO - 'NO_EM_RESTART': '1', 17:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:27 INFO - 'PWD': '/builds/slave/test', 17:12:27 INFO - 'SHELL': '/bin/bash', 17:12:27 INFO - 'SHLVL': '1', 17:12:27 INFO - 'TERM': 'linux', 17:12:27 INFO - 'TMOUT': '86400', 17:12:27 INFO - 'USER': 'cltbld', 17:12:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:27 INFO - '_': '/tools/buildbot/bin/python'} 17:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:27 INFO - Downloading/unpacking flake8 17:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:12:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:12:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:12:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:30 INFO - no previously-included directories found matching 'docs/_build' 17:12:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:12:30 INFO - Running setup.py install for pep8 17:12:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:30 INFO - no previously-included directories found matching 'docs/_build' 17:12:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:12:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:12:30 INFO - Cleaning up... 17:12:30 INFO - Return code: 0 17:12:30 INFO - Running post-action listener: _resource_record_post_action 17:12:30 INFO - Running post-action listener: _start_resource_monitoring 17:12:30 INFO - Starting resource monitoring. 17:12:30 INFO - ##### 17:12:30 INFO - ##### Finished create-virtualenv step (success) 17:12:30 INFO - ##### 17:12:30 INFO - ##### 17:12:30 INFO - ##### Running install step. 17:12:30 INFO - ##### 17:12:30 INFO - Running pre-action listener: _resource_record_pre_action 17:12:30 INFO - Running main action method: install 17:12:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:30 INFO - Reading from file tmpfile_stdout 17:12:30 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:30 INFO - Reading from file tmpfile_stdout 17:12:30 INFO - Output received: 17:12:30 INFO - Usage: mozinstall [options] installer 17:12:30 INFO - Options: 17:12:30 INFO - -h, --help show this help message and exit 17:12:30 INFO - -d DEST, --destination=DEST 17:12:30 INFO - Directory to install application into. [default: 17:12:30 INFO - "/builds/slave/test"] 17:12:30 INFO - --app=APP Application being installed. [default: firefox] 17:12:30 INFO - mkdir: /builds/slave/test/build/application 17:12:30 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'] 17:12:30 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 17:12:50 INFO - Reading from file tmpfile_stdout 17:12:50 INFO - Output received: 17:12:50 INFO - /builds/slave/test/build/application/firefox/firefox 17:12:50 INFO - Running post-action listener: _resource_record_post_action 17:12:50 INFO - ##### 17:12:50 INFO - ##### Finished install step (success) 17:12:50 INFO - ##### 17:12:50 INFO - ##### 17:12:50 INFO - ##### Running run-tests step. 17:12:50 INFO - ##### 17:12:50 INFO - Running pre-action listener: _resource_record_pre_action 17:12:50 INFO - Running main action method: run_tests 17:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:50 INFO - Python 2.7.3 17:12:50 INFO - Return code: 0 17:12:50 INFO - grabbing minidump binary from tooltool 17:12: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')]} 17:12:50 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 0x2cb9110>, '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 0x2c25230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c256c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:12:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:12:50 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 17:12:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:50 INFO - Return code: 0 17:12:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:12:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:12:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:12:51 INFO - Return code: 0 17:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:12:51 INFO - Using env: {'DISPLAY': ':0', 17:12:51 INFO - 'HOME': '/home/cltbld', 17:12:51 INFO - 'LANG': 'en_US.UTF-8', 17:12:51 INFO - 'LANGUAGE': 'en_US:en', 17:12:51 INFO - 'LOGNAME': 'cltbld', 17:12:51 INFO - 'MAIL': '/var/mail/cltbld', 17:12:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:51 INFO - 'MOZ_NO_REMOTE': '1', 17:12:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:51 INFO - 'NO_EM_RESTART': '1', 17:12:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:51 INFO - 'PWD': '/builds/slave/test', 17:12:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:51 INFO - 'SHELL': '/bin/bash', 17:12:51 INFO - 'SHLVL': '1', 17:12:51 INFO - 'TERM': 'linux', 17:12:51 INFO - 'TMOUT': '86400', 17:12:51 INFO - 'USER': 'cltbld', 17:12:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1465431113.347518-1666325503', 17:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:51 INFO - '_': '/tools/buildbot/bin/python'} 17:12:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:12:51 INFO - mozversion application_buildid: 20160608143002 17:12:51 INFO - mozversion application_changeset: 97074800423c429ca7ae01ca5db8c2e61b0fee17 17:12:51 INFO - mozversion application_display_name: Nightly 17:12:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:51 INFO - mozversion application_name: Firefox 17:12:51 INFO - mozversion application_remotingname: firefox 17:12:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:12:51 INFO - mozversion application_vendor: Mozilla 17:12:51 INFO - mozversion application_version: 50.0a1 17:12:51 INFO - mozversion platform_buildid: 20160608143002 17:12:51 INFO - mozversion platform_changeset: 97074800423c429ca7ae01ca5db8c2e61b0fee17 17:12:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:12:51 INFO - mozversion platform_version: 50.0a1 17:12:51 INFO - using testdate: 1465431171 17:12:51 INFO - actual date: 1465431171 17:12:51 INFO - starting webserver on 'localhost:42415' 17:12:51 INFO - SUITE-START | Running 2 tests 17:12:51 INFO - TEST-START | dromaeo_css 17:12:51 INFO - operating with platform_type : linux_ 17:12:51 INFO - Initialising browser for dromaeo_css test... 17:12:51 INFO - TEST-INFO | started process 18704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWjh30C/profile http://localhost:42415/getInfo.html) 17:12:56 INFO - PROCESS | 18704 | __metrics Screen width/height:1600/1200 17:12:56 INFO - PROCESS | 18704 | colorDepth:24 17:12:56 INFO - PROCESS | 18704 | Browser inner width/height: 1024/697 17:12:56 INFO - PROCESS | 18704 | __metrics 17:12:57 ERROR - PROCESS | 18704 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:12:58 INFO - PROCESS | 18704 | console.error: PushService: 17:12:58 INFO - PROCESS | 18704 | stateChangeProcessEnqueue: Error transitioning state 17:12:58 INFO - PROCESS | 18704 | UnknownError 17:12:58 INFO - TEST-INFO | 18704: exit 0 17:12:58 INFO - Browser initialized. 17:12:58 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:58 INFO - TEST-INFO | started process 18785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWjh30C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:10 INFO - PROCESS | 18785 | RSS: Main: 156246016 17:13:10 INFO - PROCESS | 18785 | 17:14:01 INFO - PROCESS | 18785 | 1465431241771 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:16:09 INFO - PROCESS | 18785 | Cycle 1(1): loaded http://localhost:42415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42415/tests/dromaeo/cssquery-ext.html) 17:16:10 INFO - PROCESS | 18785 | RSS: Main: 245600256 17:16:10 INFO - PROCESS | 18785 | 17:19:13 INFO - PROCESS | 18785 | Cycle 1(1): loaded http://localhost:42415/tests/dromaeo/cssquery-ext.html (next: http://localhost:42415/tests/dromaeo/cssquery-jquery.html) 17:19:13 INFO - PROCESS | 18785 | RSS: Main: 250023936 17:19:13 INFO - PROCESS | 18785 | 17:22:15 INFO - PROCESS | 18785 | Cycle 1(1): loaded http://localhost:42415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42415/tests/dromaeo/cssquery-mootools.html) 17:22:16 INFO - PROCESS | 18785 | RSS: Main: 243032064 17:22:16 INFO - PROCESS | 18785 | 17:25:18 INFO - PROCESS | 18785 | Cycle 1(1): loaded http://localhost:42415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42415/tests/dromaeo/cssquery-prototype.html) 17:25:19 INFO - PROCESS | 18785 | RSS: Main: 243470336 17:25:19 INFO - PROCESS | 18785 | 17:28:21 INFO - PROCESS | 18785 | Cycle 1(1): loaded http://localhost:42415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42415/tests/dromaeo/cssquery-yui.html) 17:28:22 INFO - PROCESS | 18785 | RSS: Main: 205250560 17:28:22 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | Cycle 1(1): loaded http://localhost:42415/tests/dromaeo/cssquery-yui.html (next: http://localhost:42415/tests/dromaeo/cssquery-dojo.html) 17:31:25 INFO - PROCESS | 18785 | RSS: Main: 286605312 17:31:25 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | __start_tp_report 17:31:25 INFO - PROCESS | 18785 | _x_x_mozilla_page_load 17:31:25 INFO - PROCESS | 18785 | _x_x_mozilla_page_load_details 17:31:25 INFO - PROCESS | 18785 | |i|pagename|runs| 17:31:25 INFO - PROCESS | 18785 | |0;dojo.html;3151.7636177286704;3166.3034132490843;3187.2987942652617;3215.662355452679;3234.9676503234973;5123.66696164749;5217.530422261995;5335.093034184189;5396.514313711765;5433.755481003354;5353.946460535393;5369.865753356168;5387.24578559002;5411.864703382417;5459.12653975364;4769.689970151938;4799.712017278957;4854.12625727369;4861.927071093936;4992.425871024824;4894.461609222983;4947.03532811102;4965.826196083138;4972.552470277675;5020.949790502084;4635.721856688592;4720.952790472103;4774.259989701602;4801.543853333945;4826.203676393426;4795.328653988409;4809.519048095198;4815.590674792612;4868.488808675073;4930.4330002049865;4847.660663753539;4849.951500484985;4850.5149485051215;4852.805887764485;4861.149298872683;5040.59675225981;5174.172132458789;5257.13257312543;5318.069337865858;5320.042392369372;5692.9146062809095;5739.655620662774;5748.166515855178;5767.740451679684;5769.653820770767;5477.315335583052;5797.246357973479;5810.88378232433;5818.679972601505;5824.825255242349;5294.735263236823;5359.437259087817;5363.141897296414;5407.729613519387;5409.756560954766;5934.376890426443;5994.9700251499335;5998.550108741862;6001.099835024781;6002.039673652282;5350.0904846176245;5575.665460072409;5738.971305143531;5747.942520574825;5752.338481074647;5732.799352022659;5793.362730099686;5795.507381872588;5798.478136967693;5855.677937713382;5748.051571490657;5765.827025189251;5769.653820770767;5771.653700777967;5785.421457854265;5393.83818485446;5572.189038562484;5623.550115990793;5760.769569217268;5772.393898640582;4355.825766969349;4375.956240437555;4376.037271800199;4389.582989615981;4407.184670835905;3888.1640447303967;3899.53205615328;3907.159960608426;3933.174033453007;3946.3685810270217;5140.665856719302;5178.0679477694375;5217.373915130132;5302.787888484495;5346.117890548094;5649.435056494318;5674.4892959633835;5680.204771332017;5715.114157305624;5727.5990680652785;5320.946790532045;5326.733663316819;5337.066013447631;5340.973295133577;5341.839744807662;4771.856844294677;4910.852674419773;4949.331840201598;4972.378452693413;4978.527039931273;5920.733566989496;5955.791547295824;5961.672108034013;5965.164876917235;5982.641041537521;5775.768969241268;5782.306123265235;5783.421657834183;5785.537157027512;5787.305523337226;5536.612437129524;5779.942200577941;5873.471387575139;5919.378465261258;5955.493783028491;5678.801241956512;5682.971585142048;5683.175939488834;5684.346300175367;5687.232223649754;5452.7546260417585;5717.485426311652;5783.681897495678;5786.074228123648;5788.044972579477;5435.266239057677;5496.1755736639825;5507.146392309199;5542.695151766691;5546.306711661043;5478.096114141282;5514.117741161395;5523.309586301712;5527;5527.281453411031;5198.75229944803;5422.945770542244;5423.728813559385;5430.755615997211;5468.906218756344;5488.396276409512;5553.527950124285;5555.444455554574;5661.122526008476;5664.0937450007805;5493.533049690821;5493.890122197454;5497.312835895513;5499.972500137474;5531.751071201886 17:31:25 INFO - PROCESS | 18785 | |1;ext.html;617.5337620096827;625.5808608232487;626.573929727785;646.1632186318717;648.6497291462609;33500;41985.580144198546;43641.78179109108;43679.126417471634;46313.7684311578;44669.77665111678;44775.10449791002;45078.64764057084;45129.774351128195;45154.32268515975;8554.95722521388;8811.383203175781;8826.073262307462;8838.027816940132;8841.292696584258;8541.82916341676;8623.827523449527;8641.827163456726;8659.047504774502;8663.480191188517;8793.912060879406;8810.955945220265;8828.382013259074;8835.116488351177;8842.557872106401;8751.606177722018;8817.030126686059;8820.470771753651;8829;8845.690400835972;8695.652173913037;8827.205551500332;8834.204921557091;8835.514046727427;8838.602262898185;40946;41342;41465;41582;41605.79197104026;3198.0885447647543;3248.642649308574;3257.218267615755;3274.8035117893;3372.8482218300237;28703.85648071767;29630.555541666894;32146.357072858413;32339.83830080858;32483.837580811945;3955.980220098881;4079.5308539518037;4096.242195193899;4111.239420707178;4136.338185890273;321408;323546;324431;326092.9999999976;327178;62521.37478625246;62594.37405625977;63405;63433.682831585546;63495.36504634987;66071.33928660749;66182.33817661858;66193.02841829506;66418.66790666016;66734;15191.544253672408;15230.619234519225;15249;15308.540743777705;15322.770158447633;12406.751864962831;12551.623451296477;12576.182548134526;12584.748305033849;12637.684057898443;19414.2234310626;20473.795262047486;20654.380368588965;20682.276120335715;20735.377938661863;7225.855482890418;7280.8179795504475;7419.183889772121;7507.5870827103945;7617.5048621839405;885.6678745470449;938.6949241496541;1005.4218824175982;1014.1227837920146;1089.9891001090045;31164.376712465622;31601.525977110363;31755.20611984719;31875.67437957085;32223.194420139684;931.6040682709821;1067.4841724750872;1109.7003808971533;1168.1881092640704;1176.253079294637;15955.361785528681;16135.354585816436;16402.671946561;16484.6703065938;16769.7484537732;494323;497023;497382;497406;499192;55449;55919;55942.160867587016;56035.71982140145;56039;1230.7353918907477;1277.2145130744525;1348.689801345696;1356.3692882809542;1375.1611516974638;30098.24754381158;32385.190370240933;32601.510977334885;32753.836230818695;33228;48278.5172148274;48864.511354885995;48953.755231223615;48994;48995;375781;376421;376545;377489;380969;41685.79157104195;42495;43306.78346608247;43367.78316108399;43472.56527434812;42159.36760948527;43245.3513197296;47187;47812.2828157571;48284;39766.02924634421;40362.394564080976;41322.38016429816;41438.58561414468;41493;39598.40602390909;39631.60368396279;40066.06585754094;40325;41077;39055.609443905196;40080;40177.19645607013;40231.396529051504;40335.79832100821;34339.82830085834;35614.64385356113;35887;36165.63834361623;36192.638073618924;27390;27567.724322757316;27588.963615105513;27633.309167270978;27833.860830695718 17:31:25 INFO - PROCESS | 18785 | |2;jquery.html;378.89201577550403;387.5293262070442;388.1112252940767;399.8900302416836;412.3381971935044;17236.913815430922;18011.549711257227;18764.62470750586;18782.4365269042;19218.807811921877;17886.5528361791;18026.369077082305;18461;18757;18930.14814333355;5423.620346575742;5488.670679759207;5649.350324712649;5652.971735141318;5685.260916080924;5557.888842223173;5579.414161513044;5597.188407680884;5597.188407680884;5606.24315717377;5326.201069839536;5556.888862222753;5571.359293681217;5574.10814269717;5591.41290164533;5552.444755524435;5610.775568977236;5614.775408983635;5631.746571404296;5632.324121105473;4807.158747219258;4869.220924652039;4925.21196608541;4973.626977976666;4982.153033984231;22082;22116;22258.332250032363;22848;22859.199928002607;2217.733871935362;2235.1953296813135;2247.7974283758113;2297.3911913342977;2313.4910319729634;13570.321483925763;13695.86304136956;13929.471406858793;14073.225972571505;14373.06575072617;1870.6819840627127;1911.44568075258;1926.7206255093074;1935.2355819451238;2001.0095002973476;50822.70013378852;54902;68623.9999999995;71918;73378;10207.438590877424;10338.586456541805;10517.737056573495;10683.679489615168;10811.243212975016;14602.34289456977;14651.267436628126;14715;14740.926295368454;14771.556853294418;6835.4189893859575;7050.4007159391;7482.289182527651;7506;7747.186545412763;7177.144895300261;7714.884276735854;7742.690292388242;7836.686532538749;7840.803979900548;6396.42432181106;6408.61548307103;6440.355964403616;6466.935330646727;6527.086207930894;1800.091902583266;1854.7217917312512;1927.9710804337947;1930.0639189992842;1964.2143142743016;973.532704301939;1000.6747806962766;1012.0587853296357;1081.5241293830688;1114.453917580396;17951.281948722168;19007.524811879815;19119.80880191208;19143.23427062902;19349.4195174145;966.4491239993137;978.848278516831;989.0850962859327;1021.2136654775929;1056.7252514346326;10631.682793395084;10939.179561532757;11018.983961223457;11052.834207486734;11059.72350691239;441495;441642;457940;458836;462111.68944155064;78405;79616.20383796089;80060.59969700231;80261;80790;1034.4414016431194;1041.9114375278034;1082.2045796339685;1108.8004159251411;1115.1246271676696;16835.915820420818;16856.494305170865;16908.915455422644;17080.145992700564;17632.647347053244;37951.43072853965;38743.612563874;39020.41469377905;39162.80418597889;39537.406938895365;50327.74836125942;50823.491765081875;50845.49154508408;51078.744606276734;53031;7982.241687039722;8077.15189905075;8164.346852251924;8253.298469629908;8466.661333546836;12093.455794489446;12264.632061038183;12270.815937760763;12413.44139513742;12639.304838233986;10001.899981000388;10460.215483838894;10820.350778953289;10861.239713219999;11311.660650180507;10941.671749847517;10975.134227181557;10987.670369888916;11300.378479183395;11324.773504530029;10839.945800271264;11230.606928757781;11250.437478125898;11281.548738050386;11301.604443844426;8176.059753128228;8209.481245969277;8220.177982201732;8411.200935911078;8486.236238738296;10167.898321016992;10535;10662.73343166427;11098.50056747432;11157 17:31:25 INFO - PROCESS | 18785 | |3;mootools.html;1341.7786065299226;1424.8860091192703;1487.7917091607173;1594.5774369792007;1771.9025453600054;8582.098879617635;8968.865467018;8971.23744481719;9254.768630784234;9293.44239345638;8901.19889209971;9197.21823644991;9198.678046268382;9203.677871274507;9208.217301529361;2008.4677560446494;2215.1360969222014;2315.9305220843403;2341.683872677188;2378.714554253483;2325.7092863392077;2328.7554806745216;2331.80179684727;2333.9299821005397;2335.4278201840575;2320.477892474188;2331.463763334434;2356.1282325539573;2358.056777289081;2361.515889242701;1951.5121219695077;2219.4673278413225;2252.3805953362876;2276.8747718875456;2284.280451657739;2291.129370839087;2302.056156975632;2316.8841557922206;2318.07277089164;2322.93031209064;8957.776055598597;8958.014618392037;8996.190342869173;9055.547222638908;9067.954660226722;5053.1157047516535;5194.35070616173;5202.08963431398;5205.037068142406;5206.583473322125;3188.85650145744;3269.7057264846276;3346.28054968183;3356.5636467259346;3387.9830600847085;1081.9026287634072;1106.750981029262;1147.7474955509774;1151.0101312871009;1164.6855349055706;12524;12585.874141258562;12601.117921745481;12603.684907877285;12607.621771346874;4439.511653718088;4568.88577785558;4587.8623641290815;4675.3869914879315;4684.95315046852;10461.9476902615;10488.475576221159;10501.474926253657;10573.788524229472;10586.258961872749;5284.4187139414635;5296.788128474895;5298.682079075268;5298.761555730001;5301.125314323171;4232.978835105866;4663.650226233046;4865.099956508057;4884.853454396374;4885.853424397274;3956.4065390191126;4032.858849940238;4035.878923632296;4095.877123686294;4111.9177616447505;1247.25788156047;1266.4047897488165;1268.2580690296095;1283.0441321215753;1288.0854593238905;864.6541383446546;935.6584846530967;1002.498780475659;1007.992007992008;1016.8068067067234;5999.970000150059;6177.938220617826;6200.782972596027;6209.720562574695;6296.275928268216;929.3215952354819;948.0472125513814;966.8839739231337;986.6990567876867;1025.1337619711333;4115.218108559364;4159.916801664011;4270.274053410928;4278.080212754273;4324.308110702335;10558.630447934285;10830.729231769268;10887;10914.290571113012;10922.126229901589;10545.578176872992;10656.307340022873;10724.356538607552;10828.025477707044;10967.945160274307;8313.542755148525;8430.15698430152;8438.071812100665;8461.873071903927;8472.068072512018;6042.1843051187525;6256.957583079093;6313.96843015782;6359.014352775327;6367.777127800505;10372.325798823053;10594.576216951236;10668.89331106679;10683;10737.731556711145;10406.427646479517;10520.10579100785;10739.087177589992;10847.620333288298;10875.836862446911;7342.155652100077;7480.513766605153;7493.962530187314;8075.071366792894;8215.835683286421;8237.546934918637;8289.4197406181;8542.957285213533;8584.098669639598;8811;7688.154303026775;7723.691052357843;7764.378849692124;7874.960625196837;7976.880346794686;7139.785806425815;7772.961135194514;7781.494202876795;7838.098618658927;7977.202279772208;6898.206706228848;7090.539114957512;7114.786556403109;7123.857522849617;7141.035960145522;5061.772220250024;5154;5241.659292146151;5297.337832770903;5399.487048730364;5207.973960130175;5430.456954304538;5494.09347457681;5645.040343141593;5672.602917795714 17:31:25 INFO - PROCESS | 18785 | |4;prototype.html;319.8097132206336;323.9497877828937;326.9133679574912;331.4481388488166;332.7504371721209;5052.322269197327;5154.716490593016;5204.739763011844;5206.921896171561;5253;5119.38567371915;5143.048536020839;5149.74251287436;5164.586833053356;5173.370388327674;3989.2221016901717;4079.673626109904;4087.816048277835;4092.7135100542973;4098.815553300109;4039.53545342285;4058.715889887709;4062.614051665087;4067.376542130324;4076.7757773322455;3984.760914345134;4013.4782478277784;4013.5384430790396;4027.335489644205;4028.67770578353;3860.36304009838;3881.243157584244;4033.2135233629306;4048.4332193492933;4090.3455447128317;3612.4942508048894;3623;3623.9456408153897;3635.6909662678704;3642.4354225095153;4971.179755340365;4980.302757613937;4995.700257984497;4996.625253106032;5004.524570165829;4394.296912494017;4461.349300758708;4593.56361145694;4640.651951103647;4671.929921051187;5344.251804747339;5347.41178470368;5372.677639341652;5377.892442151135;5379.946200537984;3905.023744063984;3906;3906.2968665640174;3920.15716620925;3935.8622448214173;5314.263154475449;5509.5041446270025;5535.972320138414;5539.169124631298;5540.778368865241;3997.8800635980965;4031.8992025199605;4040.8585699500964;4042.292598795199;4044.4539987101953;4057.539285857089;4077.4495443115393;4096.955276404497;4102.897427564275;4115.794210289474;4413.933790993137;4552.180607490617;4627.375304333939;4662.580367766917;4668;5390.21841832932;5393.002294575516;5425.945740542623;5436.429174936654;5455.117984295412;1404.8269694804749;1411.6823714664324;1415.6177831985513;1422.679897023182;1423.3452611798482;873.8512292828564;916.6791622932054;930.9487978161267;931.1154403316876;935.9423851048272;4611.532829935968;4615.653825963066;4656.301554766745;4738.47876733559;4743.549362810528;4876.219804831281;4910.379574740327;4912.70523768575;4921.261810728348;4956.231784073474;4624.953750462452;4633.675642705046;4637.86086417408;4767.092073834958;4914.459409464956;2865.0402115291613;2901.332693480469;2967.792254542161;2995.715407036328;3002.324476992659;5820.82537523875;5826.883462330815;5830.5627077968475;5832.825015249549;5836.824895253149;5292.629515933924;5576.860578485489;5612.663240205519;5700.37295897451;5719.342275638355;5739.540836732968;5740.196372507852;5754.510866576305;5756.136579513107;5778.913316300259;5357.303550538405;5505.311836020497;5518.19986102021;5556.333240011225;5572.969000734877;5415.918761218663;5483.287172667528;5487;5493.697846618475;5494;5716.142578613241;5719.342275638355;5734.770609175753;5737.770489180386;5766.5675074368755;3818.789966551866;3961.7520481048377;3976.940345894756;3986.481757371523;3996.8201430935096;5517.310336207974;5546.58400619947;5548.556115510669;5560.304961879765;5576.665400076008;5403.486668766461;5404.162354835007;5427.782888684408;5435.945640543544;5439.238506609157;5152.76812543444;5393.919091213714;5423.322084739408;5449.128139497661;5464.562834973272;5343.812966546152;5349.705766182898;5358.437364076716;5365.678059316453;5367.624266301322;5467.933752918143;5489.33767122937;5492.80775172867;5495.148252020943;5502.404302752318;5135.3324067870935;5323.547498462674;5348.919766203432;5349.839504814861;5379.811706590251 17:31:25 INFO - PROCESS | 18785 | |5;yui.html;656.1240743607283;686.6292202210807;718.4862823081496;727.2691242550204;733.2667332667332;14867.40530378785;15678.84321156788;15720.37118515261;15732.29204685789;15761.842381576182;13633.182009079463;13691;13807.792883106737;13842.584722458318;15129.92435037826;781.7732857471326;790.3519114326255;794.964226609804;795.0459448661601;796.0884786918974;668.9230738465066;775.9757120600809;797.8882956386111;799.7240951871595;805.0862271322062;830.622066959535;831.0650518167062;832.24681663095;833.7748807821915;835.1940377535677;690.7927621713466;828.6561077152975;829.1087081387502;830.5764060329216;832.9333653307721;592.2744637818638;606.1877084706471;606.6481440764346;608.8173547935646;610.0209164291293;14036.92981535096;14046.367913443919;14068.155910645393;14069.36687849039;14121.293935303194;13243.933780331134;13981.161130332213;14025.71948561023;14075.366608502642;14110;11402.71493212668;11460.255083419552;11703;11926.522939082426;12122.454489547992;4297.205017071852;4350.260455722535;4374.8906277343;4399.912001759947;4558.680892337537;69052.3094769051;69173.65413172952;69260.30739692588;69391.65304173446;70898;10287.742806429898;10475.528601212964;10794.082502987178;10990.120790336754;11064.225504214628;19970.500737481678;20170.798292017185;20200.292989745583;20208.09063592142;20254;8103.230193131643;8270.917290827014;8338.749837504885;8365.749027529184;8514.914850851412;4549.021960278556;4664.277037059262;4711.1519926413575;4829.275608658659;4986.127427700138;3357.84889679965;3449.8275086245585;3452.8273586320583;3467.878624248139;3494.6155922848466;587.4067192135974;592.1857446011734;596.8209537138841;612.6201754911983;616.7687117331001;520.1391696741898;542.4765101676901;590.3594599859201;600.3396264109444;676.4149011105457;9108.635654573874;9117.680881169128;9167.298710630374;9171.266298696088;9274.95362523183;608.2761513798565;695.436696276008;702.2065066474851;702.880510313248;721.0878239027634;4359.17175736609;4499;4536.931946020813;4552.294394368878;4694.342792009122;91885.54057229671;97531;97782.5110874441;107819;108969.45515272532;44239.778801105786;61382.69308653428;62772.68613656903;63296.683516582125;81782.59108704419;82788.58605706813;83197.58401207955;85261;86020.13979860247;87822;9534.141927226583;9676.27427942893;9750.60997560118;9783.41299522031;9834.803303933739;48902.510974889796;49420.50579494159;50240;50569;50575.241371378725;59505.70247148736;77194.2280577187;77210.22789772031;77403.61298193473;77782;11922.642320730392;12044.73873471702;12279.421321522581;12293.815592765937;12613.74772504563;13928.233947133005;14040.508582199982;14085.647858803202;14361;14507.202103884387;12028.338441385458;12141.15011949155;13149.60161731495;13188.670283242996;13356.532521361705;12862.421191046613;12999.41502632365;13171.47314107425;13220.735585288432;13552.322383880964;12005.75988480243;12239.75520489603;12773.297468639314;12832.743345132858;13017.934910325388;10394.896051039696;10599.470026498799;10712.625058122929;10759.139268858316;11070.723231919266;11169.329840209613;11324.94337528307;11358.60244891425;11484.712882178012;11695.298282103102 17:31:25 INFO - PROCESS | 18785 | __end_tp_report 17:31:25 INFO - PROCESS | 18785 | __start_cc_report 17:31:25 INFO - PROCESS | 18785 | _x_x_mozilla_cycle_collect,923 17:31:25 INFO - PROCESS | 18785 | __end_cc_report 17:31:25 INFO - PROCESS | 18785 | __startTimestamp1465432285404__endTimestamp 17:31:25 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | ------- Summary: start ------- 17:31:25 INFO - PROCESS | 18785 | Number of tests: 6 17:31:25 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | [#0] dojo.html Cycles:165 Average:5301.47 Median:5459.13 stddev:598.21 (11.0%) stddev-sans-first:575.78 17:31:25 INFO - PROCESS | 18785 | Values: 3151.8 3166.3 3187.3 3215.7 3235.0 5123.7 5217.5 5335.1 5396.5 5433.8 5353.9 5369.9 5387.2 5411.9 5459.1 4769.7 4799.7 4854.1 4861.9 4992.4 4894.5 4947.0 4965.8 4972.6 5020.9 4635.7 4721.0 4774.3 4801.5 4826.2 4795.3 4809.5 4815.6 4868.5 4930.4 4847.7 4850.0 4850.5 4852.8 4861.1 5040.6 5174.2 5257.1 5318.1 5320.0 5692.9 5739.7 5748.2 5767.7 5769.7 5477.3 5797.2 5810.9 5818.7 5824.8 5294.7 5359.4 5363.1 5407.7 5409.8 5934.4 5995.0 5998.6 6001.1 6002.0 5350.1 5575.7 5739.0 5747.9 5752.3 5732.8 5793.4 5795.5 5798.5 5855.7 5748.1 5765.8 5769.7 5771.7 5785.4 5393.8 5572.2 5623.6 5760.8 5772.4 4355.8 4376.0 4376.0 4389.6 4407.2 3888.2 3899.5 3907.2 3933.2 3946.4 5140.7 5178.1 5217.4 5302.8 5346.1 5649.4 5674.5 5680.2 5715.1 5727.6 5320.9 5326.7 5337.1 5341.0 5341.8 4771.9 4910.9 4949.3 4972.4 4978.5 5920.7 5955.8 5961.7 5965.2 5982.6 5775.8 5782.3 5783.4 5785.5 5787.3 5536.6 5779.9 5873.5 5919.4 5955.5 5678.8 5683.0 5683.2 5684.3 5687.2 5452.8 5717.5 5783.7 5786.1 5788.0 5435.3 5496.2 5507.1 5542.7 5546.3 5478.1 5514.1 5523.3 5527.0 5527.3 5198.8 5422.9 5423.7 5430.8 5468.9 5488.4 5553.5 5555.4 5661.1 5664.1 5493.5 5493.9 5497.3 5500.0 5531.8 17:31:25 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | [#1] ext.html Cycles:180 Average:57120.30 Median:41332.19 stddev:107303.52 (259.6%) stddev-sans-first:107520.67 17:31:25 INFO - PROCESS | 18785 | Values: 617.5 625.6 626.6 646.2 648.6 33500.0 41985.6 43641.8 43679.1 46313.8 44669.8 44775.1 45078.6 45129.8 45154.3 8555.0 8811.4 8826.1 8838.0 8841.3 8541.8 8623.8 8641.8 8659.0 8663.5 8793.9 8811.0 8828.4 8835.1 8842.6 8751.6 8817.0 8820.5 8829.0 8845.7 8695.7 8827.2 8834.2 8835.5 8838.6 40946.0 41342.0 41465.0 41582.0 41605.8 3198.1 3248.6 3257.2 3274.8 3372.8 28703.9 29630.6 32146.4 32339.8 32483.8 3956.0 4079.5 4096.2 4111.2 4136.3 321408.0 323546.0 324431.0 326093.0 327178.0 62521.4 62594.4 63405.0 63433.7 63495.4 66071.3 66182.3 66193.0 66418.7 66734.0 15191.5 15230.6 15249.0 15308.5 15322.8 12406.8 12551.6 12576.2 12584.7 12637.7 19414.2 20473.8 20654.4 20682.3 20735.4 7225.9 7280.8 7419.2 7507.6 7617.5 885.7 938.7 1005.4 1014.1 1090.0 31164.4 31601.5 31755.2 31875.7 32223.2 931.6 1067.5 1109.7 1168.2 1176.3 15955.4 16135.4 16402.7 16484.7 16769.7 494323.0 497023.0 497382.0 497406.0 499192.0 55449.0 55919.0 55942.2 56035.7 56039.0 1230.7 1277.2 1348.7 1356.4 1375.2 30098.2 32385.2 32601.5 32753.8 33228.0 48278.5 48864.5 48953.8 48994.0 48995.0 375781.0 376421.0 376545.0 377489.0 380969.0 41685.8 42495.0 43306.8 43367.8 43472.6 42159.4 43245.4 47187.0 47812.3 48284.0 39766.0 40362.4 41322.4 41438.6 41493.0 39598.4 39631.6 40066.1 40325.0 41077.0 39055.6 40080.0 40177.2 40231.4 40335.8 34339.8 35614.6 35887.0 36165.6 36192.6 27390.0 27567.7 27589.0 27633.3 27833.9 17:31:25 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | [#2] jquery.html Cycles:180 Average:26731.55 Median:2241.50 stddev:74230.47 (3311.6%) stddev-sans-first:74412.33 17:31:25 INFO - PROCESS | 18785 | Values: 378.9 387.5 388.1 399.9 412.3 17236.9 18011.5 18764.6 18782.4 19218.8 17886.6 18026.4 18461.0 18757.0 18930.1 5423.6 5488.7 5649.4 5653.0 5685.3 5557.9 5579.4 5597.2 5597.2 5606.2 5326.2 5556.9 5571.4 5574.1 5591.4 5552.4 5610.8 5614.8 5631.7 5632.3 4807.2 4869.2 4925.2 4973.6 4982.2 22082.0 22116.0 22258.3 22848.0 22859.2 2217.7 2235.2 2247.8 2297.4 2313.5 13570.3 13695.9 13929.5 14073.2 14373.1 1870.7 1911.4 1926.7 1935.2 2001.0 50822.7 54902.0 68624.0 71918.0 73378.0 10207.4 10338.6 10517.7 10683.7 10811.2 14602.3 14651.3 14715.0 14740.9 14771.6 6835.4 7050.4 7482.3 7506.0 7747.2 7177.1 7714.9 7742.7 7836.7 7840.8 6396.4 6408.6 6440.4 6466.9 6527.1 1800.1 1854.7 1928.0 1930.1 1964.2 973.5 1000.7 1012.1 1081.5 1114.5 17951.3 19007.5 19119.8 19143.2 19349.4 966.4 978.8 989.1 1021.2 1056.7 10631.7 10939.2 11019.0 11052.8 11059.7 441495.0 441642.0 457940.0 458836.0 462111.7 78405.0 79616.2 80060.6 80261.0 80790.0 1034.4 1041.9 1082.2 1108.8 1115.1 16835.9 16856.5 16908.9 17080.1 17632.6 37951.4 38743.6 39020.4 39162.8 39537.4 50327.7 50823.5 50845.5 51078.7 53031.0 7982.2 8077.2 8164.3 8253.3 8466.7 12093.5 12264.6 12270.8 12413.4 12639.3 10001.9 10460.2 10820.4 10861.2 11311.7 10941.7 10975.1 10987.7 11300.4 11324.8 10839.9 11230.6 11250.4 11281.5 11301.6 8176.1 8209.5 8220.2 8411.2 8486.2 10167.9 10535.0 10662.7 11098.5 11157.0 17:31:25 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | [#3] mootools.html Cycles:180 Average:5893.34 Median:4504.20 stddev:3380.04 (75.0%) stddev-sans-first:3372.21 17:31:25 INFO - PROCESS | 18785 | Values: 1341.8 1424.9 1487.8 1594.6 1771.9 8582.1 8968.9 8971.2 9254.8 9293.4 8901.2 9197.2 9198.7 9203.7 9208.2 2008.5 2215.1 2315.9 2341.7 2378.7 2325.7 2328.8 2331.8 2333.9 2335.4 2320.5 2331.5 2356.1 2358.1 2361.5 1951.5 2219.5 2252.4 2276.9 2284.3 2291.1 2302.1 2316.9 2318.1 2322.9 8957.8 8958.0 8996.2 9055.5 9068.0 5053.1 5194.4 5202.1 5205.0 5206.6 3188.9 3269.7 3346.3 3356.6 3388.0 1081.9 1106.8 1147.7 1151.0 1164.7 12524.0 12585.9 12601.1 12603.7 12607.6 4439.5 4568.9 4587.9 4675.4 4685.0 10461.9 10488.5 10501.5 10573.8 10586.3 5284.4 5296.8 5298.7 5298.8 5301.1 4233.0 4663.7 4865.1 4884.9 4885.9 3956.4 4032.9 4035.9 4095.9 4111.9 1247.3 1266.4 1268.3 1283.0 1288.1 864.7 935.7 1002.5 1008.0 1016.8 6000.0 6177.9 6200.8 6209.7 6296.3 929.3 948.0 966.9 986.7 1025.1 4115.2 4159.9 4270.3 4278.1 4324.3 10558.6 10830.7 10887.0 10914.3 10922.1 10545.6 10656.3 10724.4 10828.0 10967.9 8313.5 8430.2 8438.1 8461.9 8472.1 6042.2 6257.0 6314.0 6359.0 6367.8 10372.3 10594.6 10668.9 10683.0 10737.7 10406.4 10520.1 10739.1 10847.6 10875.8 7342.2 7480.5 7494.0 8075.1 8215.8 8237.5 8289.4 8543.0 8584.1 8811.0 7688.2 7723.7 7764.4 7875.0 7976.9 7139.8 7773.0 7781.5 7838.1 7977.2 6898.2 7090.5 7114.8 7123.9 7141.0 5061.8 5154.0 5241.7 5297.3 5399.5 5208.0 5430.5 5494.1 5645.0 5672.6 17:31:25 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | [#4] prototype.html Cycles:180 Average:4520.88 Median:5085.85 stddev:1315.77 (25.9%) stddev-sans-first:1281.12 17:31:25 INFO - PROCESS | 18785 | Values: 319.8 323.9 326.9 331.4 332.8 5052.3 5154.7 5204.7 5206.9 5253.0 5119.4 5143.0 5149.7 5164.6 5173.4 3989.2 4079.7 4087.8 4092.7 4098.8 4039.5 4058.7 4062.6 4067.4 4076.8 3984.8 4013.5 4013.5 4027.3 4028.7 3860.4 3881.2 4033.2 4048.4 4090.3 3612.5 3623.0 3623.9 3635.7 3642.4 4971.2 4980.3 4995.7 4996.6 5004.5 4394.3 4461.3 4593.6 4640.7 4671.9 5344.3 5347.4 5372.7 5377.9 5379.9 3905.0 3906.0 3906.3 3920.2 3935.9 5314.3 5509.5 5536.0 5539.2 5540.8 3997.9 4031.9 4040.9 4042.3 4044.5 4057.5 4077.4 4097.0 4102.9 4115.8 4413.9 4552.2 4627.4 4662.6 4668.0 5390.2 5393.0 5425.9 5436.4 5455.1 1404.8 1411.7 1415.6 1422.7 1423.3 873.9 916.7 930.9 931.1 935.9 4611.5 4615.7 4656.3 4738.5 4743.5 4876.2 4910.4 4912.7 4921.3 4956.2 4625.0 4633.7 4637.9 4767.1 4914.5 2865.0 2901.3 2967.8 2995.7 3002.3 5820.8 5826.9 5830.6 5832.8 5836.8 5292.6 5576.9 5612.7 5700.4 5719.3 5739.5 5740.2 5754.5 5756.1 5778.9 5357.3 5505.3 5518.2 5556.3 5573.0 5415.9 5483.3 5487.0 5493.7 5494.0 5716.1 5719.3 5734.8 5737.8 5766.6 3818.8 3961.8 3976.9 3986.5 3996.8 5517.3 5546.6 5548.6 5560.3 5576.7 5403.5 5404.2 5427.8 5435.9 5439.2 5152.8 5393.9 5423.3 5449.1 5464.6 5343.8 5349.7 5358.4 5365.7 5367.6 5467.9 5489.3 5492.8 5495.1 5502.4 5135.3 5323.5 5348.9 5349.8 5379.8 17:31:25 INFO - PROCESS | 18785 | 17:31:25 INFO - PROCESS | 18785 | [#5] yui.html Cycles:180 Average:18880.45 Median:4770.21 stddev:26113.93 (547.4%) stddev-sans-first:26151.33 17:31:25 INFO - PROCESS | 18785 | Values: 656.1 686.6 718.5 727.3 733.3 14867.4 15678.8 15720.4 15732.3 15761.8 13633.2 13691.0 13807.8 13842.6 15129.9 781.8 790.4 795.0 795.0 796.1 668.9 776.0 797.9 799.7 805.1 830.6 831.1 832.2 833.8 835.2 690.8 828.7 829.1 830.6 832.9 592.3 606.2 606.6 608.8 610.0 14036.9 14046.4 14068.2 14069.4 14121.3 13243.9 13981.2 14025.7 14075.4 14110.0 11402.7 11460.3 11703.0 11926.5 12122.5 4297.2 4350.3 4374.9 4399.9 4558.7 69052.3 69173.7 69260.3 69391.7 70898.0 10287.7 10475.5 10794.1 10990.1 11064.2 19970.5 20170.8 20200.3 20208.1 20254.0 8103.2 8270.9 8338.7 8365.7 8514.9 4549.0 4664.3 4711.2 4829.3 4986.1 3357.8 3449.8 3452.8 3467.9 3494.6 587.4 592.2 596.8 612.6 616.8 520.1 542.5 590.4 600.3 676.4 9108.6 9117.7 9167.3 9171.3 9275.0 608.3 695.4 702.2 702.9 721.1 4359.2 4499.0 4536.9 4552.3 4694.3 91885.5 97531.0 97782.5 107819.0 108969.5 44239.8 61382.7 62772.7 63296.7 81782.6 82788.6 83197.6 85261.0 86020.1 87822.0 9534.1 9676.3 9750.6 9783.4 9834.8 48902.5 49420.5 50240.0 50569.0 50575.2 59505.7 77194.2 77210.2 77403.6 77782.0 11922.6 12044.7 12279.4 12293.8 12613.7 13928.2 14040.5 14085.6 14361.0 14507.2 12028.3 12141.2 13149.6 13188.7 13356.5 12862.4 12999.4 13171.5 13220.7 13552.3 12005.8 12239.8 12773.3 12832.7 13017.9 10394.9 10599.5 10712.6 10759.1 11070.7 11169.3 11324.9 11358.6 11484.7 11695.3 17:31:25 INFO - PROCESS | 18785 | -------- Summary: end -------- 17:31:25 INFO - PROCESS | 18785 | 17:31:26 INFO - TEST-INFO | 18785: exit 0 17:31:26 INFO - TEST-OK | dromaeo_css | took 1114504ms 17:31:26 INFO - TEST-START | kraken 17:31:26 INFO - operating with platform_type : linux_ 17:31:26 INFO - Initialising browser for kraken test... 17:31:26 INFO - TEST-INFO | started process 18967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQDNGV/profile http://localhost:42415/getInfo.html) 17:31:30 INFO - PROCESS | 18967 | __metrics Screen width/height:1600/1200 17:31:30 INFO - PROCESS | 18967 | colorDepth:24 17:31:30 INFO - PROCESS | 18967 | Browser inner width/height: 1024/697 17:31:30 INFO - PROCESS | 18967 | __metrics 17:31:31 ERROR - PROCESS | 18967 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:31:32 INFO - PROCESS | 18967 | console.error: PushService: 17:31:32 INFO - PROCESS | 18967 | stateChangeProcessEnqueue: Error transitioning state 17:31:32 INFO - PROCESS | 18967 | UnknownError 17:31:32 INFO - TEST-INFO | 18967: exit 0 17:31:32 INFO - Browser initialized. 17:31:32 INFO - Running cycle 1/1 for kraken test... 17:31:32 INFO - TEST-INFO | started process 19048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQDNGV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:44 INFO - PROCESS | 19048 | RSS: Main: 159936512 17:31:44 INFO - PROCESS | 19048 | 17:31:47 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42415/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:48 INFO - PROCESS | 19048 | RSS: Main: 218009600 17:31:48 INFO - PROCESS | 19048 | 17:31:50 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42415/tests/kraken/driver.html?testName=audio-dft) 17:31:51 INFO - PROCESS | 19048 | RSS: Main: 204152832 17:31:51 INFO - PROCESS | 19048 | 17:31:54 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42415/tests/kraken/driver.html?testName=audio-fft) 17:31:55 INFO - PROCESS | 19048 | RSS: Main: 271831040 17:31:55 INFO - PROCESS | 19048 | 17:31:57 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42415/tests/kraken/driver.html?testName=audio-oscillator) 17:31:57 INFO - PROCESS | 19048 | RSS: Main: 182190080 17:31:57 INFO - PROCESS | 19048 | 17:31:59 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:00 INFO - PROCESS | 19048 | RSS: Main: 186433536 17:32:00 INFO - PROCESS | 19048 | 17:32:03 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42415/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:04 INFO - PROCESS | 19048 | RSS: Main: 221974528 17:32:04 INFO - PROCESS | 19048 | 17:32:07 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42415/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:08 INFO - PROCESS | 19048 | RSS: Main: 223387648 17:32:08 INFO - PROCESS | 19048 | 17:32:10 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42415/tests/kraken/driver.html?testName=json-parse-financial) 17:32:11 INFO - PROCESS | 19048 | RSS: Main: 223096832 17:32:11 INFO - PROCESS | 19048 | 17:32:13 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:13 INFO - PROCESS | 19048 | RSS: Main: 208912384 17:32:13 INFO - PROCESS | 19048 | 17:32:15 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42415/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:16 INFO - PROCESS | 19048 | RSS: Main: 213540864 17:32:16 INFO - PROCESS | 19048 | 17:32:18 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:18 INFO - PROCESS | 19048 | RSS: Main: 216649728 17:32:18 INFO - PROCESS | 19048 | 17:32:21 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:21 INFO - PROCESS | 19048 | RSS: Main: 223637504 17:32:21 INFO - PROCESS | 19048 | 17:32:24 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:25 INFO - PROCESS | 19048 | RSS: Main: 222474240 17:32:25 INFO - PROCESS | 19048 | 17:32:26 INFO - PROCESS | 19048 | Cycle 1(1): loaded http://localhost:42415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42415/tests/kraken/driver.html?testName=ai-astar) 17:32:27 INFO - PROCESS | 19048 | RSS: Main: 264560640 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | __start_tp_report 17:32:27 INFO - PROCESS | 19048 | _x_x_mozilla_page_load 17:32:27 INFO - PROCESS | 19048 | _x_x_mozilla_page_load_details 17:32:27 INFO - PROCESS | 19048 | |i|pagename|runs| 17:32:27 INFO - PROCESS | 19048 | |0;ai-astar;109;105;111;109;108;110;110;111;110;110 17:32:27 INFO - PROCESS | 19048 | |1;audio-beat-detection;157;124;125;178;125;125;163;137;189;135 17:32:27 INFO - PROCESS | 19048 | |2;audio-dft;162;160;161;160;161;168;160;161;161;161 17:32:27 INFO - PROCESS | 19048 | |3;audio-fft;75;74;74;126;83;74;73;73;106;73 17:32:27 INFO - PROCESS | 19048 | |4;audio-oscillator;85;85;112;85;85;85;127;85;86;124 17:32:27 INFO - PROCESS | 19048 | |5;imaging-gaussian-blur;116;116;116;117;117;117;117;116;117;116 17:32:27 INFO - PROCESS | 19048 | |6;imaging-darkroom;146;147;146;146;146;147;147;146;146;146 17:32:27 INFO - PROCESS | 19048 | |7;imaging-desaturate;94;95;95;95;96;94;95;95;95;95 17:32:27 INFO - PROCESS | 19048 | |8;json-parse-financial;52;52;54;53;51;52;55;54;52;52 17:32:27 INFO - PROCESS | 19048 | |9;json-stringify-tinderbox;61;63;61;62;61;61;63;62;62;61 17:32:27 INFO - PROCESS | 19048 | |10;stanford-crypto-aes;85;78;79;84;86;82;86;87;115;80 17:32:27 INFO - PROCESS | 19048 | |11;stanford-crypto-ccm;134;124;131;130;131;120;120;128;129;122 17:32:27 INFO - PROCESS | 19048 | |12;stanford-crypto-pbkdf2;162;161;163;162;161;162;159;166;160;158 17:32:27 INFO - PROCESS | 19048 | |13;stanford-crypto-sha256-iterative;63;67;65;63;64;64;63;63;66;61 17:32:27 INFO - PROCESS | 19048 | __end_tp_report 17:32:27 INFO - PROCESS | 19048 | __start_cc_report 17:32:27 INFO - PROCESS | 19048 | _x_x_mozilla_cycle_collect,1608 17:32:27 INFO - PROCESS | 19048 | __end_cc_report 17:32:27 INFO - PROCESS | 19048 | __startTimestamp1465432347169__endTimestamp 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | ------- Summary: start ------- 17:32:27 INFO - PROCESS | 19048 | Number of tests: 14 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.77 (1.6%) stddev-sans-first:1.87 17:32:27 INFO - PROCESS | 19048 | Values: 109.0 105.0 111.0 109.0 108.0 110.0 110.0 111.0 110.0 110.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:147.00 stddev:24.25 (16.5%) stddev-sans-first:25.38 17:32:27 INFO - PROCESS | 19048 | Values: 157.0 124.0 125.0 178.0 125.0 125.0 163.0 137.0 189.0 135.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:2.37 (1.5%) stddev-sans-first:2.51 17:32:27 INFO - PROCESS | 19048 | Values: 162.0 160.0 161.0 160.0 161.0 168.0 160.0 161.0 161.0 161.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#3] audio-fft Cycles:10 Average:83.10 Median:74.00 stddev:18.21 (24.6%) stddev-sans-first:19.08 17:32:27 INFO - PROCESS | 19048 | Values: 75.0 74.0 74.0 126.0 83.0 74.0 73.0 73.0 106.0 73.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.72 (20.9%) stddev-sans-first:18.35 17:32:27 INFO - PROCESS | 19048 | Values: 85.0 85.0 112.0 85.0 85.0 85.0 127.0 85.0 86.0 124.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:32:27 INFO - PROCESS | 19048 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:32:27 INFO - PROCESS | 19048 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 17:32:27 INFO - PROCESS | 19048 | Values: 94.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.50 stddev:1.25 (2.4%) stddev-sans-first:1.30 17:32:27 INFO - PROCESS | 19048 | Values: 52.0 52.0 54.0 53.0 51.0 52.0 55.0 54.0 52.0 52.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 17:32:27 INFO - PROCESS | 19048 | Values: 61.0 63.0 61.0 62.0 61.0 61.0 63.0 62.0 62.0 61.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:84.50 stddev:10.60 (12.5%) stddev-sans-first:11.24 17:32:27 INFO - PROCESS | 19048 | Values: 85.0 78.0 79.0 84.0 86.0 82.0 86.0 87.0 115.0 80.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:129.50 stddev:5.02 (3.9%) stddev-sans-first:4.62 17:32:27 INFO - PROCESS | 19048 | Values: 134.0 124.0 131.0 130.0 131.0 120.0 120.0 128.0 129.0 122.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:2.22 (1.4%) stddev-sans-first:2.35 17:32:27 INFO - PROCESS | 19048 | Values: 162.0 161.0 163.0 162.0 161.0 162.0 159.0 166.0 160.0 158.0 17:32:27 INFO - PROCESS | 19048 | 17:32:27 INFO - PROCESS | 19048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.73 (2.7%) stddev-sans-first:1.80 17:32:27 INFO - PROCESS | 19048 | Values: 63.0 67.0 65.0 63.0 64.0 64.0 63.0 63.0 66.0 61.0 17:32:27 INFO - PROCESS | 19048 | -------- Summary: end -------- 17:32:27 INFO - PROCESS | 19048 | 17:32:28 INFO - TEST-INFO | 19048: exit 0 17:32:28 INFO - TEST-OK | kraken | took 62017ms 17:32:28 INFO - SUITE-END | took 1176s 17:32:28 INFO - Completed test suite (00:19:36) 17:32:28 INFO - javascript benchmark 17:32:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.7636177286704, 3166.3034132490843, 3187.2987942652617, 3215.662355452679, 3234.9676503234973, 5123.66696164749, 5217.530422261995, 5335.093034184189, 5396.514313711765, 5433.755481003354, 5353.946460535393, 5369.865753356168, 5387.24578559002, 5411.864703382417, 5459.12653975364, 4769.689970151938, 4799.712017278957, 4854.12625727369, 4861.927071093936, 4992.425871024824, 4894.461609222983, 4947.03532811102, 4965.826196083138, 4972.552470277675, 5020.949790502084, 4635.721856688592, 4720.952790472103, 4774.259989701602, 4801.543853333945, 4826.203676393426, 4795.328653988409, 4809.519048095198, 4815.590674792612, 4868.488808675073, 4930.4330002049865, 4847.660663753539, 4849.951500484985, 4850.5149485051215, 4852.805887764485, 4861.149298872683, 5040.59675225981, 5174.172132458789, 5257.13257312543, 5318.069337865858, 5320.042392369372, 5692.9146062809095, 5739.655620662774, 5748.166515855178, 5767.740451679684, 5769.653820770767, 5477.315335583052, 5797.246357973479, 5810.88378232433, 5818.679972601505, 5824.825255242349, 5294.735263236823, 5359.437259087817, 5363.141897296414, 5407.729613519387, 5409.756560954766, 5934.376890426443, 5994.9700251499335, 5998.550108741862, 6001.099835024781, 6002.039673652282, 5350.0904846176245, 5575.665460072409, 5738.971305143531, 5747.942520574825, 5752.338481074647, 5732.799352022659, 5793.362730099686, 5795.507381872588, 5798.478136967693, 5855.677937713382, 5748.051571490657, 5765.827025189251, 5769.653820770767, 5771.653700777967, 5785.421457854265, 5393.83818485446, 5572.189038562484, 5623.550115990793, 5760.769569217268, 5772.393898640582, 4355.825766969349, 4375.956240437555, 4376.037271800199, 4389.582989615981, 4407.184670835905, 3888.1640447303967, 3899.53205615328, 3907.159960608426, 3933.174033453007, 3946.3685810270217, 5140.665856719302, 5178.0679477694375, 5217.373915130132, 5302.787888484495, 5346.117890548094, 5649.435056494318, 5674.4892959633835, 5680.204771332017, 5715.114157305624, 5727.5990680652785, 5320.946790532045, 5326.733663316819, 5337.066013447631, 5340.973295133577, 5341.839744807662, 4771.856844294677, 4910.852674419773, 4949.331840201598, 4972.378452693413, 4978.527039931273, 5920.733566989496, 5955.791547295824, 5961.672108034013, 5965.164876917235, 5982.641041537521, 5775.768969241268, 5782.306123265235, 5783.421657834183, 5785.537157027512, 5787.305523337226, 5536.612437129524, 5779.942200577941, 5873.471387575139, 5919.378465261258, 5955.493783028491, 5678.801241956512, 5682.971585142048, 5683.175939488834, 5684.346300175367, 5687.232223649754, 5452.7546260417585, 5717.485426311652, 5783.681897495678, 5786.074228123648, 5788.044972579477, 5435.266239057677, 5496.1755736639825, 5507.146392309199, 5542.695151766691, 5546.306711661043, 5478.096114141282, 5514.117741161395, 5523.309586301712, 5527.0, 5527.281453411031, 5198.75229944803, 5422.945770542244, 5423.728813559385, 5430.755615997211, 5468.906218756344, 5488.396276409512, 5553.527950124285, 5555.444455554574, 5661.122526008476, 5664.0937450007805, 5493.533049690821, 5493.890122197454, 5497.312835895513, 5499.972500137474, 5531.751071201886], "value": 5262.508161384612, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.5337620096827, 625.5808608232487, 626.573929727785, 646.1632186318717, 648.6497291462609, 33500.0, 41985.580144198546, 43641.78179109108, 43679.126417471634, 46313.7684311578, 44669.77665111678, 44775.10449791002, 45078.64764057084, 45129.774351128195, 45154.32268515975, 8554.95722521388, 8811.383203175781, 8826.073262307462, 8838.027816940132, 8841.292696584258, 8541.82916341676, 8623.827523449527, 8641.827163456726, 8659.047504774502, 8663.480191188517, 8793.912060879406, 8810.955945220265, 8828.382013259074, 8835.116488351177, 8842.557872106401, 8751.606177722018, 8817.030126686059, 8820.470771753651, 8829.0, 8845.690400835972, 8695.652173913037, 8827.205551500332, 8834.204921557091, 8835.514046727427, 8838.602262898185, 40946.0, 41342.0, 41465.0, 41582.0, 41605.79197104026, 3198.0885447647543, 3248.642649308574, 3257.218267615755, 3274.8035117893, 3372.8482218300237, 28703.85648071767, 29630.555541666894, 32146.357072858413, 32339.83830080858, 32483.837580811945, 3955.980220098881, 4079.5308539518037, 4096.242195193899, 4111.239420707178, 4136.338185890273, 321408.0, 323546.0, 324431.0, 326092.9999999976, 327178.0, 62521.37478625246, 62594.37405625977, 63405.0, 63433.682831585546, 63495.36504634987, 66071.33928660749, 66182.33817661858, 66193.02841829506, 66418.66790666016, 66734.0, 15191.544253672408, 15230.619234519225, 15249.0, 15308.540743777705, 15322.770158447633, 12406.751864962831, 12551.623451296477, 12576.182548134526, 12584.748305033849, 12637.684057898443, 19414.2234310626, 20473.795262047486, 20654.380368588965, 20682.276120335715, 20735.377938661863, 7225.855482890418, 7280.8179795504475, 7419.183889772121, 7507.5870827103945, 7617.5048621839405, 885.6678745470449, 938.6949241496541, 1005.4218824175982, 1014.1227837920146, 1089.9891001090045, 31164.376712465622, 31601.525977110363, 31755.20611984719, 31875.67437957085, 32223.194420139684, 931.6040682709821, 1067.4841724750872, 1109.7003808971533, 1168.1881092640704, 1176.253079294637, 15955.361785528681, 16135.354585816436, 16402.671946561, 16484.6703065938, 16769.7484537732, 494323.0, 497023.0, 497382.0, 497406.0, 499192.0, 55449.0, 55919.0, 55942.160867587016, 56035.71982140145, 56039.0, 1230.7353918907477, 1277.2145130744525, 1348.689801345696, 1356.3692882809542, 1375.1611516974638, 30098.24754381158, 32385.190370240933, 32601.510977334885, 32753.836230818695, 33228.0, 48278.5172148274, 48864.511354885995, 48953.755231223615, 48994.0, 48995.0, 375781.0, 376421.0, 376545.0, 377489.0, 380969.0, 41685.79157104195, 42495.0, 43306.78346608247, 43367.78316108399, 43472.56527434812, 42159.36760948527, 43245.3513197296, 47187.0, 47812.2828157571, 48284.0, 39766.02924634421, 40362.394564080976, 41322.38016429816, 41438.58561414468, 41493.0, 39598.40602390909, 39631.60368396279, 40066.06585754094, 40325.0, 41077.0, 39055.609443905196, 40080.0, 40177.19645607013, 40231.396529051504, 40335.79832100821, 34339.82830085834, 35614.64385356113, 35887.0, 36165.63834361623, 36192.638073618924, 27390.0, 27567.724322757316, 27588.963615105513, 27633.309167270978, 27833.860830695718], "value": 19960.4623454548, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.89201577550403, 387.5293262070442, 388.1112252940767, 399.8900302416836, 412.3381971935044, 17236.913815430922, 18011.549711257227, 18764.62470750586, 18782.4365269042, 19218.807811921877, 17886.5528361791, 18026.369077082305, 18461.0, 18757.0, 18930.14814333355, 5423.620346575742, 5488.670679759207, 5649.350324712649, 5652.971735141318, 5685.260916080924, 5557.888842223173, 5579.414161513044, 5597.188407680884, 5597.188407680884, 5606.24315717377, 5326.201069839536, 5556.888862222753, 5571.359293681217, 5574.10814269717, 5591.41290164533, 5552.444755524435, 5610.775568977236, 5614.775408983635, 5631.746571404296, 5632.324121105473, 4807.158747219258, 4869.220924652039, 4925.21196608541, 4973.626977976666, 4982.153033984231, 22082.0, 22116.0, 22258.332250032363, 22848.0, 22859.199928002607, 2217.733871935362, 2235.1953296813135, 2247.7974283758113, 2297.3911913342977, 2313.4910319729634, 13570.321483925763, 13695.86304136956, 13929.471406858793, 14073.225972571505, 14373.06575072617, 1870.6819840627127, 1911.44568075258, 1926.7206255093074, 1935.2355819451238, 2001.0095002973476, 50822.70013378852, 54902.0, 68623.9999999995, 71918.0, 73378.0, 10207.438590877424, 10338.586456541805, 10517.737056573495, 10683.679489615168, 10811.243212975016, 14602.34289456977, 14651.267436628126, 14715.0, 14740.926295368454, 14771.556853294418, 6835.4189893859575, 7050.4007159391, 7482.289182527651, 7506.0, 7747.186545412763, 7177.144895300261, 7714.884276735854, 7742.690292388242, 7836.686532538749, 7840.803979900548, 6396.42432181106, 6408.61548307103, 6440.355964403616, 6466.935330646727, 6527.086207930894, 1800.091902583266, 1854.7217917312512, 1927.9710804337947, 1930.0639189992842, 1964.2143142743016, 973.532704301939, 1000.6747806962766, 1012.0587853296357, 1081.5241293830688, 1114.453917580396, 17951.281948722168, 19007.524811879815, 19119.80880191208, 19143.23427062902, 19349.4195174145, 966.4491239993137, 978.848278516831, 989.0850962859327, 1021.2136654775929, 1056.7252514346326, 10631.682793395084, 10939.179561532757, 11018.983961223457, 11052.834207486734, 11059.72350691239, 441495.0, 441642.0, 457940.0, 458836.0, 462111.68944155064, 78405.0, 79616.20383796089, 80060.59969700231, 80261.0, 80790.0, 1034.4414016431194, 1041.9114375278034, 1082.2045796339685, 1108.8004159251411, 1115.1246271676696, 16835.915820420818, 16856.494305170865, 16908.915455422644, 17080.145992700564, 17632.647347053244, 37951.43072853965, 38743.612563874, 39020.41469377905, 39162.80418597889, 39537.406938895365, 50327.74836125942, 50823.491765081875, 50845.49154508408, 51078.744606276734, 53031.0, 7982.241687039722, 8077.15189905075, 8164.346852251924, 8253.298469629908, 8466.661333546836, 12093.455794489446, 12264.632061038183, 12270.815937760763, 12413.44139513742, 12639.304838233986, 10001.899981000388, 10460.215483838894, 10820.350778953289, 10861.239713219999, 11311.660650180507, 10941.671749847517, 10975.134227181557, 10987.670369888916, 11300.378479183395, 11324.773504530029, 10839.945800271264, 11230.606928757781, 11250.437478125898, 11281.548738050386, 11301.604443844426, 8176.059753128228, 8209.481245969277, 8220.177982201732, 8411.200935911078, 8486.236238738296, 10167.898321016992, 10535.0, 10662.73343166427, 11098.50056747432, 11157.0], "value": 8969.234293411466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.7786065299226, 1424.8860091192703, 1487.7917091607173, 1594.5774369792007, 1771.9025453600054, 8582.098879617635, 8968.865467018, 8971.23744481719, 9254.768630784234, 9293.44239345638, 8901.19889209971, 9197.21823644991, 9198.678046268382, 9203.677871274507, 9208.217301529361, 2008.4677560446494, 2215.1360969222014, 2315.9305220843403, 2341.683872677188, 2378.714554253483, 2325.7092863392077, 2328.7554806745216, 2331.80179684727, 2333.9299821005397, 2335.4278201840575, 2320.477892474188, 2331.463763334434, 2356.1282325539573, 2358.056777289081, 2361.515889242701, 1951.5121219695077, 2219.4673278413225, 2252.3805953362876, 2276.8747718875456, 2284.280451657739, 2291.129370839087, 2302.056156975632, 2316.8841557922206, 2318.07277089164, 2322.93031209064, 8957.776055598597, 8958.014618392037, 8996.190342869173, 9055.547222638908, 9067.954660226722, 5053.1157047516535, 5194.35070616173, 5202.08963431398, 5205.037068142406, 5206.583473322125, 3188.85650145744, 3269.7057264846276, 3346.28054968183, 3356.5636467259346, 3387.9830600847085, 1081.9026287634072, 1106.750981029262, 1147.7474955509774, 1151.0101312871009, 1164.6855349055706, 12524.0, 12585.874141258562, 12601.117921745481, 12603.684907877285, 12607.621771346874, 4439.511653718088, 4568.88577785558, 4587.8623641290815, 4675.3869914879315, 4684.95315046852, 10461.9476902615, 10488.475576221159, 10501.474926253657, 10573.788524229472, 10586.258961872749, 5284.4187139414635, 5296.788128474895, 5298.682079075268, 5298.761555730001, 5301.125314323171, 4232.978835105866, 4663.650226233046, 4865.099956508057, 4884.853454396374, 4885.853424397274, 3956.4065390191126, 4032.858849940238, 4035.878923632296, 4095.877123686294, 4111.9177616447505, 1247.25788156047, 1266.4047897488165, 1268.2580690296095, 1283.0441321215753, 1288.0854593238905, 864.6541383446546, 935.6584846530967, 1002.498780475659, 1007.992007992008, 1016.8068067067234, 5999.970000150059, 6177.938220617826, 6200.782972596027, 6209.720562574695, 6296.275928268216, 929.3215952354819, 948.0472125513814, 966.8839739231337, 986.6990567876867, 1025.1337619711333, 4115.218108559364, 4159.916801664011, 4270.274053410928, 4278.080212754273, 4324.308110702335, 10558.630447934285, 10830.729231769268, 10887.0, 10914.290571113012, 10922.126229901589, 10545.578176872992, 10656.307340022873, 10724.356538607552, 10828.025477707044, 10967.945160274307, 8313.542755148525, 8430.15698430152, 8438.071812100665, 8461.873071903927, 8472.068072512018, 6042.1843051187525, 6256.957583079093, 6313.96843015782, 6359.014352775327, 6367.777127800505, 10372.325798823053, 10594.576216951236, 10668.89331106679, 10683.0, 10737.731556711145, 10406.427646479517, 10520.10579100785, 10739.087177589992, 10847.620333288298, 10875.836862446911, 7342.155652100077, 7480.513766605153, 7493.962530187314, 8075.071366792894, 8215.835683286421, 8237.546934918637, 8289.4197406181, 8542.957285213533, 8584.098669639598, 8811.0, 7688.154303026775, 7723.691052357843, 7764.378849692124, 7874.960625196837, 7976.880346794686, 7139.785806425815, 7772.961135194514, 7781.494202876795, 7838.098618658927, 7977.202279772208, 6898.206706228848, 7090.539114957512, 7114.786556403109, 7123.857522849617, 7141.035960145522, 5061.772220250024, 5154.0, 5241.659292146151, 5297.337832770903, 5399.487048730364, 5207.973960130175, 5430.456954304538, 5494.09347457681, 5645.040343141593, 5672.602917795714], "value": 4690.557174323364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8097132206336, 323.9497877828937, 326.9133679574912, 331.4481388488166, 332.7504371721209, 5052.322269197327, 5154.716490593016, 5204.739763011844, 5206.921896171561, 5253.0, 5119.38567371915, 5143.048536020839, 5149.74251287436, 5164.586833053356, 5173.370388327674, 3989.2221016901717, 4079.673626109904, 4087.816048277835, 4092.7135100542973, 4098.815553300109, 4039.53545342285, 4058.715889887709, 4062.614051665087, 4067.376542130324, 4076.7757773322455, 3984.760914345134, 4013.4782478277784, 4013.5384430790396, 4027.335489644205, 4028.67770578353, 3860.36304009838, 3881.243157584244, 4033.2135233629306, 4048.4332193492933, 4090.3455447128317, 3612.4942508048894, 3623.0, 3623.9456408153897, 3635.6909662678704, 3642.4354225095153, 4971.179755340365, 4980.302757613937, 4995.700257984497, 4996.625253106032, 5004.524570165829, 4394.296912494017, 4461.349300758708, 4593.56361145694, 4640.651951103647, 4671.929921051187, 5344.251804747339, 5347.41178470368, 5372.677639341652, 5377.892442151135, 5379.946200537984, 3905.023744063984, 3906.0, 3906.2968665640174, 3920.15716620925, 3935.8622448214173, 5314.263154475449, 5509.5041446270025, 5535.972320138414, 5539.169124631298, 5540.778368865241, 3997.8800635980965, 4031.8992025199605, 4040.8585699500964, 4042.292598795199, 4044.4539987101953, 4057.539285857089, 4077.4495443115393, 4096.955276404497, 4102.897427564275, 4115.794210289474, 4413.933790993137, 4552.180607490617, 4627.375304333939, 4662.580367766917, 4668.0, 5390.21841832932, 5393.002294575516, 5425.945740542623, 5436.429174936654, 5455.117984295412, 1404.8269694804749, 1411.6823714664324, 1415.6177831985513, 1422.679897023182, 1423.3452611798482, 873.8512292828564, 916.6791622932054, 930.9487978161267, 931.1154403316876, 935.9423851048272, 4611.532829935968, 4615.653825963066, 4656.301554766745, 4738.47876733559, 4743.549362810528, 4876.219804831281, 4910.379574740327, 4912.70523768575, 4921.261810728348, 4956.231784073474, 4624.953750462452, 4633.675642705046, 4637.86086417408, 4767.092073834958, 4914.459409464956, 2865.0402115291613, 2901.332693480469, 2967.792254542161, 2995.715407036328, 3002.324476992659, 5820.82537523875, 5826.883462330815, 5830.5627077968475, 5832.825015249549, 5836.824895253149, 5292.629515933924, 5576.860578485489, 5612.663240205519, 5700.37295897451, 5719.342275638355, 5739.540836732968, 5740.196372507852, 5754.510866576305, 5756.136579513107, 5778.913316300259, 5357.303550538405, 5505.311836020497, 5518.19986102021, 5556.333240011225, 5572.969000734877, 5415.918761218663, 5483.287172667528, 5487.0, 5493.697846618475, 5494.0, 5716.142578613241, 5719.342275638355, 5734.770609175753, 5737.770489180386, 5766.5675074368755, 3818.789966551866, 3961.7520481048377, 3976.940345894756, 3986.481757371523, 3996.8201430935096, 5517.310336207974, 5546.58400619947, 5548.556115510669, 5560.304961879765, 5576.665400076008, 5403.486668766461, 5404.162354835007, 5427.782888684408, 5435.945640543544, 5439.238506609157, 5152.76812543444, 5393.919091213714, 5423.322084739408, 5449.128139497661, 5464.562834973272, 5343.812966546152, 5349.705766182898, 5358.437364076716, 5365.678059316453, 5367.624266301322, 5467.933752918143, 5489.33767122937, 5492.80775172867, 5495.148252020943, 5502.404302752318, 5135.3324067870935, 5323.547498462674, 5348.919766203432, 5349.839504814861, 5379.811706590251], "value": 4105.067752862151, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.1240743607283, 686.6292202210807, 718.4862823081496, 727.2691242550204, 733.2667332667332, 14867.40530378785, 15678.84321156788, 15720.37118515261, 15732.29204685789, 15761.842381576182, 13633.182009079463, 13691.0, 13807.792883106737, 13842.584722458318, 15129.92435037826, 781.7732857471326, 790.3519114326255, 794.964226609804, 795.0459448661601, 796.0884786918974, 668.9230738465066, 775.9757120600809, 797.8882956386111, 799.7240951871595, 805.0862271322062, 830.622066959535, 831.0650518167062, 832.24681663095, 833.7748807821915, 835.1940377535677, 690.7927621713466, 828.6561077152975, 829.1087081387502, 830.5764060329216, 832.9333653307721, 592.2744637818638, 606.1877084706471, 606.6481440764346, 608.8173547935646, 610.0209164291293, 14036.92981535096, 14046.367913443919, 14068.155910645393, 14069.36687849039, 14121.293935303194, 13243.933780331134, 13981.161130332213, 14025.71948561023, 14075.366608502642, 14110.0, 11402.71493212668, 11460.255083419552, 11703.0, 11926.522939082426, 12122.454489547992, 4297.205017071852, 4350.260455722535, 4374.8906277343, 4399.912001759947, 4558.680892337537, 69052.3094769051, 69173.65413172952, 69260.30739692588, 69391.65304173446, 70898.0, 10287.742806429898, 10475.528601212964, 10794.082502987178, 10990.120790336754, 11064.225504214628, 19970.500737481678, 20170.798292017185, 20200.292989745583, 20208.09063592142, 20254.0, 8103.230193131643, 8270.917290827014, 8338.749837504885, 8365.749027529184, 8514.914850851412, 4549.021960278556, 4664.277037059262, 4711.1519926413575, 4829.275608658659, 4986.127427700138, 3357.84889679965, 3449.8275086245585, 3452.8273586320583, 3467.878624248139, 3494.6155922848466, 587.4067192135974, 592.1857446011734, 596.8209537138841, 612.6201754911983, 616.7687117331001, 520.1391696741898, 542.4765101676901, 590.3594599859201, 600.3396264109444, 676.4149011105457, 9108.635654573874, 9117.680881169128, 9167.298710630374, 9171.266298696088, 9274.95362523183, 608.2761513798565, 695.436696276008, 702.2065066474851, 702.880510313248, 721.0878239027634, 4359.17175736609, 4499.0, 4536.931946020813, 4552.294394368878, 4694.342792009122, 91885.54057229671, 97531.0, 97782.5110874441, 107819.0, 108969.45515272532, 44239.778801105786, 61382.69308653428, 62772.68613656903, 63296.683516582125, 81782.59108704419, 82788.58605706813, 83197.58401207955, 85261.0, 86020.13979860247, 87822.0, 9534.141927226583, 9676.27427942893, 9750.60997560118, 9783.41299522031, 9834.803303933739, 48902.510974889796, 49420.50579494159, 50240.0, 50569.0, 50575.241371378725, 59505.70247148736, 77194.2280577187, 77210.22789772031, 77403.61298193473, 77782.0, 11922.642320730392, 12044.73873471702, 12279.421321522581, 12293.815592765937, 12613.74772504563, 13928.233947133005, 14040.508582199982, 14085.647858803202, 14361.0, 14507.202103884387, 12028.338441385458, 12141.15011949155, 13149.60161731495, 13188.670283242996, 13356.532521361705, 12862.421191046613, 12999.41502632365, 13171.47314107425, 13220.735585288432, 13552.322383880964, 12005.75988480243, 12239.75520489603, 12773.297468639314, 12832.743345132858, 13017.934910325388, 10394.896051039696, 10599.470026498799, 10712.625058122929, 10759.139268858316, 11070.723231919266, 11169.329840209613, 11324.94337528307, 11358.60244891425, 11484.712882178012, 11695.298282103102], "value": 7185.599656328232, "unit": "score"}], "name": "dromaeo_css", "value": 7120.798300063141, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 111.0, 109.0, 108.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 125.0, 178.0, 125.0, 125.0, 163.0, 137.0, 189.0, 135.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 161.0, 168.0, 160.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 126.0, 83.0, 74.0, 73.0, 73.0, 106.0, 73.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 112.0, 85.0, 85.0, 85.0, 127.0, 85.0, 86.0, 124.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 53.0, 51.0, 52.0, 55.0, 54.0, 52.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 62.0, 61.0, 61.0, 63.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 79.0, 84.0, 86.0, 82.0, 86.0, 87.0, 115.0, 80.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 124.0, 131.0, 130.0, 131.0, 120.0, 120.0, 128.0, 129.0, 122.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 161.0, 162.0, 159.0, 166.0, 160.0, 158.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 65.0, 63.0, 64.0, 64.0, 63.0, 63.0, 66.0, 61.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1506.1000000000004, "alertThreshold": 2.0}]} 17:32:28 INFO - Return code: 0 17:32:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:32:28 ERROR - # TBPL SUCCESS # 17:32:28 INFO - Running post-action listener: _resource_record_post_action 17:32:28 INFO - ##### 17:32:28 INFO - ##### Finished run-tests step (success) 17:32:28 INFO - ##### 17:32:28 INFO - Running post-run listener: _resource_record_post_run 17:32:28 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548495360; Read time: 168; Write time: 1357596 17:32:28 INFO - TinderboxPrint: CPU usage
13.3% 17:32:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 168 17:32:28 INFO - TinderboxPrint: I/O write bytes / time
548,495,360 / 1,357,596 17:32:28 INFO - TinderboxPrint: CPU idle
8,286.8 (86.7%) 17:32:28 INFO - TinderboxPrint: CPU user
1,207.9 (12.6%) 17:32:28 INFO - TinderboxPrint: Swap in / out
0 / 0 17:32:28 INFO - install - Wall time: 20s; CPU: 18.0%; Read bytes: 0; Write bytes: 255553536; Read time: 0; Write time: 844504 17:32:28 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292483072; Read time: 168; Write time: 513092 17:32:29 INFO - Running post-run listener: _upload_blobber_files 17:32:29 INFO - Blob upload gear active. 17:32:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:32:29 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:32:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:33 INFO - (blobuploader) - INFO - Done attempting. 17:32:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:32:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:32:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:34 INFO - (blobuploader) - INFO - Done attempting. 17:32:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:32:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:32:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:35 INFO - (blobuploader) - INFO - Done attempting. 17:32:35 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:35 INFO - Return code: 0 17:32:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e287a3522d9407e015204392ed844205fd50af5b10b7a7f6739400ea81fb461b7b90fd4f87eaeb6b91b357863463dc399b95d0d6ada048a490e8e063dd1ccb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94464055214d2f92abd190bc2e79f339566d537d07d06c5a1fa0ae3656f2f760cb457e95134f43f70261935bc11af09133451dd49629a292fa794c446a052462", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6508148e56111e203bb238571aa4a3d52673268f6246228e67d9a84a51af86d07bd1fe530cff09f9046b5a995ce00d708b472edc02318e6bbfa6a0cff28e27af"} 17:32:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:35 INFO - Contents: 17:32:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e287a3522d9407e015204392ed844205fd50af5b10b7a7f6739400ea81fb461b7b90fd4f87eaeb6b91b357863463dc399b95d0d6ada048a490e8e063dd1ccb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94464055214d2f92abd190bc2e79f339566d537d07d06c5a1fa0ae3656f2f760cb457e95134f43f70261935bc11af09133451dd49629a292fa794c446a052462", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6508148e56111e203bb238571aa4a3d52673268f6246228e67d9a84a51af86d07bd1fe530cff09f9046b5a995ce00d708b472edc02318e6bbfa6a0cff28e27af"} 17:32:35 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:35 INFO - Copying logs to upload dir... 17:32:35 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.881475 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-08 17:32:35.324685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:35.327891) ========= 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=745a4373a2a16df560f216e000000264-1465431113.347518-1666325503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e287a3522d9407e015204392ed844205fd50af5b10b7a7f6739400ea81fb461b7b90fd4f87eaeb6b91b357863463dc399b95d0d6ada048a490e8e063dd1ccb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94464055214d2f92abd190bc2e79f339566d537d07d06c5a1fa0ae3656f2f760cb457e95134f43f70261935bc11af09133451dd49629a292fa794c446a052462", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6508148e56111e203bb238571aa4a3d52673268f6246228e67d9a84a51af86d07bd1fe530cff09f9046b5a995ce00d708b472edc02318e6bbfa6a0cff28e27af"} build_url:https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e287a3522d9407e015204392ed844205fd50af5b10b7a7f6739400ea81fb461b7b90fd4f87eaeb6b91b357863463dc399b95d0d6ada048a490e8e063dd1ccb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94464055214d2f92abd190bc2e79f339566d537d07d06c5a1fa0ae3656f2f760cb457e95134f43f70261935bc11af09133451dd49629a292fa794c446a052462", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6508148e56111e203bb238571aa4a3d52673268f6246228e67d9a84a51af86d07bd1fe530cff09f9046b5a995ce00d708b472edc02318e6bbfa6a0cff28e27af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:35.353075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:35.353402) ========= 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=745a4373a2a16df560f216e000000264-1465431113.347518-1666325503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:35.438086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:32:35.438403) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:32:35.438751) ========= ========= Total master_lag: 0.27 =========