builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1466014690.77 results: success (0) buildid: 20160615083055 builduid: 4e827579fcaa412a9eb804da878b3e56 revision: 153553aecf160632bbcb50906ba135511da138e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.774347) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.774823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.775147) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.797932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.798201) ========= 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=52faae308a556c440401f8e5000001e8-1466014205.322545-470370542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 11:18:11-- 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% 78.5M=0s 2016-06-15 11:18:11 (78.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074399 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.886319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.886624) ========= 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=52faae308a556c440401f8e5000001e8-1466014205.322545-470370542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017095 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.936055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.936379) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 153553aecf160632bbcb50906ba135511da138e6 --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 153553aecf160632bbcb50906ba135511da138e6 --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=52faae308a556c440401f8e5000001e8-1466014205.322545-470370542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 11:18:11,505 truncating revision to first 12 chars 2016-06-15 11:18:11,505 Setting DEBUG logging. 2016-06-15 11:18:11,506 attempt 1/10 2016-06-15 11:18:11,506 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/153553aecf16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 11:18:11,809 unpacking tar archive at: fx-team-153553aecf16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629351 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.580003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.580445) ========= script_repo_revision: 153553aecf160632bbcb50906ba135511da138e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.580898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.581190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.590488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-15 11:18:11.590786) ========= /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=52faae308a556c440401f8e5000001e8-1466014205.322545-470370542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:12 INFO - MultiFileLogger online at 20160615 11:18:12 in /builds/slave/test 11:18:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:18:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:12 INFO - {'append_to_log': False, 11:18:12 INFO - 'base_work_dir': '/builds/slave/test', 11:18:12 INFO - 'blob_upload_branch': 'Fx-Team', 11:18:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:12 INFO - 'branch': 'Fx-Team', 11:18:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:12 INFO - 'config_files': ('talos/linux_config.py',), 11:18:12 INFO - 'default_actions': ('clobber', 11:18:12 INFO - 'read-buildbot-config', 11:18:12 INFO - 'download-and-extract', 11:18:12 INFO - 'populate-webroot', 11:18:12 INFO - 'create-virtualenv', 11:18:12 INFO - 'install', 11:18:12 INFO - 'run-tests'), 11:18:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:12 INFO - 'download_minidump_stackwalk': True, 11:18:12 INFO - 'download_symbols': 'ondemand', 11:18:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:12 INFO - 'installer_path': 'installer.exe', 11:18:12 INFO - 'log_level': 'info', 11:18:12 INFO - 'log_name': 'talos', 11:18:12 INFO - 'log_to_console': True, 11:18:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:12 INFO - 'opt_config_files': (), 11:18:12 INFO - 'pip_index': False, 11:18:12 INFO - 'sps_profile': False, 11:18:12 INFO - 'sps_profile_interval': 0, 11:18:12 INFO - 'suite': 'dromaeojs', 11:18:12 INFO - 'system_bits': '32', 11:18:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:12 INFO - 'title': 'talos-linux64-ix-056', 11:18:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:12 INFO - 'use_talos_json': True, 11:18:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:12 INFO - 'work_dir': 'build'} 11:18:12 INFO - ##### 11:18:12 INFO - ##### Running clobber step. 11:18:12 INFO - ##### 11:18:12 INFO - Running pre-action listener: _resource_record_pre_action 11:18:12 INFO - Running main action method: clobber 11:18:12 INFO - rmtree: /builds/slave/test/build 11:18:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:13 INFO - Running post-action listener: _resource_record_post_action 11:18:13 INFO - ##### 11:18:13 INFO - ##### Finished clobber step (success) 11:18:13 INFO - ##### 11:18:13 INFO - ##### 11:18:13 INFO - ##### Running read-buildbot-config step. 11:18:13 INFO - ##### 11:18:13 INFO - Running pre-action listener: _resource_record_pre_action 11:18:13 INFO - Running main action method: read_buildbot_config 11:18:13 INFO - Using buildbot properties: 11:18:13 INFO - { 11:18:13 INFO - "project": "", 11:18:13 INFO - "product": "firefox", 11:18:13 INFO - "script_repo_revision": "production", 11:18:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:18:13 INFO - "repository": "", 11:18:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:18:13 INFO - "buildid": "20160615083055", 11:18:13 INFO - "pgo_build": "True", 11:18:13 INFO - "basedir": "/builds/slave/test", 11:18:13 INFO - "buildnumber": 188, 11:18:13 INFO - "slavename": "talos-linux64-ix-056", 11:18:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:18:13 INFO - "platform": "ubuntu64_hw", 11:18:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:18:13 INFO - "branch": "fx-team", 11:18:13 INFO - "repo_path": "integration/fx-team", 11:18:13 INFO - "revision": "153553aecf160632bbcb50906ba135511da138e6", 11:18:13 INFO - "stage_platform": "linux64-pgo", 11:18:13 INFO - "builduid": "4e827579fcaa412a9eb804da878b3e56", 11:18:13 INFO - "slavebuilddir": "test" 11:18:13 INFO - } 11:18:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:18:13 INFO - Running post-action listener: _resource_record_post_action 11:18:13 INFO - ##### 11:18:13 INFO - ##### Finished read-buildbot-config step (success) 11:18:13 INFO - ##### 11:18:13 INFO - ##### 11:18:13 INFO - ##### Running download-and-extract step. 11:18:13 INFO - ##### 11:18:13 INFO - Running pre-action listener: _resource_record_pre_action 11:18:13 INFO - Running main action method: download_and_extract 11:18:13 INFO - mkdir: /builds/slave/test/build/tests 11:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:13 INFO - https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:18:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:16 INFO - Downloaded 1361 bytes. 11:18:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:16 INFO - Using the following test package requirements: 11:18:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:18:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:18:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:16 INFO - u'jsshell-linux-x86_64.zip'], 11:18:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:18:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:18:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:18:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:18:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:18:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:16 INFO - https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:17 INFO - Downloaded 24220181 bytes. 11:18:17 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'] 11:18:17 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 11:18:19 INFO - Return code: 0 11:18:19 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 11:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:19 INFO - https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:25 INFO - Downloaded 24220181 bytes. 11:18:25 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'] 11:18:25 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 11:18:27 INFO - Return code: 0 11:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:27 INFO - https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:29 INFO - Downloaded 14405384 bytes. 11:18:29 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'] 11:18:29 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 11:18:30 INFO - Return code: 0 11:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:30 INFO - https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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 11:18:32 INFO - Downloaded 59386487 bytes. 11:18:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:32 INFO - mkdir: /builds/slave/test/properties 11:18:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:32 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:32 INFO - Contents: 11:18:32 INFO - build_url:https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:33 INFO - Running post-action listener: _resource_record_post_action 11:18:33 INFO - Running post-action listener: set_extra_try_arguments 11:18:33 INFO - ##### 11:18:33 INFO - ##### Finished download-and-extract step (success) 11:18:33 INFO - ##### 11:18:33 INFO - ##### 11:18:33 INFO - ##### Running populate-webroot step. 11:18:33 INFO - ##### 11:18:33 INFO - Running pre-action listener: _resource_record_pre_action 11:18:33 INFO - Running main action method: populate_webroot 11:18:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:33 INFO - '--tppagecycles', 11:18:33 INFO - '7'], 11:18:33 INFO - 'tests': ['tsvgm']}}, 11:18:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['damp', 'tps']}, 11:18:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'tests': ['damp', 'tps']}, 11:18:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['dromaeo_dom']}, 11:18:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['basic_compositor_video']}, 11:18:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['tsvgx', 11:18:33 INFO - 'tsvgr_opacity', 11:18:33 INFO - 'tart', 11:18:33 INFO - 'tscrollx', 11:18:33 INFO - 'cart']}, 11:18:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:33 INFO - 'tsvgr_opacity', 11:18:33 INFO - 'tart', 11:18:33 INFO - 'tscrollx', 11:18:33 INFO - 'cart']}, 11:18:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['tp5o']}, 11:18:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'tests': ['tp5o']}, 11:18:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--disable-e10s', 11:18:33 INFO - '--xperf_path', 11:18:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:33 INFO - 'tests': ['tp5n']}, 11:18:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--xperf_path', 11:18:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:33 INFO - 'tests': ['tp5n']}}, 11:18:33 INFO - 'talos.zip': {'path': '', 11:18:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:33 INFO - Running post-action listener: _resource_record_post_action 11:18:33 INFO - ##### 11:18:33 INFO - ##### Finished populate-webroot step (success) 11:18:33 INFO - ##### 11:18:33 INFO - ##### 11:18:33 INFO - ##### Running create-virtualenv step. 11:18:33 INFO - ##### 11:18:33 INFO - Running pre-action listener: _resource_record_pre_action 11:18:33 INFO - Running main action method: create_virtualenv 11:18:33 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:18:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:33 INFO - Using real prefix '/usr' 11:18:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:35 INFO - Installing pip.................done. 11:18:35 INFO - Return code: 0 11:18:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:18:35 INFO - Using env: {'DISPLAY': ':0', 11:18:35 INFO - 'HOME': '/home/cltbld', 11:18:35 INFO - 'LANG': 'en_US.UTF-8', 11:18:35 INFO - 'LANGUAGE': 'en_US:en', 11:18:35 INFO - 'LOGNAME': 'cltbld', 11:18:35 INFO - 'MAIL': '/var/mail/cltbld', 11:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:35 INFO - 'MOZ_NO_REMOTE': '1', 11:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:35 INFO - 'NO_EM_RESTART': '1', 11:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:35 INFO - 'PWD': '/builds/slave/test', 11:18:35 INFO - 'SHELL': '/bin/bash', 11:18:35 INFO - 'SHLVL': '1', 11:18:35 INFO - 'TERM': 'linux', 11:18:35 INFO - 'TMOUT': '86400', 11:18:35 INFO - 'USER': 'cltbld', 11:18:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:35 INFO - '_': '/tools/buildbot/bin/python'} 11:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:18:35 INFO - Cleaning up... 11:18:36 INFO - Return code: 0 11:18:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:18:36 INFO - Using env: {'DISPLAY': ':0', 11:18:36 INFO - 'HOME': '/home/cltbld', 11:18:36 INFO - 'LANG': 'en_US.UTF-8', 11:18:36 INFO - 'LANGUAGE': 'en_US:en', 11:18:36 INFO - 'LOGNAME': 'cltbld', 11:18:36 INFO - 'MAIL': '/var/mail/cltbld', 11:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:36 INFO - 'MOZ_NO_REMOTE': '1', 11:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:36 INFO - 'NO_EM_RESTART': '1', 11:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:36 INFO - 'PWD': '/builds/slave/test', 11:18:36 INFO - 'SHELL': '/bin/bash', 11:18:36 INFO - 'SHLVL': '1', 11:18:36 INFO - 'TERM': 'linux', 11:18:36 INFO - 'TMOUT': '86400', 11:18:36 INFO - 'USER': 'cltbld', 11:18:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:36 INFO - '_': '/tools/buildbot/bin/python'} 11:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:36 INFO - Downloading/unpacking psutil>=3.1.1 11:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:38 INFO - Installing collected packages: psutil 11:18:38 INFO - Running setup.py install for psutil 11:18:38 INFO - building 'psutil._psutil_linux' extension 11:18:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:18:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:18:38 INFO - building 'psutil._psutil_posix' extension 11:18:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:18:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:38 INFO - Successfully installed psutil 11:18:38 INFO - Cleaning up... 11:18:38 INFO - Return code: 0 11:18:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:18:38 INFO - Using env: {'DISPLAY': ':0', 11:18:38 INFO - 'HOME': '/home/cltbld', 11:18:38 INFO - 'LANG': 'en_US.UTF-8', 11:18:38 INFO - 'LANGUAGE': 'en_US:en', 11:18:38 INFO - 'LOGNAME': 'cltbld', 11:18:38 INFO - 'MAIL': '/var/mail/cltbld', 11:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:38 INFO - 'MOZ_NO_REMOTE': '1', 11:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:38 INFO - 'NO_EM_RESTART': '1', 11:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:38 INFO - 'PWD': '/builds/slave/test', 11:18:38 INFO - 'SHELL': '/bin/bash', 11:18:38 INFO - 'SHLVL': '1', 11:18:38 INFO - 'TERM': 'linux', 11:18:38 INFO - 'TMOUT': '86400', 11:18:38 INFO - 'USER': 'cltbld', 11:18:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:38 INFO - '_': '/tools/buildbot/bin/python'} 11:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:40 INFO - Installing collected packages: mozsystemmonitor 11:18:40 INFO - Running setup.py install for mozsystemmonitor 11:18:41 INFO - Successfully installed mozsystemmonitor 11:18:41 INFO - Cleaning up... 11:18:41 INFO - Return code: 0 11:18:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:18:41 INFO - Using env: {'DISPLAY': ':0', 11:18:41 INFO - 'HOME': '/home/cltbld', 11:18:41 INFO - 'LANG': 'en_US.UTF-8', 11:18:41 INFO - 'LANGUAGE': 'en_US:en', 11:18:41 INFO - 'LOGNAME': 'cltbld', 11:18:41 INFO - 'MAIL': '/var/mail/cltbld', 11:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:41 INFO - 'MOZ_NO_REMOTE': '1', 11:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:41 INFO - 'NO_EM_RESTART': '1', 11:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:41 INFO - 'PWD': '/builds/slave/test', 11:18:41 INFO - 'SHELL': '/bin/bash', 11:18:41 INFO - 'SHLVL': '1', 11:18:41 INFO - 'TERM': 'linux', 11:18:41 INFO - 'TMOUT': '86400', 11:18:41 INFO - 'USER': 'cltbld', 11:18:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:41 INFO - '_': '/tools/buildbot/bin/python'} 11:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:41 INFO - Downloading/unpacking jsonschema==2.5.1 11:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:43 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:43 INFO - warning: no files found matching '*.txt' 11:18:43 INFO - no previously-included directories found matching 'build' 11:18:43 INFO - no previously-included directories found matching 'dist' 11:18:43 INFO - no previously-included directories found matching '.git*' 11:18:43 INFO - Installing collected packages: jsonschema, functools32 11:18:43 INFO - Running setup.py install for functools32 11:18:43 INFO - warning: no files found matching '*.txt' 11:18:43 INFO - no previously-included directories found matching 'build' 11:18:43 INFO - no previously-included directories found matching 'dist' 11:18:43 INFO - no previously-included directories found matching '.git*' 11:18:43 INFO - Successfully installed jsonschema functools32 11:18:43 INFO - Cleaning up... 11:18:43 INFO - Return code: 0 11:18:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:18:43 INFO - Using env: {'DISPLAY': ':0', 11:18:43 INFO - 'HOME': '/home/cltbld', 11:18:43 INFO - 'LANG': 'en_US.UTF-8', 11:18:43 INFO - 'LANGUAGE': 'en_US:en', 11:18:43 INFO - 'LOGNAME': 'cltbld', 11:18:43 INFO - 'MAIL': '/var/mail/cltbld', 11:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:43 INFO - 'MOZ_NO_REMOTE': '1', 11:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:43 INFO - 'NO_EM_RESTART': '1', 11:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:43 INFO - 'PWD': '/builds/slave/test', 11:18:43 INFO - 'SHELL': '/bin/bash', 11:18:43 INFO - 'SHLVL': '1', 11:18:43 INFO - 'TERM': 'linux', 11:18:43 INFO - 'TMOUT': '86400', 11:18:43 INFO - 'USER': 'cltbld', 11:18:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:43 INFO - '_': '/tools/buildbot/bin/python'} 11:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:46 INFO - Downloading docopt-0.6.1.tar.gz 11:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:46 INFO - Running setup.py install for blobuploader 11:18:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:46 INFO - Running setup.py install for requests 11:18:47 INFO - Running setup.py install for docopt 11:18:47 INFO - Successfully installed blobuploader requests docopt 11:18:47 INFO - Cleaning up... 11:18:47 INFO - Return code: 0 11:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:47 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 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:47 INFO - Using env: {'DISPLAY': ':0', 11:18:47 INFO - 'HOME': '/home/cltbld', 11:18:47 INFO - 'LANG': 'en_US.UTF-8', 11:18:47 INFO - 'LANGUAGE': 'en_US:en', 11:18:47 INFO - 'LOGNAME': 'cltbld', 11:18:47 INFO - 'MAIL': '/var/mail/cltbld', 11:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:47 INFO - 'MOZ_NO_REMOTE': '1', 11:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:47 INFO - 'NO_EM_RESTART': '1', 11:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:47 INFO - 'PWD': '/builds/slave/test', 11:18:47 INFO - 'SHELL': '/bin/bash', 11:18:47 INFO - 'SHLVL': '1', 11:18:47 INFO - 'TERM': 'linux', 11:18:47 INFO - 'TMOUT': '86400', 11:18:47 INFO - 'USER': 'cltbld', 11:18:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:47 INFO - '_': '/tools/buildbot/bin/python'} 11:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:47 INFO - Running setup.py (path:/tmp/pip-W20S1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:47 INFO - Running setup.py (path:/tmp/pip-a_UlYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:47 INFO - Running setup.py (path:/tmp/pip-W6DOgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:47 INFO - Running setup.py (path:/tmp/pip-3dTdoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:47 INFO - Running setup.py (path:/tmp/pip-5k3rGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:47 INFO - Running setup.py (path:/tmp/pip-SG_MAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:47 INFO - Running setup.py (path:/tmp/pip-EEplhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:47 INFO - Running setup.py (path:/tmp/pip-0l9c_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:48 INFO - Running setup.py (path:/tmp/pip-M6Vgrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:48 INFO - Running setup.py (path:/tmp/pip-IX1fn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:48 INFO - Running setup.py (path:/tmp/pip-mVrKHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:48 INFO - Running setup.py (path:/tmp/pip-JGSt8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:48 INFO - Running setup.py (path:/tmp/pip-JN0owg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:48 INFO - Running setup.py (path:/tmp/pip-br8EBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:48 INFO - Running setup.py (path:/tmp/pip-66OoSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:48 INFO - Running setup.py (path:/tmp/pip-mzg7X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:48 INFO - Running setup.py (path:/tmp/pip-WZfZ0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:48 INFO - Running setup.py install for manifestparser 11:18:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:48 INFO - Running setup.py install for mozcrash 11:18:48 INFO - Running setup.py install for mozdebug 11:18:48 INFO - Running setup.py install for mozdevice 11:18:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Running setup.py install for mozfile 11:18:49 INFO - Running setup.py install for mozhttpd 11:18:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Running setup.py install for mozinfo 11:18:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Running setup.py install for mozInstall 11:18:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Running setup.py install for mozleak 11:18:49 INFO - Running setup.py install for mozlog 11:18:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Running setup.py install for moznetwork 11:18:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Running setup.py install for mozprocess 11:18:49 INFO - Running setup.py install for mozprofile 11:18:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozrunner 11:18:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozscreenshot 11:18:50 INFO - Running setup.py install for moztest 11:18:50 INFO - Running setup.py install for mozversion 11:18:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:50 INFO - Cleaning up... 11:18:50 INFO - Return code: 0 11:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:50 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 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:50 INFO - Using env: {'DISPLAY': ':0', 11:18:50 INFO - 'HOME': '/home/cltbld', 11:18:50 INFO - 'LANG': 'en_US.UTF-8', 11:18:50 INFO - 'LANGUAGE': 'en_US:en', 11:18:50 INFO - 'LOGNAME': 'cltbld', 11:18:50 INFO - 'MAIL': '/var/mail/cltbld', 11:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:50 INFO - 'MOZ_NO_REMOTE': '1', 11:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:50 INFO - 'NO_EM_RESTART': '1', 11:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:50 INFO - 'PWD': '/builds/slave/test', 11:18:50 INFO - 'SHELL': '/bin/bash', 11:18:50 INFO - 'SHLVL': '1', 11:18:50 INFO - 'TERM': 'linux', 11:18:50 INFO - 'TMOUT': '86400', 11:18:50 INFO - 'USER': 'cltbld', 11:18:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:50 INFO - '_': '/tools/buildbot/bin/python'} 11:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:50 INFO - Running setup.py (path:/tmp/pip-lk3qlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:50 INFO - Running setup.py (path:/tmp/pip-vFGdMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:50 INFO - Running setup.py (path:/tmp/pip-NlbEvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:50 INFO - Running setup.py (path:/tmp/pip-IAlo8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:51 INFO - Running setup.py (path:/tmp/pip-8plfRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:51 INFO - Running setup.py (path:/tmp/pip-kEICPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:51 INFO - Running setup.py (path:/tmp/pip-3r57wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:51 INFO - Running setup.py (path:/tmp/pip-WZaIBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:51 INFO - Running setup.py (path:/tmp/pip-6mOy5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:51 INFO - Running setup.py (path:/tmp/pip-3vvGlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:51 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)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:51 INFO - Running setup.py (path:/tmp/pip-x2cKDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:51 INFO - Running setup.py (path:/tmp/pip-cRVpHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:51 INFO - Running setup.py (path:/tmp/pip-JUW3WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:51 INFO - Running setup.py (path:/tmp/pip-xDWGyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:51 INFO - Running setup.py (path:/tmp/pip-GJiTiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:51 INFO - Running setup.py (path:/tmp/pip-e1o50K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:51 INFO - Running setup.py (path:/tmp/pip-PnUV4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:53 INFO - Downloading blessings-1.6.tar.gz 11:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:53 INFO - Installing collected packages: blessings 11:18:53 INFO - Running setup.py install for blessings 11:18:54 INFO - Successfully installed blessings 11:18:54 INFO - Cleaning up... 11:18:54 INFO - Return code: 0 11:18:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:54 INFO - Reading from file tmpfile_stdout 11:18:54 INFO - Current package versions: 11:18:54 INFO - argparse == 1.2.1 11:18:54 INFO - blessings == 1.6 11:18:54 INFO - blobuploader == 1.2.4 11:18:54 INFO - docopt == 0.6.1 11:18:54 INFO - functools32 == 3.2.3-2 11:18:54 INFO - jsonschema == 2.5.1 11:18:54 INFO - manifestparser == 1.1 11:18:54 INFO - mozInstall == 1.12 11:18:54 INFO - mozcrash == 0.17 11:18:54 INFO - mozdebug == 0.1 11:18:54 INFO - mozdevice == 0.48 11:18:54 INFO - mozfile == 1.2 11:18:54 INFO - mozhttpd == 0.7 11:18:54 INFO - mozinfo == 0.9 11:18:54 INFO - mozleak == 0.1 11:18:54 INFO - mozlog == 3.2 11:18:54 INFO - moznetwork == 0.27 11:18:54 INFO - mozprocess == 0.22 11:18:54 INFO - mozprofile == 0.28 11:18:54 INFO - mozrunner == 6.11 11:18:54 INFO - mozscreenshot == 0.1 11:18:54 INFO - mozsystemmonitor == 0.3 11:18:54 INFO - moztest == 0.7 11:18:54 INFO - mozversion == 1.4 11:18:54 INFO - psutil == 3.1.1 11:18:54 INFO - requests == 1.2.3 11:18:54 INFO - wsgiref == 0.1.2 11:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:54 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 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:54 INFO - Using env: {'DISPLAY': ':0', 11:18:54 INFO - 'HOME': '/home/cltbld', 11:18:54 INFO - 'LANG': 'en_US.UTF-8', 11:18:54 INFO - 'LANGUAGE': 'en_US:en', 11:18:54 INFO - 'LOGNAME': 'cltbld', 11:18:54 INFO - 'MAIL': '/var/mail/cltbld', 11:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:54 INFO - 'MOZ_NO_REMOTE': '1', 11:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:54 INFO - 'NO_EM_RESTART': '1', 11:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:54 INFO - 'PWD': '/builds/slave/test', 11:18:54 INFO - 'SHELL': '/bin/bash', 11:18:54 INFO - 'SHLVL': '1', 11:18:54 INFO - 'TERM': 'linux', 11:18:54 INFO - 'TMOUT': '86400', 11:18:54 INFO - 'USER': 'cltbld', 11:18:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:54 INFO - '_': '/tools/buildbot/bin/python'} 11:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:18:54 INFO - Cleaning up... 11:18:54 INFO - Return code: 0 11:18:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:18:54 INFO - Using env: {'DISPLAY': ':0', 11:18:54 INFO - 'HOME': '/home/cltbld', 11:18:54 INFO - 'LANG': 'en_US.UTF-8', 11:18:54 INFO - 'LANGUAGE': 'en_US:en', 11:18:54 INFO - 'LOGNAME': 'cltbld', 11:18:54 INFO - 'MAIL': '/var/mail/cltbld', 11:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:54 INFO - 'MOZ_NO_REMOTE': '1', 11:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:54 INFO - 'NO_EM_RESTART': '1', 11:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:54 INFO - 'PWD': '/builds/slave/test', 11:18:54 INFO - 'SHELL': '/bin/bash', 11:18:54 INFO - 'SHLVL': '1', 11:18:54 INFO - 'TERM': 'linux', 11:18:54 INFO - 'TMOUT': '86400', 11:18:54 INFO - 'USER': 'cltbld', 11:18:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:54 INFO - '_': '/tools/buildbot/bin/python'} 11:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:54 INFO - Cleaning up... 11:18:54 INFO - Return code: 0 11:18:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd9accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, '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': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:18:54 INFO - Using env: {'DISPLAY': ':0', 11:18:54 INFO - 'HOME': '/home/cltbld', 11:18:54 INFO - 'LANG': 'en_US.UTF-8', 11:18:54 INFO - 'LANGUAGE': 'en_US:en', 11:18:54 INFO - 'LOGNAME': 'cltbld', 11:18:54 INFO - 'MAIL': '/var/mail/cltbld', 11:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:54 INFO - 'MOZ_NO_REMOTE': '1', 11:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:54 INFO - 'NO_EM_RESTART': '1', 11:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:54 INFO - 'PWD': '/builds/slave/test', 11:18:54 INFO - 'SHELL': '/bin/bash', 11:18:54 INFO - 'SHLVL': '1', 11:18:54 INFO - 'TERM': 'linux', 11:18:54 INFO - 'TMOUT': '86400', 11:18:54 INFO - 'USER': 'cltbld', 11:18:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:54 INFO - '_': '/tools/buildbot/bin/python'} 11:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:55 INFO - Downloading/unpacking flake8 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:18:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:18:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:57 INFO - no previously-included directories found matching 'docs/_build' 11:18:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:18:57 INFO - Running setup.py install for pep8 11:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:57 INFO - no previously-included directories found matching 'docs/_build' 11:18:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:18:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:18:57 INFO - Cleaning up... 11:18:57 INFO - Return code: 0 11:18:57 INFO - Running post-action listener: _resource_record_post_action 11:18:57 INFO - Running post-action listener: _start_resource_monitoring 11:18:57 INFO - Starting resource monitoring. 11:18:57 INFO - ##### 11:18:57 INFO - ##### Finished create-virtualenv step (success) 11:18:57 INFO - ##### 11:18:57 INFO - ##### 11:18:57 INFO - ##### Running install step. 11:18:57 INFO - ##### 11:18:57 INFO - Running pre-action listener: _resource_record_pre_action 11:18:57 INFO - Running main action method: install 11:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:58 INFO - Reading from file tmpfile_stdout 11:18:58 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:58 INFO - Reading from file tmpfile_stdout 11:18:58 INFO - Output received: 11:18:58 INFO - Usage: mozinstall [options] installer 11:18:58 INFO - Options: 11:18:58 INFO - -h, --help show this help message and exit 11:18:58 INFO - -d DEST, --destination=DEST 11:18:58 INFO - Directory to install application into. [default: 11:18:58 INFO - "/builds/slave/test"] 11:18:58 INFO - --app=APP Application being installed. [default: firefox] 11:18:58 INFO - mkdir: /builds/slave/test/build/application 11:18:58 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'] 11:18:58 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 11:19:15 INFO - Reading from file tmpfile_stdout 11:19:15 INFO - Output received: 11:19:15 INFO - /builds/slave/test/build/application/firefox/firefox 11:19:15 INFO - Running post-action listener: _resource_record_post_action 11:19:15 INFO - ##### 11:19:15 INFO - ##### Finished install step (success) 11:19:15 INFO - ##### 11:19:15 INFO - ##### 11:19:15 INFO - ##### Running run-tests step. 11:19:15 INFO - ##### 11:19:15 INFO - Running pre-action listener: _resource_record_pre_action 11:19:15 INFO - Running main action method: run_tests 11:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:15 INFO - Python 2.7.3 11:19:15 INFO - Return code: 0 11:19:15 INFO - grabbing minidump binary from tooltool 11:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:15 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 0x2c3f1c0>, '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 0x2c400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c40550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:19:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:19:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:19:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:15 INFO - Return code: 0 11:19:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:19:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:19:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:19:16 INFO - Return code: 0 11:19:16 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/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:19:16 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/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:19:16 INFO - Using env: {'DISPLAY': ':0', 11:19:16 INFO - 'HOME': '/home/cltbld', 11:19:16 INFO - 'LANG': 'en_US.UTF-8', 11:19:16 INFO - 'LANGUAGE': 'en_US:en', 11:19:16 INFO - 'LOGNAME': 'cltbld', 11:19:16 INFO - 'MAIL': '/var/mail/cltbld', 11:19:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:16 INFO - 'MOZ_NO_REMOTE': '1', 11:19:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:16 INFO - 'NO_EM_RESTART': '1', 11:19:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:16 INFO - 'PWD': '/builds/slave/test', 11:19:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:16 INFO - 'SHELL': '/bin/bash', 11:19:16 INFO - 'SHLVL': '1', 11:19:16 INFO - 'TERM': 'linux', 11:19:16 INFO - 'TMOUT': '86400', 11:19:16 INFO - 'USER': 'cltbld', 11:19:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466014205.322545-470370542', 11:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:16 INFO - '_': '/tools/buildbot/bin/python'} 11:19:16 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/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:19:16 INFO - mozversion application_buildid: 20160615083055 11:19:16 INFO - mozversion application_changeset: 153553aecf160632bbcb50906ba135511da138e6 11:19:16 INFO - mozversion application_display_name: Nightly 11:19:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:16 INFO - mozversion application_name: Firefox 11:19:16 INFO - mozversion application_remotingname: firefox 11:19:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:19:16 INFO - mozversion application_vendor: Mozilla 11:19:16 INFO - mozversion application_version: 50.0a1 11:19:16 INFO - mozversion platform_buildid: 20160615083055 11:19:16 INFO - mozversion platform_changeset: 153553aecf160632bbcb50906ba135511da138e6 11:19:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:19:16 INFO - mozversion platform_version: 50.0a1 11:19:16 INFO - using testdate: 1466014756 11:19:16 INFO - actual date: 1466014756 11:19:16 INFO - starting webserver on 'localhost:39881' 11:19:16 INFO - SUITE-START | Running 2 tests 11:19:16 INFO - TEST-START | dromaeo_css 11:19:16 INFO - operating with platform_type : linux_ 11:19:16 INFO - Initialising browser for dromaeo_css test... 11:19:16 INFO - TEST-INFO | started process 12715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu4BlxV/profile http://localhost:39881/getInfo.html) 11:19:20 INFO - PROCESS | 12715 | __metrics Screen width/height:1600/1200 11:19:20 INFO - PROCESS | 12715 | colorDepth:24 11:19:20 INFO - PROCESS | 12715 | Browser inner width/height: 1024/697 11:19:20 INFO - PROCESS | 12715 | __metrics 11:19:21 INFO - PROCESS | 12715 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:21 INFO - PROCESS | 12715 | console.error: PushService: 11:19:21 INFO - PROCESS | 12715 | stateChangeProcessEnqueue: Error transitioning state 11:19:21 INFO - PROCESS | 12715 | UnknownError 11:19:22 INFO - TEST-INFO | 12715: exit 0 11:19:22 INFO - Browser initialized. 11:19:22 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:22 INFO - TEST-INFO | started process 12799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu4BlxV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:34 INFO - PROCESS | 12799 | RSS: Main: 173682688 11:19:34 INFO - PROCESS | 12799 | 11:20:25 INFO - PROCESS | 12799 | 1466014825386 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:22:34 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:39881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39881/tests/dromaeo/cssquery-ext.html) 11:22:35 INFO - PROCESS | 12799 | RSS: Main: 309080064 11:22:35 INFO - PROCESS | 12799 | 11:25:38 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:39881/tests/dromaeo/cssquery-ext.html (next: http://localhost:39881/tests/dromaeo/cssquery-jquery.html) 11:25:38 INFO - PROCESS | 12799 | RSS: Main: 257822720 11:25:38 INFO - PROCESS | 12799 | 11:28:40 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:39881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39881/tests/dromaeo/cssquery-mootools.html) 11:28:41 INFO - PROCESS | 12799 | RSS: Main: 263786496 11:28:41 INFO - PROCESS | 12799 | 11:31:43 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:39881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39881/tests/dromaeo/cssquery-prototype.html) 11:31:43 INFO - PROCESS | 12799 | RSS: Main: 251498496 11:31:43 INFO - PROCESS | 12799 | 11:34:46 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:39881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39881/tests/dromaeo/cssquery-yui.html) 11:34:46 INFO - PROCESS | 12799 | RSS: Main: 248836096 11:34:46 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:39881/tests/dromaeo/cssquery-yui.html (next: http://localhost:39881/tests/dromaeo/cssquery-dojo.html) 11:37:49 INFO - PROCESS | 12799 | RSS: Main: 297000960 11:37:49 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | __start_tp_report 11:37:49 INFO - PROCESS | 12799 | _x_x_mozilla_page_load 11:37:49 INFO - PROCESS | 12799 | _x_x_mozilla_page_load_details 11:37:49 INFO - PROCESS | 12799 | |i|pagename|runs| 11:37:49 INFO - PROCESS | 12799 | |0;dojo.html;3009.9548506772417;3051.3134544727427;3066.815991040536;3099.7210251077404;3150.921226969325;5277.683338999663;5334.199870019499;5391.56867450604;5483.780648774049;5493.91759123613;5409.080456322425;5420.512153906147;5435.83692489226;5469.917951230725;5506.174073888918;4873.926891096637;4874.049560335736;4955.653104282702;4961.8015279388965;5087.287779710843;4969.875753106165;5001;5036.697798132105;5063.139266324733;5068.847934561969;4811.446683631375;4862.829800956985;4878.243872199815;4943.1102401567705;4948.0846043481715;4802.255650374198;4819.879503012417;4828.130936431441;4852.539008794159;4945;4833.371661683994;4854.514548545118;4860.9513904861205;4869.975650121763;4991.600671946272;5281.577473802086;5343.919841202385;5386.1920711893135;5416.458354164592;5469.234307196995;5814.825555233308;5854.619449735754;5867.266591676041;5870.559708021916;5882.823515294548;5827.825165245007;5907.4683278505145;5918.023526118185;5918.408159184047;5920;5267.894642107136;5337.813176538842;5387.488188622075;5389.380221274603;5475.370332411744;5988.041913293852;6001.039833626686;6002.6698531580305;6008.579399442085;6012.699365031731;5773.364929857797;5775.5668324875805;5780.42195780427;5784.942150578525;5786.276715410574;5539.944600554023;5619.8876022480135;5711.600187986801;5720.313562372542;5757.136429535603;5698.373178950312;5718.771249150071;5720.342160651495;5727.11229759388;5737.139429085671;5493.450654934474;5666.4050274721385;5745.482906538348;5771.538276937835;5783.913241301384;4327.6970612057485;4328.653707703376;4341.435613370241;4357.869263922087;4366.890827729332;3840.8655697051026;3845.5193100862393;3866.8259928303296;3888.202918401721;3888.8444462221196;5267.157254839208;5396.406395296514;5415.160650099241;5419.295491586068;5422.593305502024;5721.8569535761935;5769.567282453832;5790.073588225948;5873.676947767914;5894.8821023579285;5507.972460137674;5514;5514.724263786795;5523.613347065667;5529.391766905637;4995.275685025651;4999.925001124986;5017.84946451607;5046.545810877039;5051.823186188466;5824.796132135355;5951.583389162717;6005.579609427386;6013.428724271187;6076.331603523698;5871.060630299132;5885.3820348864465;5893.793717219876;5894.970525147518;5900.527957763455;5763.279590051244;6001.4298641628975;6048.183495228088;6060.545459090497;6061.7575296987625;5649.717514124195;5681.0058239808695;5690.5163061140265;5697.943020569741;5728.6562806230095;5805.245318108618;5835.183074369676;5838;5848.5028772553105;5849.64902105875;5513.531349835309;5567.220589117445;5721.456461636138;5735.11105778605;5738.454846789548;5619.297587801525;5697.4587414195585;5706.600537962303;5706.657600543981;5756.16535602327;5551.056320425457;5592.133219351007;5602.691851948182;5604.243427137284;5604.6917419542315;5457.945420545744;5467.179923011421;5530.446955304598;5726.026575482095;5771.451712087345;5324.201369794407;5389.757460914347;5482.753276102505;5485.4788795064405;5534.142207957773 11:37:49 INFO - PROCESS | 12799 | |1;ext.html;559.7732918168141;598.3238939997802;609.8658295175061;615.0958091605338;617.3178637605449;31788.841055794746;32377.352452950956;34918.65081349189;34927.82536087316;42522.36216456748;42682.78658606703;46473;46513;46545;46616;8836.602352894135;8943.463392196456;9010.68462603809;9013.54932253388;9032.05163457834;8825.95587022064;8942.955285223565;8951.418157819753;8954.32842536809;8955.865662015074;8908.688195913111;8940.731778046636;8958.776030599221;8963.193312601865;8963.910360896405;8869.600867960926;8897.822043559157;8906.465612063297;8909.688160914402;8911.866322005208;8859.601317940707;8941.418807777474;8942.239909607626;8942.239909607692;8947.32895032875;42302.57697423048;42647;42679.786601067106;42696.14607707829;42699.7865010676;3563.4832949222478;3663.6153203913473;3835.827387767557;4153.54311025787;4336.436263285753;32457;33114.3377132456;33218;33585.664143358495;34145.65854341474;4135.58644135587;4150.107726838744;4172.374143878412;4244.830206791725;4311.094670119279;379609;380470.9999999972;381344;381479;381744;60120;60409.69795150996;60487.39512604906;60491.39508604946;60562.39437605567;35548.46677299843;36510.81744591313;36647.81676091602;64119.358806412274;64202.35797642057;17739.379121730937;17859.107044647717;17916.372926947493;17940.19269132892;17957.551061223312;13530.797038044437;13651.180929144282;13653.726925461435;13656.726865462635;13661.590152295446;19604.607907842048;19770.40688779339;19920.10758977895;19964.50088747793;20001.59996800056;7141.001299090657;7145.4998150128995;7228.566286022856;7253.347198752138;7369.81575460607;941.383393876998;1016.6187679620142;1070.4968664727567;1121.9158563107799;1132.7281452451352;32143;32297.838510807767;32569;32976.1755956103;33354.33102358739;1060.596973150198;1073.2862646340252;1088.8312311591717;1092.4373947417087;1096.270979798425;16691;17332.39336623212;17444.563885902953;17496.300147994192;17561.648767024588;568274;570579;571270;573786;576358;58898.11652825211;59563.40436595665;59573;59647;59670.40329596735;1215.7993931001463;1317.6047185844209;1349.0556610372778;1351.297325390811;1356.5184359552413;32357.35285294234;33417.83291083529;33562.83218583892;33827;34499.82750086234;51828.481715182366;52386.73806631095;52534.73732631465;52548.474515254355;52549.47450525446;401148;403644;403679;405796;677898;45698.31452528281;45780;46046.53953460423;46589.76705116453;50711.492885072155;46747.76626116984;46771;51539.22691159561;52555;52637.47362526479;41844.79077604714;42799.7860010698;42974;43416.34875476807;43751;42573.148537028464;43368;43371.349429757945;43492;43745.12509749851;42593.78703106465;43148;43627.34558981681;43744.12511749811;43816;36178.63821361752;37779.1098456462;38613.4207986886;38718.41922371223;39082.2183556333;28836.567451487826;29036.854815725786;29141.85429072841;29202.41595168042;29310.26724331909 11:37:49 INFO - PROCESS | 12799 | |2;jquery.html;368.4822823932374;374.6571886723648;376.56737475905646;388.9397143442766;397.7414680457702;17592;19085.522861928443;19769.703454448194;19796.80203197966;19800.603987920233;18317;18661.533461663465;18678.62642747144;18789.81210187898;18934.431967040975;5426.348838139429;5464.207689884965;5683.744231509592;5721.284839395075;5730.169125476824;5589.692566908819;5641.492265696086;5649.661020338793;5678.687672178028;5691.686957217351;5436.592255580827;5523.2543606613;5591.692456914868;5641.802536911209;5642.802501912434;5518.668879867221;5558.944410555883;5562.221289019541;5563.248961390222;5563.471470210324;4851.320815085891;4893.486183950669;4897;4924.335214745999;4948.802047918079;22393.776062239333;22429.887850560644;22614.20850270249;22760.772392276198;22844;2307.48081681622;2343.133040774924;2357.893894774722;2482.9943872731574;2855.9428811423863;14243.287835608282;14320.64198395038;14387.856121438861;14497.275136243252;14859.405623775036;1963.1950900130878;2030.604032213719;2032.8272096871783;2035.3893831850535;2079.3138264372874;55247.72376138134;69930.65034674793;70671;75949.62025189894;81812.59093704553;9976.102150806462;10066.748331291776;10393.272470927113;10643.84034239487;10666.306690065121;11796.646100616996;12373.814392784116;14256.501022464165;14271.072380295247;14277.714445711028;7554.5646327197655;7854.803629909298;7899.249571290833;8528.104549022388;8557.914420855835;8464.915350846535;8514.489130652057;8523.872141917876;8616.224539791448;8719.04090550039;6377.107204991305;6404.327545607644;6441.32366101562;6473.902891456632;6525.804225873231;1724.5602371395214;1778.3864566724717;1779.4572655340246;1800.666876627828;1849.5930895203303;959.6065613098596;971.8930917599058;972.8103019911049;984.625842179967;1023.5803320638503;19275.903620481808;19977.900110499355;19981.700274495895;20075.996200189933;20122.69815952762;962.5812771444444;1009.9798004040025;1010.4493051287067;1044.6239353832614;1065.5311662868469;11123.443827808576;11540.653780386601;11618.477168527437;11636.301821890713;11732.296062236293;487061;491469;496181;498793;499806;80242.59878700569;82816.10143644943;84044;84603.5769821147;85998;1007.4710776842217;1025.6974192613047;1028.8096702109983;1033.6485594897772;1038.1642777563982;17691.11544422748;17827.286908523514;17909.552261193574;18060.54848628795;18238.817611824245;39651.80174099111;40090.39864402095;41331.38002929898;41616.79191604022;42250.94372640709;52543.474565253855;53697.463025369245;53827.46172538224;53864.19203711869;53940.19089713579;8073.39449541275;8354.749357519284;8549.743507694779;8640.783980400289;8660.307175426076;13857.214178731901;13876.23680697531;13907.930460347634;14240.501582444565;14252.287385630885;11996.560412750527;12120.27278363301;12204.938975305067;12238.388080596113;12271.263724176579;11949.820752688544;11956.880431195925;11988.340641264815;12069.758604827679;12121.393930303626;6292.087647291209;11493.425328733363;12141.69645758863;12200.816987745013;12390.070744694363;7922.683092676229;8013.975324817194;8085.676572937252;8087.514749115072;8161.387895907712;11708.356040417859;11852.881471185523;11858.110641701734;12070.818937716116;12255.142140050468 11:37:49 INFO - PROCESS | 12799 | |3;mootools.html;1289.7549465601528;1437.3029080895767;1488.6650503636681;1549.5738671865242;1764.4177421450916;8902.421342612733;9287.814243715131;9312.906870931305;9324.39391439556;9326.393784404017;9034.367594268404;9236.307276954221;9246.214071803888;9248.953755231214;9248.95375523123;1952.9121189546504;2307.665388518664;2344.777246161612;2370.668106465096;2381.7975472084895;2342.648602709599;2346.6128088865403;2354.682117914085;2356.5640356534095;2363.0665886974634;2371.703537057868;2379.357573455166;2413.79482743967;2414.7947424468853;2416.7462416446283;1975.2494052260192;2272.3864556569797;2342.4846533762543;2347.835651504395;2348.283773449097;2341;2358.811295096388;2360.1621424394434;2362.6337917622623;2363.031157225529;9191.816163676689;9232.307576931757;9247.72256832296;9251.259899208115;9254.491002994833;5347.1979203119845;5485.396606373296;5496.945030549683;5497.532709719679;5499.917501237484;3185.2992341684794;3328.151321413024;3446.293509830504;3461.792292462435;3479.2867462170193;1131.185546406586;1131.2590253383964;1132.5866058888528;1138.2771939818274;1171.958981435654;12998.740025199537;13004.544840930617;13061.804072938914;13067.673308167277;13068;4692.436907571113;4724.220503616864;4783.497732738082;4819.084373969004;4878.341423907798;11001.284916480403;11002.284851484628;11007.284526505911;11010.669679909615;11011.064059554867;5329.86675333112;5339.14573668219;5375.623706340597;5384.030874442559;5400.297961265089;4192.203481338536;4852.8786780330065;4937.333459982857;4995.700257984533;5001.124803159432;3986.940195897064;4046.5548789633117;4130.56629053951;4139.834406623701;4140.4617399737845;1243.4653099167265;1248.1138391741783;1248.8688687687843;1259.0745801835644;1259.5465632372338;857.691231156783;929;977.8044391121804;977.8239916814899;993.7913038262046;6153.261608606996;6191.442770150708;6268.561200715906;6283.654399008007;6378.202724659418;446.1434046630477;449.21611787430487;450.9008018235983;980.5146452505912;1047.3977462958828;4247.851325203603;4310.612044915973;4312.654987600984;4316.460442444694;4341.978290108529;11595.304281743123;11636;11702.590409335633;11727.76544469123;11757.823632645517;11587.652370428901;11617.593384231512;11636.418179091012;11641;11643.825342619868;8100.9873765779275;8462.36532260083;8467.153284671484;8700.564971751388;8702.782430439289;5681.801136960186;6059.151718759465;6077.4226448487325;6083.513318934386;6129.264488261437;10366.5335059924;10645.201609879445;10796.082333001783;10821.513031913426;10856.185786065918;10917.836232456679;11039.944800275947;11042.171837112088;11186.216964812711;11198.888011119785;6924.169099708067;7934.444588878723;8155.347572194329;8192.795180120545;8372.623231954698;9093.090690930854;9098;9112.997570267398;9177.21993630549;9177.357584968988;8023;8190.50856948585;8195.46729462583;8197.46716463428;8360.163983601591;7762.184970578008;7880.921190788019;7957.880631790412;7967.5219486828655;8007.759767206993;7052.9647351762915;7134.607596582237;7200.387967022862;7208.35124838767;7215.062041934725;5067.265246539305;5078.136716758087;5084.949150508448;5110.897782044412;5250.369955605352;4972.5027497249985;5006.4242612098615;5124.6412751108555;5151.098557752453;5194.7922083116255 11:37:49 INFO - PROCESS | 12799 | |4;prototype.html;309.1020585199994;317.4270441852457;320.894104945368;325.8142858570616;325.97881137726046;5270.81552145675;5306.257124002643;5312.043832110218;5328.46715328467;5369.463053694629;5255.792567121808;5276.525112739852;5311.362636483627;5320.073959322376;5331.920021199685;4125.401816736587;4128.75227486351;4129.079977810317;4131.173765246963;4136.855210067648;3801.733878628497;4041.1715598302276;4051.8784436466954;4065.3292206785845;4071.531773846016;3996.700247481436;4019.77891215983;4026.4161696553983;4063.7155399122075;4073.287174744408;3861.2663593917064;3887.047673320026;4032.0847597391153;4062.837486500536;4066.959330406717;3513.91215219619;3521.0493166845063;3527.417976033977;3529.170644898447;3537.7169826413824;5118.539331460186;5118.564921981636;5119.488051194888;5144.922826157611;5181.740912954338;4384.89037774055;4483.730976141409;4602.424696912886;4619.630429565626;4634.328022436762;5377.8117765878005;5414.458554144593;5468.808591699271;5489;5491.643043202179;3885.3977633466857;3885.8821942041654;3894.6105389460827;3898;3903.551091624471;5457.345118585756;5610.242617246701;5724.627899186539;5736.741846616912;5756.481916627482;3904.6681032112588;3914.745541539791;3934.2524920265632;3945.901352466154;3953.5058117735284;3963.623455771697;3969.702272329587;3997.480327557399;4005.6595189408645;4013;4441.579691102513;4611.723296602215;4615.676902616851;4621.930671039937;4651.720896746206;5523.613347065747;5540.695261760561;5543.972280138654;5547.972260138674;5555.611107222456;1371.2800779590796;1380.2132784313046;1388.5417812121975;1391.0957877379783;1391.7842734376188;840.470503582739;875.868619707049;885.455444901381;888.8622263549161;896.5786080542135;4689.296605509201;4699.812007519661;4755.904881902343;4827.879303017382;4835.428485742148;5017.598592112622;5044.8234311798915;5053.772580233825;5077.923831142536;5123;4794.232922732346;4826.855194344175;4848.345473361122;4878.902421951541;4989.25161225819;2885.350796070867;2939.8236105833716;3022.6977302269597;3038.769298434138;3057.694230576969;5840.328362238312;5841.386654401312;5848.5321174305955;5869.383714709979;5890.646561206341;5591.608587398843;5831.471959464548;5842.707864606753;5866.2373891393845;5888.4700376966275;5861.296644402699;5878.470937615635;5884.617499862496;5888.823335299948;5889.1755154278435;5619.808433687042;5715.828525144252;5725.713714314351;5742;5751.683657398883;5535.474129957647;5657.745401457027;5682.857928551819;5686.516646084963;5690.829275121753;5783.074708046693;5826.009578371772;5831.970840145772;5838.591298609056;5878.794242201502;3877.554081280576;3951.545572259227;3958.465607142999;3975.801209939549;4003.2393845169327;5524.696141712245;5596.888062238651;5599.692016939108;5611.551075913999;5661.66030038199;5487.314085739283;5494.423085575957;5521.680894024439;5547.833564993057;5583.246261754611;5264.236685680631;5508.944910550843;5515.972420138034;5532.280803495681;5555.138953462219;5391.490382692852;5391.784328626811;5422.6475279106735;5438.592105592017;5442.755076021668;5504.80733174337;5532.557395408277;5549.278593782782;5554.472325129106;5576.163575463713;5115.974420127875;5344.4121146674615;5399.543207840345;5403;5424.213489044146 11:37:49 INFO - PROCESS | 12799 | |5;yui.html;719.8776208044633;741.3216906530524;747.8167848877026;758.7989182866542;827.6110228192751;13859.445622175113;14798.408063677467;14805.703885922276;14811.851881481181;14826.184559849218;14671.193084380382;14813.851861481382;14837.777433338508;14838.480653177141;14867.479638212664;672.9360710732473;790.6402586822996;796.2913007423398;815.3599424451806;817.2522142239843;793.833295008049;800.8918795962558;801.3989507869098;804.6499772598909;804.7183485779989;856.7858035491128;858.6179150278098;858.8024754306513;858.9828203435927;859.2395729779159;709.4785332780402;821.3593397150232;833.0420016980461;833.7832163637437;837.1126605797813;622.0420552349376;622.0637939900466;622.4957784194771;622.5206590925008;622.6419808610023;15179.848201517954;15297.770533442008;15353.309101090477;15373.692526149527;15392.30734616945;14076.296185190802;14363.71272574553;14429.35067921946;14499.71000579993;15022.474213402478;11766.764664706658;11888.762224755543;11963.521459141624;12114.697132571757;12181.33002684852;4387.824487020515;4431.401760762288;4431.667624928111;4433.1577000369825;4438.533953934855;63488.68255658738;67080.3291967079;69930.30069699339;70229.64885175541;72696;11278.887211127947;11568.942155289169;11658.883411165949;11714.062874969983;11843.170978031456;21604.89197554002;21612.351629451143;21627.891860540596;21630.56738865214;21641;8889.377743558018;8892.510911899908;8897.955510222408;8920.375573709907;9323.067693230758;4734;4788.329633851264;4835.2505361669;4852.417709874838;4875.463698993108;3737.2338670572467;3876.9224615507533;3880.41793730937;3888.183481468867;3891.3190191716335;684;684.4387602166275;689.3279052923359;729.68623491899;729.919708832028;602.4698265526397;653.5359894474881;742.1984257002424;756.406221116421;779.2480256552454;9561.282903782245;9662.56518456671;9747.220222382335;9775.266854985905;10039.799204015879;718.8526352097807;722.9421646268286;736.105631657528;742.921993190718;746.0860445953772;4691.671582989158;4958.851234462972;4970.15507363749;4981.327520784647;4991.725455100004;72997;73768.26231737722;125319.3734031324;125965.37017314855;126961.36519317345;99976.59071099489;106707.46646266874;107736.46131769448;107954;109551;58497.12254316189;93687.53156234311;95570.52214738882;96223.51888240514;96284;9402.764930876783;9428.858567121635;9508.809823803347;9510.254835278287;9552.283578731762;52277.47722522726;53871.73064134654;54322.45677543174;55078.44921550733;55181.724091379285;45497.31754023626;45879.54120458753;46930.76534617305;64952.675236623516;77311;13418.530351437652;13904.652383690083;14060.648483787987;14889.255537222878;14999.700006000037;14393.64015899611;15039.699206015599;15636.765448518054;16107.355705771637;17195;13766.518171863936;14582;14909.403623854925;14944;14963.77554336664;14582.270886455846;14674.63313417173;14879.330430130454;15011.699766004836;15245.847541524887;14620.41518339297;14627;14755.483558075844;14768.187749673441;14790.704185916005;10744.677659670222;11486.712832179262;11604.07167426587;11640;11860.644180674248;11887.881121188677;12153.817692734792;12199.207051541622;12228;12360.381980901098 11:37:49 INFO - PROCESS | 12799 | __end_tp_report 11:37:49 INFO - PROCESS | 12799 | __start_cc_report 11:37:49 INFO - PROCESS | 12799 | _x_x_mozilla_cycle_collect,1064 11:37:49 INFO - PROCESS | 12799 | __end_cc_report 11:37:49 INFO - PROCESS | 12799 | __startTimestamp1466015869746__endTimestamp 11:37:49 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | ------- Summary: start ------- 11:37:49 INFO - PROCESS | 12799 | Number of tests: 6 11:37:49 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | [#0] dojo.html Cycles:165 Average:5369.37 Median:5529.39 stddev:632.01 (11.4%) stddev-sans-first:606.24 11:37:49 INFO - PROCESS | 12799 | Values: 3010.0 3051.3 3066.8 3099.7 3150.9 5277.7 5334.2 5391.6 5483.8 5493.9 5409.1 5420.5 5435.8 5469.9 5506.2 4873.9 4874.0 4955.7 4961.8 5087.3 4969.9 5001.0 5036.7 5063.1 5068.8 4811.4 4862.8 4878.2 4943.1 4948.1 4802.3 4819.9 4828.1 4852.5 4945.0 4833.4 4854.5 4861.0 4870.0 4991.6 5281.6 5343.9 5386.2 5416.5 5469.2 5814.8 5854.6 5867.3 5870.6 5882.8 5827.8 5907.5 5918.0 5918.4 5920.0 5267.9 5337.8 5387.5 5389.4 5475.4 5988.0 6001.0 6002.7 6008.6 6012.7 5773.4 5775.6 5780.4 5784.9 5786.3 5539.9 5619.9 5711.6 5720.3 5757.1 5698.4 5718.8 5720.3 5727.1 5737.1 5493.5 5666.4 5745.5 5771.5 5783.9 4327.7 4328.7 4341.4 4357.9 4366.9 3840.9 3845.5 3866.8 3888.2 3888.8 5267.2 5396.4 5415.2 5419.3 5422.6 5721.9 5769.6 5790.1 5873.7 5894.9 5508.0 5514.0 5514.7 5523.6 5529.4 4995.3 4999.9 5017.8 5046.5 5051.8 5824.8 5951.6 6005.6 6013.4 6076.3 5871.1 5885.4 5893.8 5895.0 5900.5 5763.3 6001.4 6048.2 6060.5 6061.8 5649.7 5681.0 5690.5 5697.9 5728.7 5805.2 5835.2 5838.0 5848.5 5849.6 5513.5 5567.2 5721.5 5735.1 5738.5 5619.3 5697.5 5706.6 5706.7 5756.2 5551.1 5592.1 5602.7 5604.2 5604.7 5457.9 5467.2 5530.4 5726.0 5771.5 5324.2 5389.8 5482.8 5485.5 5534.1 11:37:49 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | [#1] ext.html Cycles:180 Average:63356.72 Median:42689.47 stddev:127853.91 (299.5%) stddev-sans-first:128125.64 11:37:49 INFO - PROCESS | 12799 | Values: 559.8 598.3 609.9 615.1 617.3 31788.8 32377.4 34918.7 34927.8 42522.4 42682.8 46473.0 46513.0 46545.0 46616.0 8836.6 8943.5 9010.7 9013.5 9032.1 8826.0 8943.0 8951.4 8954.3 8955.9 8908.7 8940.7 8958.8 8963.2 8963.9 8869.6 8897.8 8906.5 8909.7 8911.9 8859.6 8941.4 8942.2 8942.2 8947.3 42302.6 42647.0 42679.8 42696.1 42699.8 3563.5 3663.6 3835.8 4153.5 4336.4 32457.0 33114.3 33218.0 33585.7 34145.7 4135.6 4150.1 4172.4 4244.8 4311.1 379609.0 380471.0 381344.0 381479.0 381744.0 60120.0 60409.7 60487.4 60491.4 60562.4 35548.5 36510.8 36647.8 64119.4 64202.4 17739.4 17859.1 17916.4 17940.2 17957.6 13530.8 13651.2 13653.7 13656.7 13661.6 19604.6 19770.4 19920.1 19964.5 20001.6 7141.0 7145.5 7228.6 7253.3 7369.8 941.4 1016.6 1070.5 1121.9 1132.7 32143.0 32297.8 32569.0 32976.2 33354.3 1060.6 1073.3 1088.8 1092.4 1096.3 16691.0 17332.4 17444.6 17496.3 17561.6 568274.0 570579.0 571270.0 573786.0 576358.0 58898.1 59563.4 59573.0 59647.0 59670.4 1215.8 1317.6 1349.1 1351.3 1356.5 32357.4 33417.8 33562.8 33827.0 34499.8 51828.5 52386.7 52534.7 52548.5 52549.5 401148.0 403644.0 403679.0 405796.0 677898.0 45698.3 45780.0 46046.5 46589.8 50711.5 46747.8 46771.0 51539.2 52555.0 52637.5 41844.8 42799.8 42974.0 43416.3 43751.0 42573.1 43368.0 43371.3 43492.0 43745.1 42593.8 43148.0 43627.3 43744.1 43816.0 36178.6 37779.1 38613.4 38718.4 39082.2 28836.6 29036.9 29141.9 29202.4 29310.3 11:37:49 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | [#2] jquery.html Cycles:180 Average:28588.53 Median:2420.44 stddev:81144.19 (3352.5%) stddev-sans-first:81344.15 11:37:49 INFO - PROCESS | 12799 | Values: 368.5 374.7 376.6 388.9 397.7 17592.0 19085.5 19769.7 19796.8 19800.6 18317.0 18661.5 18678.6 18789.8 18934.4 5426.3 5464.2 5683.7 5721.3 5730.2 5589.7 5641.5 5649.7 5678.7 5691.7 5436.6 5523.3 5591.7 5641.8 5642.8 5518.7 5558.9 5562.2 5563.2 5563.5 4851.3 4893.5 4897.0 4924.3 4948.8 22393.8 22429.9 22614.2 22760.8 22844.0 2307.5 2343.1 2357.9 2483.0 2855.9 14243.3 14320.6 14387.9 14497.3 14859.4 1963.2 2030.6 2032.8 2035.4 2079.3 55247.7 69930.7 70671.0 75949.6 81812.6 9976.1 10066.7 10393.3 10643.8 10666.3 11796.6 12373.8 14256.5 14271.1 14277.7 7554.6 7854.8 7899.2 8528.1 8557.9 8464.9 8514.5 8523.9 8616.2 8719.0 6377.1 6404.3 6441.3 6473.9 6525.8 1724.6 1778.4 1779.5 1800.7 1849.6 959.6 971.9 972.8 984.6 1023.6 19275.9 19977.9 19981.7 20076.0 20122.7 962.6 1010.0 1010.4 1044.6 1065.5 11123.4 11540.7 11618.5 11636.3 11732.3 487061.0 491469.0 496181.0 498793.0 499806.0 80242.6 82816.1 84044.0 84603.6 85998.0 1007.5 1025.7 1028.8 1033.6 1038.2 17691.1 17827.3 17909.6 18060.5 18238.8 39651.8 40090.4 41331.4 41616.8 42250.9 52543.5 53697.5 53827.5 53864.2 53940.2 8073.4 8354.7 8549.7 8640.8 8660.3 13857.2 13876.2 13907.9 14240.5 14252.3 11996.6 12120.3 12204.9 12238.4 12271.3 11949.8 11956.9 11988.3 12069.8 12121.4 6292.1 11493.4 12141.7 12200.8 12390.1 7922.7 8014.0 8085.7 8087.5 8161.4 11708.4 11852.9 11858.1 12070.8 12255.1 11:37:49 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | [#3] mootools.html Cycles:180 Average:6039.28 Median:4708.33 stddev:3561.62 (75.6%) stddev-sans-first:3553.73 11:37:49 INFO - PROCESS | 12799 | Values: 1289.8 1437.3 1488.7 1549.6 1764.4 8902.4 9287.8 9312.9 9324.4 9326.4 9034.4 9236.3 9246.2 9249.0 9249.0 1952.9 2307.7 2344.8 2370.7 2381.8 2342.6 2346.6 2354.7 2356.6 2363.1 2371.7 2379.4 2413.8 2414.8 2416.7 1975.2 2272.4 2342.5 2347.8 2348.3 2341.0 2358.8 2360.2 2362.6 2363.0 9191.8 9232.3 9247.7 9251.3 9254.5 5347.2 5485.4 5496.9 5497.5 5499.9 3185.3 3328.2 3446.3 3461.8 3479.3 1131.2 1131.3 1132.6 1138.3 1172.0 12998.7 13004.5 13061.8 13067.7 13068.0 4692.4 4724.2 4783.5 4819.1 4878.3 11001.3 11002.3 11007.3 11010.7 11011.1 5329.9 5339.1 5375.6 5384.0 5400.3 4192.2 4852.9 4937.3 4995.7 5001.1 3986.9 4046.6 4130.6 4139.8 4140.5 1243.5 1248.1 1248.9 1259.1 1259.5 857.7 929.0 977.8 977.8 993.8 6153.3 6191.4 6268.6 6283.7 6378.2 446.1 449.2 450.9 980.5 1047.4 4247.9 4310.6 4312.7 4316.5 4342.0 11595.3 11636.0 11702.6 11727.8 11757.8 11587.7 11617.6 11636.4 11641.0 11643.8 8101.0 8462.4 8467.2 8700.6 8702.8 5681.8 6059.2 6077.4 6083.5 6129.3 10366.5 10645.2 10796.1 10821.5 10856.2 10917.8 11039.9 11042.2 11186.2 11198.9 6924.2 7934.4 8155.3 8192.8 8372.6 9093.1 9098.0 9113.0 9177.2 9177.4 8023.0 8190.5 8195.5 8197.5 8360.2 7762.2 7880.9 7957.9 7967.5 8007.8 7053.0 7134.6 7200.4 7208.4 7215.1 5067.3 5078.1 5084.9 5110.9 5250.4 4972.5 5006.4 5124.6 5151.1 5194.8 11:37:49 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | [#4] prototype.html Cycles:180 Average:4580.03 Median:5218.77 stddev:1367.65 (26.2%) stddev-sans-first:1333.39 11:37:49 INFO - PROCESS | 12799 | Values: 309.1 317.4 320.9 325.8 326.0 5270.8 5306.3 5312.0 5328.5 5369.5 5255.8 5276.5 5311.4 5320.1 5331.9 4125.4 4128.8 4129.1 4131.2 4136.9 3801.7 4041.2 4051.9 4065.3 4071.5 3996.7 4019.8 4026.4 4063.7 4073.3 3861.3 3887.0 4032.1 4062.8 4067.0 3513.9 3521.0 3527.4 3529.2 3537.7 5118.5 5118.6 5119.5 5144.9 5181.7 4384.9 4483.7 4602.4 4619.6 4634.3 5377.8 5414.5 5468.8 5489.0 5491.6 3885.4 3885.9 3894.6 3898.0 3903.6 5457.3 5610.2 5724.6 5736.7 5756.5 3904.7 3914.7 3934.3 3945.9 3953.5 3963.6 3969.7 3997.5 4005.7 4013.0 4441.6 4611.7 4615.7 4621.9 4651.7 5523.6 5540.7 5544.0 5548.0 5555.6 1371.3 1380.2 1388.5 1391.1 1391.8 840.5 875.9 885.5 888.9 896.6 4689.3 4699.8 4755.9 4827.9 4835.4 5017.6 5044.8 5053.8 5077.9 5123.0 4794.2 4826.9 4848.3 4878.9 4989.3 2885.4 2939.8 3022.7 3038.8 3057.7 5840.3 5841.4 5848.5 5869.4 5890.6 5591.6 5831.5 5842.7 5866.2 5888.5 5861.3 5878.5 5884.6 5888.8 5889.2 5619.8 5715.8 5725.7 5742.0 5751.7 5535.5 5657.7 5682.9 5686.5 5690.8 5783.1 5826.0 5832.0 5838.6 5878.8 3877.6 3951.5 3958.5 3975.8 4003.2 5524.7 5596.9 5599.7 5611.6 5661.7 5487.3 5494.4 5521.7 5547.8 5583.2 5264.2 5508.9 5516.0 5532.3 5555.1 5391.5 5391.8 5422.6 5438.6 5442.8 5504.8 5532.6 5549.3 5554.5 5576.2 5116.0 5344.4 5399.5 5403.0 5424.2 11:37:49 INFO - PROCESS | 12799 | 11:37:49 INFO - PROCESS | 12799 | [#5] yui.html Cycles:180 Average:20378.41 Median:25811.22 stddev:29129.52 (112.9%) stddev-sans-first:29173.84 11:37:49 INFO - PROCESS | 12799 | Values: 719.9 741.3 747.8 758.8 827.6 13859.4 14798.4 14805.7 14811.9 14826.2 14671.2 14813.9 14837.8 14838.5 14867.5 672.9 790.6 796.3 815.4 817.3 793.8 800.9 801.4 804.6 804.7 856.8 858.6 858.8 859.0 859.2 709.5 821.4 833.0 833.8 837.1 622.0 622.1 622.5 622.5 622.6 15179.8 15297.8 15353.3 15373.7 15392.3 14076.3 14363.7 14429.4 14499.7 15022.5 11766.8 11888.8 11963.5 12114.7 12181.3 4387.8 4431.4 4431.7 4433.2 4438.5 63488.7 67080.3 69930.3 70229.6 72696.0 11278.9 11568.9 11658.9 11714.1 11843.2 21604.9 21612.4 21627.9 21630.6 21641.0 8889.4 8892.5 8898.0 8920.4 9323.1 4734.0 4788.3 4835.3 4852.4 4875.5 3737.2 3876.9 3880.4 3888.2 3891.3 684.0 684.4 689.3 729.7 729.9 602.5 653.5 742.2 756.4 779.2 9561.3 9662.6 9747.2 9775.3 10039.8 718.9 722.9 736.1 742.9 746.1 4691.7 4958.9 4970.2 4981.3 4991.7 72997.0 73768.3 125319.4 125965.4 126961.4 99976.6 106707.5 107736.5 107954.0 109551.0 58497.1 93687.5 95570.5 96223.5 96284.0 9402.8 9428.9 9508.8 9510.3 9552.3 52277.5 53871.7 54322.5 55078.4 55181.7 45497.3 45879.5 46930.8 64952.7 77311.0 13418.5 13904.7 14060.6 14889.3 14999.7 14393.6 15039.7 15636.8 16107.4 17195.0 13766.5 14582.0 14909.4 14944.0 14963.8 14582.3 14674.6 14879.3 15011.7 15245.8 14620.4 14627.0 14755.5 14768.2 14790.7 10744.7 11486.7 11604.1 11640.0 11860.6 11887.9 12153.8 12199.2 12228.0 12360.4 11:37:49 INFO - PROCESS | 12799 | -------- Summary: end -------- 11:37:49 INFO - PROCESS | 12799 | 11:37:50 INFO - TEST-INFO | 12799: exit 0 11:37:50 INFO - TEST-OK | dromaeo_css | took 1114038ms 11:37:50 INFO - TEST-START | kraken 11:37:50 INFO - operating with platform_type : linux_ 11:37:50 INFO - Initialising browser for kraken test... 11:37:50 INFO - TEST-INFO | started process 12981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPq1Ju/profile http://localhost:39881/getInfo.html) 11:37:54 INFO - PROCESS | 12981 | __metrics Screen width/height:1600/1200 11:37:54 INFO - PROCESS | 12981 | colorDepth:24 11:37:54 INFO - PROCESS | 12981 | Browser inner width/height: 1024/697 11:37:54 INFO - PROCESS | 12981 | __metrics 11:37:55 INFO - PROCESS | 12981 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:55 INFO - PROCESS | 12981 | console.error: PushService: 11:37:55 INFO - PROCESS | 12981 | stateChangeProcessEnqueue: Error transitioning state 11:37:55 INFO - PROCESS | 12981 | UnknownError 11:37:56 INFO - TEST-INFO | 12981: exit 0 11:37:56 INFO - Browser initialized. 11:37:56 INFO - Running cycle 1/1 for kraken test... 11:37:56 INFO - TEST-INFO | started process 13060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPq1Ju/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:08 INFO - PROCESS | 13060 | RSS: Main: 173559808 11:38:08 INFO - PROCESS | 13060 | 11:38:10 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39881/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:11 INFO - PROCESS | 13060 | RSS: Main: 233021440 11:38:11 INFO - PROCESS | 13060 | 11:38:14 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39881/tests/kraken/driver.html?testName=audio-dft) 11:38:15 INFO - PROCESS | 13060 | RSS: Main: 219852800 11:38:15 INFO - PROCESS | 13060 | 11:38:18 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39881/tests/kraken/driver.html?testName=audio-fft) 11:38:18 INFO - PROCESS | 13060 | RSS: Main: 286932992 11:38:18 INFO - PROCESS | 13060 | 11:38:21 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39881/tests/kraken/driver.html?testName=audio-oscillator) 11:38:21 INFO - PROCESS | 13060 | RSS: Main: 198275072 11:38:21 INFO - PROCESS | 13060 | 11:38:23 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:24 INFO - PROCESS | 13060 | RSS: Main: 201973760 11:38:24 INFO - PROCESS | 13060 | 11:38:27 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39881/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:28 INFO - PROCESS | 13060 | RSS: Main: 237973504 11:38:28 INFO - PROCESS | 13060 | 11:38:31 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39881/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:32 INFO - PROCESS | 13060 | RSS: Main: 238931968 11:38:32 INFO - PROCESS | 13060 | 11:38:34 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39881/tests/kraken/driver.html?testName=json-parse-financial) 11:38:35 INFO - PROCESS | 13060 | RSS: Main: 238100480 11:38:35 INFO - PROCESS | 13060 | 11:38:37 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:37 INFO - PROCESS | 13060 | RSS: Main: 226000896 11:38:37 INFO - PROCESS | 13060 | 11:38:39 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39881/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:40 INFO - PROCESS | 13060 | RSS: Main: 231264256 11:38:40 INFO - PROCESS | 13060 | 11:38:42 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:42 INFO - PROCESS | 13060 | RSS: Main: 239034368 11:38:42 INFO - PROCESS | 13060 | 11:38:45 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:45 INFO - PROCESS | 13060 | RSS: Main: 238903296 11:38:45 INFO - PROCESS | 13060 | 11:38:48 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:49 INFO - PROCESS | 13060 | RSS: Main: 240357376 11:38:49 INFO - PROCESS | 13060 | 11:38:50 INFO - PROCESS | 13060 | Cycle 1(1): loaded http://localhost:39881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39881/tests/kraken/driver.html?testName=ai-astar) 11:38:51 INFO - PROCESS | 13060 | RSS: Main: 283193344 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | __start_tp_report 11:38:51 INFO - PROCESS | 13060 | _x_x_mozilla_page_load 11:38:51 INFO - PROCESS | 13060 | _x_x_mozilla_page_load_details 11:38:51 INFO - PROCESS | 13060 | |i|pagename|runs| 11:38:51 INFO - PROCESS | 13060 | |0;ai-astar;111;107;111;109;110;112;111;111;110;109 11:38:51 INFO - PROCESS | 13060 | |1;audio-beat-detection;153;125;126;192;127;129;164;126;161;124 11:38:51 INFO - PROCESS | 13060 | |2;audio-dft;162;165;163;162;164;161;162;162;163;161 11:38:51 INFO - PROCESS | 13060 | |3;audio-fft;74;75;75;123;77;75;75;76;97;76 11:38:51 INFO - PROCESS | 13060 | |4;audio-oscillator;85;86;114;87;86;86;126;86;86;125 11:38:51 INFO - PROCESS | 13060 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;116 11:38:51 INFO - PROCESS | 13060 | |6;imaging-darkroom;145;146;146;145;146;147;147;147;146;146 11:38:51 INFO - PROCESS | 13060 | |7;imaging-desaturate;95;95;96;95;95;96;95;95;96;95 11:38:51 INFO - PROCESS | 13060 | |8;json-parse-financial;57;53;61;55;54;54;55;60;55;54 11:38:51 INFO - PROCESS | 13060 | |9;json-stringify-tinderbox;61;63;63;63;64;62;62;62;62;63 11:38:51 INFO - PROCESS | 13060 | |10;stanford-crypto-aes;79;85;82;79;80;80;80;84;114;87 11:38:51 INFO - PROCESS | 13060 | |11;stanford-crypto-ccm;129;123;123;119;122;119;119;124;128;125 11:38:51 INFO - PROCESS | 13060 | |12;stanford-crypto-pbkdf2;162;165;161;166;164;162;163;167;164;161 11:38:51 INFO - PROCESS | 13060 | |13;stanford-crypto-sha256-iterative;64;63;63;63;62;62;64;62;66;65 11:38:51 INFO - PROCESS | 13060 | __end_tp_report 11:38:51 INFO - PROCESS | 13060 | __start_cc_report 11:38:51 INFO - PROCESS | 13060 | _x_x_mozilla_cycle_collect,1653 11:38:51 INFO - PROCESS | 13060 | __end_cc_report 11:38:51 INFO - PROCESS | 13060 | __startTimestamp1466015931176__endTimestamp 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | ------- Summary: start ------- 11:38:51 INFO - PROCESS | 13060 | Number of tests: 14 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.45 (1.3%) stddev-sans-first:1.50 11:38:51 INFO - PROCESS | 13060 | Values: 111.0 107.0 111.0 109.0 110.0 112.0 111.0 111.0 110.0 109.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:141.00 stddev:23.52 (16.7%) stddev-sans-first:24.65 11:38:51 INFO - PROCESS | 13060 | Values: 153.0 125.0 126.0 192.0 127.0 129.0 164.0 126.0 161.0 124.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 11:38:51 INFO - PROCESS | 13060 | Values: 162.0 165.0 163.0 162.0 164.0 161.0 162.0 162.0 163.0 161.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.50 stddev:15.85 (21.0%) stddev-sans-first:16.53 11:38:51 INFO - PROCESS | 13060 | Values: 74.0 75.0 75.0 123.0 77.0 75.0 75.0 76.0 97.0 76.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:86.00 stddev:17.52 (20.4%) stddev-sans-first:18.06 11:38:51 INFO - PROCESS | 13060 | Values: 85.0 86.0 114.0 87.0 86.0 86.0 126.0 86.0 86.0 125.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:38:51 INFO - PROCESS | 13060 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 11:38:51 INFO - PROCESS | 13060 | Values: 145.0 146.0 146.0 145.0 146.0 147.0 147.0 147.0 146.0 146.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:38:51 INFO - PROCESS | 13060 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:2.70 (4.9%) stddev-sans-first:2.83 11:38:51 INFO - PROCESS | 13060 | Values: 57.0 53.0 61.0 55.0 54.0 54.0 55.0 60.0 55.0 54.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 11:38:51 INFO - PROCESS | 13060 | Values: 61.0 63.0 63.0 63.0 64.0 62.0 62.0 62.0 62.0 63.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:81.00 stddev:10.55 (13.0%) stddev-sans-first:10.97 11:38:51 INFO - PROCESS | 13060 | Values: 79.0 85.0 82.0 79.0 80.0 80.0 80.0 84.0 114.0 87.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:123.50 stddev:3.57 (2.9%) stddev-sans-first:3.09 11:38:51 INFO - PROCESS | 13060 | Values: 129.0 123.0 123.0 119.0 122.0 119.0 119.0 124.0 128.0 125.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:2.07 (1.3%) stddev-sans-first:2.12 11:38:51 INFO - PROCESS | 13060 | Values: 162.0 165.0 161.0 166.0 164.0 162.0 163.0 167.0 164.0 161.0 11:38:51 INFO - PROCESS | 13060 | 11:38:51 INFO - PROCESS | 13060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.35 (2.1%) stddev-sans-first:1.41 11:38:51 INFO - PROCESS | 13060 | Values: 64.0 63.0 63.0 63.0 62.0 62.0 64.0 62.0 66.0 65.0 11:38:51 INFO - PROCESS | 13060 | -------- Summary: end -------- 11:38:51 INFO - PROCESS | 13060 | 11:38:52 INFO - TEST-INFO | 13060: exit 0 11:38:52 INFO - TEST-OK | kraken | took 61801ms 11:38:52 INFO - SUITE-END | took 1175s 11:38:52 INFO - Completed test suite (00:19:35) 11:38:52 INFO - javascript benchmark 11:38:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3009.9548506772417, 3051.3134544727427, 3066.815991040536, 3099.7210251077404, 3150.921226969325, 5277.683338999663, 5334.199870019499, 5391.56867450604, 5483.780648774049, 5493.91759123613, 5409.080456322425, 5420.512153906147, 5435.83692489226, 5469.917951230725, 5506.174073888918, 4873.926891096637, 4874.049560335736, 4955.653104282702, 4961.8015279388965, 5087.287779710843, 4969.875753106165, 5001.0, 5036.697798132105, 5063.139266324733, 5068.847934561969, 4811.446683631375, 4862.829800956985, 4878.243872199815, 4943.1102401567705, 4948.0846043481715, 4802.255650374198, 4819.879503012417, 4828.130936431441, 4852.539008794159, 4945.0, 4833.371661683994, 4854.514548545118, 4860.9513904861205, 4869.975650121763, 4991.600671946272, 5281.577473802086, 5343.919841202385, 5386.1920711893135, 5416.458354164592, 5469.234307196995, 5814.825555233308, 5854.619449735754, 5867.266591676041, 5870.559708021916, 5882.823515294548, 5827.825165245007, 5907.4683278505145, 5918.023526118185, 5918.408159184047, 5920.0, 5267.894642107136, 5337.813176538842, 5387.488188622075, 5389.380221274603, 5475.370332411744, 5988.041913293852, 6001.039833626686, 6002.6698531580305, 6008.579399442085, 6012.699365031731, 5773.364929857797, 5775.5668324875805, 5780.42195780427, 5784.942150578525, 5786.276715410574, 5539.944600554023, 5619.8876022480135, 5711.600187986801, 5720.313562372542, 5757.136429535603, 5698.373178950312, 5718.771249150071, 5720.342160651495, 5727.11229759388, 5737.139429085671, 5493.450654934474, 5666.4050274721385, 5745.482906538348, 5771.538276937835, 5783.913241301384, 4327.6970612057485, 4328.653707703376, 4341.435613370241, 4357.869263922087, 4366.890827729332, 3840.8655697051026, 3845.5193100862393, 3866.8259928303296, 3888.202918401721, 3888.8444462221196, 5267.157254839208, 5396.406395296514, 5415.160650099241, 5419.295491586068, 5422.593305502024, 5721.8569535761935, 5769.567282453832, 5790.073588225948, 5873.676947767914, 5894.8821023579285, 5507.972460137674, 5514.0, 5514.724263786795, 5523.613347065667, 5529.391766905637, 4995.275685025651, 4999.925001124986, 5017.84946451607, 5046.545810877039, 5051.823186188466, 5824.796132135355, 5951.583389162717, 6005.579609427386, 6013.428724271187, 6076.331603523698, 5871.060630299132, 5885.3820348864465, 5893.793717219876, 5894.970525147518, 5900.527957763455, 5763.279590051244, 6001.4298641628975, 6048.183495228088, 6060.545459090497, 6061.7575296987625, 5649.717514124195, 5681.0058239808695, 5690.5163061140265, 5697.943020569741, 5728.6562806230095, 5805.245318108618, 5835.183074369676, 5838.0, 5848.5028772553105, 5849.64902105875, 5513.531349835309, 5567.220589117445, 5721.456461636138, 5735.11105778605, 5738.454846789548, 5619.297587801525, 5697.4587414195585, 5706.600537962303, 5706.657600543981, 5756.16535602327, 5551.056320425457, 5592.133219351007, 5602.691851948182, 5604.243427137284, 5604.6917419542315, 5457.945420545744, 5467.179923011421, 5530.446955304598, 5726.026575482095, 5771.451712087345, 5324.201369794407, 5389.757460914347, 5482.753276102505, 5485.4788795064405, 5534.142207957773], "value": 5324.994304327935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.7732918168141, 598.3238939997802, 609.8658295175061, 615.0958091605338, 617.3178637605449, 31788.841055794746, 32377.352452950956, 34918.65081349189, 34927.82536087316, 42522.36216456748, 42682.78658606703, 46473.0, 46513.0, 46545.0, 46616.0, 8836.602352894135, 8943.463392196456, 9010.68462603809, 9013.54932253388, 9032.05163457834, 8825.95587022064, 8942.955285223565, 8951.418157819753, 8954.32842536809, 8955.865662015074, 8908.688195913111, 8940.731778046636, 8958.776030599221, 8963.193312601865, 8963.910360896405, 8869.600867960926, 8897.822043559157, 8906.465612063297, 8909.688160914402, 8911.866322005208, 8859.601317940707, 8941.418807777474, 8942.239909607626, 8942.239909607692, 8947.32895032875, 42302.57697423048, 42647.0, 42679.786601067106, 42696.14607707829, 42699.7865010676, 3563.4832949222478, 3663.6153203913473, 3835.827387767557, 4153.54311025787, 4336.436263285753, 32457.0, 33114.3377132456, 33218.0, 33585.664143358495, 34145.65854341474, 4135.58644135587, 4150.107726838744, 4172.374143878412, 4244.830206791725, 4311.094670119279, 379609.0, 380470.9999999972, 381344.0, 381479.0, 381744.0, 60120.0, 60409.69795150996, 60487.39512604906, 60491.39508604946, 60562.39437605567, 35548.46677299843, 36510.81744591313, 36647.81676091602, 64119.358806412274, 64202.35797642057, 17739.379121730937, 17859.107044647717, 17916.372926947493, 17940.19269132892, 17957.551061223312, 13530.797038044437, 13651.180929144282, 13653.726925461435, 13656.726865462635, 13661.590152295446, 19604.607907842048, 19770.40688779339, 19920.10758977895, 19964.50088747793, 20001.59996800056, 7141.001299090657, 7145.4998150128995, 7228.566286022856, 7253.347198752138, 7369.81575460607, 941.383393876998, 1016.6187679620142, 1070.4968664727567, 1121.9158563107799, 1132.7281452451352, 32143.0, 32297.838510807767, 32569.0, 32976.1755956103, 33354.33102358739, 1060.596973150198, 1073.2862646340252, 1088.8312311591717, 1092.4373947417087, 1096.270979798425, 16691.0, 17332.39336623212, 17444.563885902953, 17496.300147994192, 17561.648767024588, 568274.0, 570579.0, 571270.0, 573786.0, 576358.0, 58898.11652825211, 59563.40436595665, 59573.0, 59647.0, 59670.40329596735, 1215.7993931001463, 1317.6047185844209, 1349.0556610372778, 1351.297325390811, 1356.5184359552413, 32357.35285294234, 33417.83291083529, 33562.83218583892, 33827.0, 34499.82750086234, 51828.481715182366, 52386.73806631095, 52534.73732631465, 52548.474515254355, 52549.47450525446, 401148.0, 403644.0, 403679.0, 405796.0, 677898.0, 45698.31452528281, 45780.0, 46046.53953460423, 46589.76705116453, 50711.492885072155, 46747.76626116984, 46771.0, 51539.22691159561, 52555.0, 52637.47362526479, 41844.79077604714, 42799.7860010698, 42974.0, 43416.34875476807, 43751.0, 42573.148537028464, 43368.0, 43371.349429757945, 43492.0, 43745.12509749851, 42593.78703106465, 43148.0, 43627.34558981681, 43744.12511749811, 43816.0, 36178.63821361752, 37779.1098456462, 38613.4207986886, 38718.41922371223, 39082.2183556333, 28836.567451487826, 29036.854815725786, 29141.85429072841, 29202.41595168042, 29310.26724331909], "value": 20711.592596530354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.4822823932374, 374.6571886723648, 376.56737475905646, 388.9397143442766, 397.7414680457702, 17592.0, 19085.522861928443, 19769.703454448194, 19796.80203197966, 19800.603987920233, 18317.0, 18661.533461663465, 18678.62642747144, 18789.81210187898, 18934.431967040975, 5426.348838139429, 5464.207689884965, 5683.744231509592, 5721.284839395075, 5730.169125476824, 5589.692566908819, 5641.492265696086, 5649.661020338793, 5678.687672178028, 5691.686957217351, 5436.592255580827, 5523.2543606613, 5591.692456914868, 5641.802536911209, 5642.802501912434, 5518.668879867221, 5558.944410555883, 5562.221289019541, 5563.248961390222, 5563.471470210324, 4851.320815085891, 4893.486183950669, 4897.0, 4924.335214745999, 4948.802047918079, 22393.776062239333, 22429.887850560644, 22614.20850270249, 22760.772392276198, 22844.0, 2307.48081681622, 2343.133040774924, 2357.893894774722, 2482.9943872731574, 2855.9428811423863, 14243.287835608282, 14320.64198395038, 14387.856121438861, 14497.275136243252, 14859.405623775036, 1963.1950900130878, 2030.604032213719, 2032.8272096871783, 2035.3893831850535, 2079.3138264372874, 55247.72376138134, 69930.65034674793, 70671.0, 75949.62025189894, 81812.59093704553, 9976.102150806462, 10066.748331291776, 10393.272470927113, 10643.84034239487, 10666.306690065121, 11796.646100616996, 12373.814392784116, 14256.501022464165, 14271.072380295247, 14277.714445711028, 7554.5646327197655, 7854.803629909298, 7899.249571290833, 8528.104549022388, 8557.914420855835, 8464.915350846535, 8514.489130652057, 8523.872141917876, 8616.224539791448, 8719.04090550039, 6377.107204991305, 6404.327545607644, 6441.32366101562, 6473.902891456632, 6525.804225873231, 1724.5602371395214, 1778.3864566724717, 1779.4572655340246, 1800.666876627828, 1849.5930895203303, 959.6065613098596, 971.8930917599058, 972.8103019911049, 984.625842179967, 1023.5803320638503, 19275.903620481808, 19977.900110499355, 19981.700274495895, 20075.996200189933, 20122.69815952762, 962.5812771444444, 1009.9798004040025, 1010.4493051287067, 1044.6239353832614, 1065.5311662868469, 11123.443827808576, 11540.653780386601, 11618.477168527437, 11636.301821890713, 11732.296062236293, 487061.0, 491469.0, 496181.0, 498793.0, 499806.0, 80242.59878700569, 82816.10143644943, 84044.0, 84603.5769821147, 85998.0, 1007.4710776842217, 1025.6974192613047, 1028.8096702109983, 1033.6485594897772, 1038.1642777563982, 17691.11544422748, 17827.286908523514, 17909.552261193574, 18060.54848628795, 18238.817611824245, 39651.80174099111, 40090.39864402095, 41331.38002929898, 41616.79191604022, 42250.94372640709, 52543.474565253855, 53697.463025369245, 53827.46172538224, 53864.19203711869, 53940.19089713579, 8073.39449541275, 8354.749357519284, 8549.743507694779, 8640.783980400289, 8660.307175426076, 13857.214178731901, 13876.23680697531, 13907.930460347634, 14240.501582444565, 14252.287385630885, 11996.560412750527, 12120.27278363301, 12204.938975305067, 12238.388080596113, 12271.263724176579, 11949.820752688544, 11956.880431195925, 11988.340641264815, 12069.758604827679, 12121.393930303626, 6292.087647291209, 11493.425328733363, 12141.69645758863, 12200.816987745013, 12390.070744694363, 7922.683092676229, 8013.975324817194, 8085.676572937252, 8087.514749115072, 8161.387895907712, 11708.356040417859, 11852.881471185523, 11858.110641701734, 12070.818937716116, 12255.142140050468], "value": 9243.975087388199, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.7549465601528, 1437.3029080895767, 1488.6650503636681, 1549.5738671865242, 1764.4177421450916, 8902.421342612733, 9287.814243715131, 9312.906870931305, 9324.39391439556, 9326.393784404017, 9034.367594268404, 9236.307276954221, 9246.214071803888, 9248.953755231214, 9248.95375523123, 1952.9121189546504, 2307.665388518664, 2344.777246161612, 2370.668106465096, 2381.7975472084895, 2342.648602709599, 2346.6128088865403, 2354.682117914085, 2356.5640356534095, 2363.0665886974634, 2371.703537057868, 2379.357573455166, 2413.79482743967, 2414.7947424468853, 2416.7462416446283, 1975.2494052260192, 2272.3864556569797, 2342.4846533762543, 2347.835651504395, 2348.283773449097, 2341.0, 2358.811295096388, 2360.1621424394434, 2362.6337917622623, 2363.031157225529, 9191.816163676689, 9232.307576931757, 9247.72256832296, 9251.259899208115, 9254.491002994833, 5347.1979203119845, 5485.396606373296, 5496.945030549683, 5497.532709719679, 5499.917501237484, 3185.2992341684794, 3328.151321413024, 3446.293509830504, 3461.792292462435, 3479.2867462170193, 1131.185546406586, 1131.2590253383964, 1132.5866058888528, 1138.2771939818274, 1171.958981435654, 12998.740025199537, 13004.544840930617, 13061.804072938914, 13067.673308167277, 13068.0, 4692.436907571113, 4724.220503616864, 4783.497732738082, 4819.084373969004, 4878.341423907798, 11001.284916480403, 11002.284851484628, 11007.284526505911, 11010.669679909615, 11011.064059554867, 5329.86675333112, 5339.14573668219, 5375.623706340597, 5384.030874442559, 5400.297961265089, 4192.203481338536, 4852.8786780330065, 4937.333459982857, 4995.700257984533, 5001.124803159432, 3986.940195897064, 4046.5548789633117, 4130.56629053951, 4139.834406623701, 4140.4617399737845, 1243.4653099167265, 1248.1138391741783, 1248.8688687687843, 1259.0745801835644, 1259.5465632372338, 857.691231156783, 929.0, 977.8044391121804, 977.8239916814899, 993.7913038262046, 6153.261608606996, 6191.442770150708, 6268.561200715906, 6283.654399008007, 6378.202724659418, 446.1434046630477, 449.21611787430487, 450.9008018235983, 980.5146452505912, 1047.3977462958828, 4247.851325203603, 4310.612044915973, 4312.654987600984, 4316.460442444694, 4341.978290108529, 11595.304281743123, 11636.0, 11702.590409335633, 11727.76544469123, 11757.823632645517, 11587.652370428901, 11617.593384231512, 11636.418179091012, 11641.0, 11643.825342619868, 8100.9873765779275, 8462.36532260083, 8467.153284671484, 8700.564971751388, 8702.782430439289, 5681.801136960186, 6059.151718759465, 6077.4226448487325, 6083.513318934386, 6129.264488261437, 10366.5335059924, 10645.201609879445, 10796.082333001783, 10821.513031913426, 10856.185786065918, 10917.836232456679, 11039.944800275947, 11042.171837112088, 11186.216964812711, 11198.888011119785, 6924.169099708067, 7934.444588878723, 8155.347572194329, 8192.795180120545, 8372.623231954698, 9093.090690930854, 9098.0, 9112.997570267398, 9177.21993630549, 9177.357584968988, 8023.0, 8190.50856948585, 8195.46729462583, 8197.46716463428, 8360.163983601591, 7762.184970578008, 7880.921190788019, 7957.880631790412, 7967.5219486828655, 8007.759767206993, 7052.9647351762915, 7134.607596582237, 7200.387967022862, 7208.35124838767, 7215.062041934725, 5067.265246539305, 5078.136716758087, 5084.949150508448, 5110.897782044412, 5250.369955605352, 4972.5027497249985, 5006.4242612098615, 5124.6412751108555, 5151.098557752453, 5194.7922083116255], "value": 4725.298288401651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.1020585199994, 317.4270441852457, 320.894104945368, 325.8142858570616, 325.97881137726046, 5270.81552145675, 5306.257124002643, 5312.043832110218, 5328.46715328467, 5369.463053694629, 5255.792567121808, 5276.525112739852, 5311.362636483627, 5320.073959322376, 5331.920021199685, 4125.401816736587, 4128.75227486351, 4129.079977810317, 4131.173765246963, 4136.855210067648, 3801.733878628497, 4041.1715598302276, 4051.8784436466954, 4065.3292206785845, 4071.531773846016, 3996.700247481436, 4019.77891215983, 4026.4161696553983, 4063.7155399122075, 4073.287174744408, 3861.2663593917064, 3887.047673320026, 4032.0847597391153, 4062.837486500536, 4066.959330406717, 3513.91215219619, 3521.0493166845063, 3527.417976033977, 3529.170644898447, 3537.7169826413824, 5118.539331460186, 5118.564921981636, 5119.488051194888, 5144.922826157611, 5181.740912954338, 4384.89037774055, 4483.730976141409, 4602.424696912886, 4619.630429565626, 4634.328022436762, 5377.8117765878005, 5414.458554144593, 5468.808591699271, 5489.0, 5491.643043202179, 3885.3977633466857, 3885.8821942041654, 3894.6105389460827, 3898.0, 3903.551091624471, 5457.345118585756, 5610.242617246701, 5724.627899186539, 5736.741846616912, 5756.481916627482, 3904.6681032112588, 3914.745541539791, 3934.2524920265632, 3945.901352466154, 3953.5058117735284, 3963.623455771697, 3969.702272329587, 3997.480327557399, 4005.6595189408645, 4013.0, 4441.579691102513, 4611.723296602215, 4615.676902616851, 4621.930671039937, 4651.720896746206, 5523.613347065747, 5540.695261760561, 5543.972280138654, 5547.972260138674, 5555.611107222456, 1371.2800779590796, 1380.2132784313046, 1388.5417812121975, 1391.0957877379783, 1391.7842734376188, 840.470503582739, 875.868619707049, 885.455444901381, 888.8622263549161, 896.5786080542135, 4689.296605509201, 4699.812007519661, 4755.904881902343, 4827.879303017382, 4835.428485742148, 5017.598592112622, 5044.8234311798915, 5053.772580233825, 5077.923831142536, 5123.0, 4794.232922732346, 4826.855194344175, 4848.345473361122, 4878.902421951541, 4989.25161225819, 2885.350796070867, 2939.8236105833716, 3022.6977302269597, 3038.769298434138, 3057.694230576969, 5840.328362238312, 5841.386654401312, 5848.5321174305955, 5869.383714709979, 5890.646561206341, 5591.608587398843, 5831.471959464548, 5842.707864606753, 5866.2373891393845, 5888.4700376966275, 5861.296644402699, 5878.470937615635, 5884.617499862496, 5888.823335299948, 5889.1755154278435, 5619.808433687042, 5715.828525144252, 5725.713714314351, 5742.0, 5751.683657398883, 5535.474129957647, 5657.745401457027, 5682.857928551819, 5686.516646084963, 5690.829275121753, 5783.074708046693, 5826.009578371772, 5831.970840145772, 5838.591298609056, 5878.794242201502, 3877.554081280576, 3951.545572259227, 3958.465607142999, 3975.801209939549, 4003.2393845169327, 5524.696141712245, 5596.888062238651, 5599.692016939108, 5611.551075913999, 5661.66030038199, 5487.314085739283, 5494.423085575957, 5521.680894024439, 5547.833564993057, 5583.246261754611, 5264.236685680631, 5508.944910550843, 5515.972420138034, 5532.280803495681, 5555.138953462219, 5391.490382692852, 5391.784328626811, 5422.6475279106735, 5438.592105592017, 5442.755076021668, 5504.80733174337, 5532.557395408277, 5549.278593782782, 5554.472325129106, 5576.163575463713, 5115.974420127875, 5344.4121146674615, 5399.543207840345, 5403.0, 5424.213489044146], "value": 4140.104413740206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8776208044633, 741.3216906530524, 747.8167848877026, 758.7989182866542, 827.6110228192751, 13859.445622175113, 14798.408063677467, 14805.703885922276, 14811.851881481181, 14826.184559849218, 14671.193084380382, 14813.851861481382, 14837.777433338508, 14838.480653177141, 14867.479638212664, 672.9360710732473, 790.6402586822996, 796.2913007423398, 815.3599424451806, 817.2522142239843, 793.833295008049, 800.8918795962558, 801.3989507869098, 804.6499772598909, 804.7183485779989, 856.7858035491128, 858.6179150278098, 858.8024754306513, 858.9828203435927, 859.2395729779159, 709.4785332780402, 821.3593397150232, 833.0420016980461, 833.7832163637437, 837.1126605797813, 622.0420552349376, 622.0637939900466, 622.4957784194771, 622.5206590925008, 622.6419808610023, 15179.848201517954, 15297.770533442008, 15353.309101090477, 15373.692526149527, 15392.30734616945, 14076.296185190802, 14363.71272574553, 14429.35067921946, 14499.71000579993, 15022.474213402478, 11766.764664706658, 11888.762224755543, 11963.521459141624, 12114.697132571757, 12181.33002684852, 4387.824487020515, 4431.401760762288, 4431.667624928111, 4433.1577000369825, 4438.533953934855, 63488.68255658738, 67080.3291967079, 69930.30069699339, 70229.64885175541, 72696.0, 11278.887211127947, 11568.942155289169, 11658.883411165949, 11714.062874969983, 11843.170978031456, 21604.89197554002, 21612.351629451143, 21627.891860540596, 21630.56738865214, 21641.0, 8889.377743558018, 8892.510911899908, 8897.955510222408, 8920.375573709907, 9323.067693230758, 4734.0, 4788.329633851264, 4835.2505361669, 4852.417709874838, 4875.463698993108, 3737.2338670572467, 3876.9224615507533, 3880.41793730937, 3888.183481468867, 3891.3190191716335, 684.0, 684.4387602166275, 689.3279052923359, 729.68623491899, 729.919708832028, 602.4698265526397, 653.5359894474881, 742.1984257002424, 756.406221116421, 779.2480256552454, 9561.282903782245, 9662.56518456671, 9747.220222382335, 9775.266854985905, 10039.799204015879, 718.8526352097807, 722.9421646268286, 736.105631657528, 742.921993190718, 746.0860445953772, 4691.671582989158, 4958.851234462972, 4970.15507363749, 4981.327520784647, 4991.725455100004, 72997.0, 73768.26231737722, 125319.3734031324, 125965.37017314855, 126961.36519317345, 99976.59071099489, 106707.46646266874, 107736.46131769448, 107954.0, 109551.0, 58497.12254316189, 93687.53156234311, 95570.52214738882, 96223.51888240514, 96284.0, 9402.764930876783, 9428.858567121635, 9508.809823803347, 9510.254835278287, 9552.283578731762, 52277.47722522726, 53871.73064134654, 54322.45677543174, 55078.44921550733, 55181.724091379285, 45497.31754023626, 45879.54120458753, 46930.76534617305, 64952.675236623516, 77311.0, 13418.530351437652, 13904.652383690083, 14060.648483787987, 14889.255537222878, 14999.700006000037, 14393.64015899611, 15039.699206015599, 15636.765448518054, 16107.355705771637, 17195.0, 13766.518171863936, 14582.0, 14909.403623854925, 14944.0, 14963.77554336664, 14582.270886455846, 14674.63313417173, 14879.330430130454, 15011.699766004836, 15245.847541524887, 14620.41518339297, 14627.0, 14755.483558075844, 14768.187749673441, 14790.704185916005, 10744.677659670222, 11486.712832179262, 11604.07167426587, 11640.0, 11860.644180674248, 11887.881121188677, 12153.817692734792, 12199.207051541622, 12228.0, 12360.381980901098], "value": 7680.247427371528, "unit": "score"}], "name": "dromaeo_css", "value": 7314.909562299747, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 111.0, 109.0, 110.0, 112.0, 111.0, 111.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 126.0, 192.0, 127.0, 129.0, 164.0, 126.0, 161.0, 124.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 162.0, 164.0, 161.0, 162.0, 162.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 123.0, 77.0, 75.0, 75.0, 76.0, 97.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 114.0, 87.0, 86.0, 86.0, 126.0, 86.0, 86.0, 125.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 61.0, 55.0, 54.0, 54.0, 55.0, 60.0, 55.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 82.0, 79.0, 80.0, 80.0, 80.0, 84.0, 114.0, 87.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 123.0, 119.0, 122.0, 119.0, 119.0, 124.0, 128.0, 125.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 161.0, 166.0, 164.0, 162.0, 163.0, 167.0, 164.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 62.0, 62.0, 64.0, 62.0, 66.0, 65.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1505.6999999999998, "alertThreshold": 2.0}]} 11:38:52 INFO - Return code: 0 11:38:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:52 INFO - # TBPL SUCCESS # 11:38:52 INFO - Running post-action listener: _resource_record_post_action 11:38:52 INFO - ##### 11:38:52 INFO - ##### Finished run-tests step (success) 11:38:52 INFO - ##### 11:38:52 INFO - Running post-run listener: _resource_record_post_run 11:38:52 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 16384; Write bytes: 499408896; Read time: 512; Write time: 470764 11:38:52 INFO - TinderboxPrint: CPU usage
13.2% 11:38:52 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 512 11:38:52 INFO - TinderboxPrint: I/O write bytes / time
499,408,896 / 470,764 11:38:52 INFO - TinderboxPrint: CPU idle
8,269.5 (86.8%) 11:38:52 INFO - TinderboxPrint: CPU user
1,206.3 (12.7%) 11:38:52 INFO - TinderboxPrint: Swap in / out
0 / 0 11:38:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 8192; Write bytes: 206118912; Read time: 292; Write time: 290784 11:38:52 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293289984; Read time: 220; Write time: 179980 11:38:53 INFO - Running post-run listener: _upload_blobber_files 11:38:53 INFO - Blob upload gear active. 11:38:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:38:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:38:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:57 INFO - (blobuploader) - INFO - Done attempting. 11:38:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:38:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:38:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:58 INFO - (blobuploader) - INFO - Done attempting. 11:38:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:38:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:38:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:58 INFO - (blobuploader) - INFO - Done attempting. 11:38:58 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:58 INFO - Return code: 0 11:38:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e99243c925ecb09727302adcc79d589319a21fe2015a411e98d0500322953397d5b03608a2f3319b5bd0e97b3f68ff5067bc58fa140a88f1a80b2581cdacda91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf067217c4a8d9c428e51f71b408f7975a237f0d4e4cca7d61a8a1eec0658dc7f52399078ff67a50c58a379e6b28445f40ee6748d77df75513f917f07309c728", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f56bc10e43dd46c3267aef1fda6ee695d684f5cbc3cf8ef2d0d3799530979dc37a4212522b669c3764723d68fbd0f9efc9bcfcaf9ecf9184dc7b3a5207186254"} 11:38:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:58 INFO - Contents: 11:38:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e99243c925ecb09727302adcc79d589319a21fe2015a411e98d0500322953397d5b03608a2f3319b5bd0e97b3f68ff5067bc58fa140a88f1a80b2581cdacda91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf067217c4a8d9c428e51f71b408f7975a237f0d4e4cca7d61a8a1eec0658dc7f52399078ff67a50c58a379e6b28445f40ee6748d77df75513f917f07309c728", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f56bc10e43dd46c3267aef1fda6ee695d684f5cbc3cf8ef2d0d3799530979dc37a4212522b669c3764723d68fbd0f9efc9bcfcaf9ecf9184dc7b3a5207186254"} 11:38:58 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:58 INFO - Copying logs to upload dir... 11:38:58 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.854971 ========= master_lag: 0.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-15 11:38:59.182929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 11:38:59.190934) ========= 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=52faae308a556c440401f8e5000001e8-1466014205.322545-470370542 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/e99243c925ecb09727302adcc79d589319a21fe2015a411e98d0500322953397d5b03608a2f3319b5bd0e97b3f68ff5067bc58fa140a88f1a80b2581cdacda91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf067217c4a8d9c428e51f71b408f7975a237f0d4e4cca7d61a8a1eec0658dc7f52399078ff67a50c58a379e6b28445f40ee6748d77df75513f917f07309c728", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f56bc10e43dd46c3267aef1fda6ee695d684f5cbc3cf8ef2d0d3799530979dc37a4212522b669c3764723d68fbd0f9efc9bcfcaf9ecf9184dc7b3a5207186254"} build_url:https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/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/e99243c925ecb09727302adcc79d589319a21fe2015a411e98d0500322953397d5b03608a2f3319b5bd0e97b3f68ff5067bc58fa140a88f1a80b2581cdacda91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf067217c4a8d9c428e51f71b408f7975a237f0d4e4cca7d61a8a1eec0658dc7f52399078ff67a50c58a379e6b28445f40ee6748d77df75513f917f07309c728", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f56bc10e43dd46c3267aef1fda6ee695d684f5cbc3cf8ef2d0d3799530979dc37a4212522b669c3764723d68fbd0f9efc9bcfcaf9ecf9184dc7b3a5207186254"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 11:38:59.218723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:38:59.219060) ========= 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=52faae308a556c440401f8e5000001e8-1466014205.322545-470370542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:38:59.268224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 11:38:59.269220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 11:38:59.269532) ========= ========= Total master_lag: 0.86 =========