builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1466014690.7 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.701861) ========= 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.702288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.702782) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.730420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.730737) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 11:18:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-15 11:18:10 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.831188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.831485) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014821 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.914104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:10.914429) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 11:18:10,978 truncating revision to first 12 chars 2016-06-15 11:18:10,978 Setting DEBUG logging. 2016-06-15 11:18:10,978 attempt 1/10 2016-06-15 11:18:10,978 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,314 unpacking tar archive at: fx-team-153553aecf16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685870 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.613222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.613524) ========= script_repo_revision: 153553aecf160632bbcb50906ba135511da138e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.613902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.614177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 11:18:11.623233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-15 11:18:11.623566) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:11 INFO - MultiFileLogger online at 20160615 11:18:11 in /builds/slave/test 11:18:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:18:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:11 INFO - {'append_to_log': False, 11:18:11 INFO - 'base_work_dir': '/builds/slave/test', 11:18:11 INFO - 'blob_upload_branch': 'Fx-Team', 11:18:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:11 INFO - 'branch': 'Fx-Team', 11:18:11 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:11 INFO - 'config_files': ('talos/linux_config.py',), 11:18:11 INFO - 'default_actions': ('clobber', 11:18:11 INFO - 'read-buildbot-config', 11:18:11 INFO - 'download-and-extract', 11:18:11 INFO - 'populate-webroot', 11:18:11 INFO - 'create-virtualenv', 11:18:11 INFO - 'install', 11:18:11 INFO - 'run-tests'), 11:18:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:11 INFO - 'download_minidump_stackwalk': True, 11:18:11 INFO - 'download_symbols': 'ondemand', 11:18:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:11 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:11 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:11 INFO - 'installer_path': 'installer.exe', 11:18:11 INFO - 'log_level': 'info', 11:18:11 INFO - 'log_name': 'talos', 11:18:11 INFO - 'log_to_console': True, 11:18:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:11 INFO - 'opt_config_files': (), 11:18:11 INFO - 'pip_index': False, 11:18:11 INFO - 'sps_profile': False, 11:18:11 INFO - 'sps_profile_interval': 0, 11:18:11 INFO - 'suite': 'dromaeojs-e10s', 11:18:11 INFO - 'system_bits': '32', 11:18:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:11 INFO - 'title': 'talos-linux64-ix-040', 11:18:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:11 INFO - 'use_talos_json': True, 11:18:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:11 INFO - 'work_dir': 'build'} 11:18:11 INFO - ##### 11:18:11 INFO - ##### Running clobber step. 11:18:11 INFO - ##### 11:18:11 INFO - Running pre-action listener: _resource_record_pre_action 11:18:11 INFO - Running main action method: clobber 11:18:11 INFO - rmtree: /builds/slave/test/build 11:18:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:12 INFO - Running post-action listener: _resource_record_post_action 11:18:12 INFO - ##### 11:18:12 INFO - ##### Finished clobber step (success) 11:18:12 INFO - ##### 11:18:12 INFO - ##### 11:18:12 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 11:18:12 INFO - Using buildbot properties: 11:18:12 INFO - { 11:18:12 INFO - "project": "", 11:18:12 INFO - "product": "firefox", 11:18:12 INFO - "script_repo_revision": "production", 11:18:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:18:12 INFO - "repository": "", 11:18:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:18:12 INFO - "buildid": "20160615083055", 11:18:12 INFO - "pgo_build": "True", 11:18:12 INFO - "basedir": "/builds/slave/test", 11:18:12 INFO - "buildnumber": 475, 11:18:12 INFO - "slavename": "talos-linux64-ix-040", 11:18:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:18:12 INFO - "platform": "ubuntu64_hw", 11:18:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:18:12 INFO - "branch": "fx-team", 11:18:12 INFO - "repo_path": "integration/fx-team", 11:18:12 INFO - "revision": "153553aecf160632bbcb50906ba135511da138e6", 11:18:12 INFO - "stage_platform": "linux64-pgo", 11:18:12 INFO - "builduid": "4e827579fcaa412a9eb804da878b3e56", 11:18:12 INFO - "slavebuilddir": "test" 11:18:12 INFO - } 11:18:12 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:12 INFO - Running post-action listener: _resource_record_post_action 11:18:12 INFO - ##### 11:18:12 INFO - ##### Finished read-buildbot-config step (success) 11:18:12 INFO - ##### 11:18:12 INFO - ##### 11:18:12 INFO - ##### Running download-and-extract 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: download_and_extract 11:18:12 INFO - mkdir: /builds/slave/test/build/tests 11:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:12 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:12 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:12 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:12 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:12 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:18 INFO - Downloaded 1361 bytes. 11:18:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:18 INFO - Using the following test package requirements: 11:18:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:18:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:18:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:18 INFO - u'jsshell-linux-x86_64.zip'], 11:18:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:18:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:18:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:18:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:18:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:18:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:18:18 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:18 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:18 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:18 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:18 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:18 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:24 INFO - Downloaded 24220181 bytes. 11:18:24 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:24 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:25 INFO - Return code: 0 11:18:25 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:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:25 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:25 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:25 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:25 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:25 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:27 INFO - Downloaded 24220181 bytes. 11:18:27 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:27 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:29 INFO - Return code: 0 11:18:29 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:29 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:29 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:29 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:29 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:29 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:31 INFO - Downloaded 14405384 bytes. 11:18:31 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:31 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:31 INFO - Return code: 0 11:18:31 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:31 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:31 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:31 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:31 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:31 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:33 INFO - Downloaded 59386487 bytes. 11:18:33 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:33 INFO - mkdir: /builds/slave/test/properties 11:18:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:33 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:33 INFO - Contents: 11:18:33 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:34 INFO - Running post-action listener: _resource_record_post_action 11:18:34 INFO - Running post-action listener: set_extra_try_arguments 11:18:34 INFO - ##### 11:18:34 INFO - ##### Finished download-and-extract step (success) 11:18:34 INFO - ##### 11:18:34 INFO - ##### 11:18:34 INFO - ##### Running populate-webroot step. 11:18:34 INFO - ##### 11:18:34 INFO - Running pre-action listener: _resource_record_pre_action 11:18:34 INFO - Running main action method: populate_webroot 11:18:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:34 INFO - '--tppagecycles', 11:18:34 INFO - '7'], 11:18:34 INFO - 'tests': ['tsvgm']}}, 11:18:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:34 INFO - 'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:34 INFO - 'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['damp', 'tps']}, 11:18:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:34 INFO - 'tests': ['damp', 'tps']}, 11:18:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['dromaeo_dom']}, 11:18:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['basic_compositor_video']}, 11:18:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['a11yr', 11:18:34 INFO - 'ts_paint', 11:18:34 INFO - 'tpaint', 11:18:34 INFO - 'sessionrestore', 11:18:34 INFO - 'sessionrestore_no_auto_restore', 11:18:34 INFO - 'tabpaint']}, 11:18:34 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:34 INFO - 'ts_paint', 11:18:34 INFO - 'tpaint', 11:18:34 INFO - 'sessionrestore', 11:18:34 INFO - 'sessionrestore_no_auto_restore', 11:18:34 INFO - 'tabpaint']}, 11:18:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:34 INFO - 'ts_paint', 11:18:34 INFO - 'tpaint', 11:18:34 INFO - 'sessionrestore', 11:18:34 INFO - 'sessionrestore_no_auto_restore', 11:18:34 INFO - 'tabpaint']}, 11:18:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:34 INFO - 'ts_paint', 11:18:34 INFO - 'tpaint', 11:18:34 INFO - 'sessionrestore', 11:18:34 INFO - 'sessionrestore_no_auto_restore', 11:18:34 INFO - 'tabpaint']}, 11:18:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['a11yr', 11:18:34 INFO - 'ts_paint', 11:18:34 INFO - 'tpaint', 11:18:34 INFO - 'sessionrestore', 11:18:34 INFO - 'sessionrestore_no_auto_restore', 11:18:34 INFO - 'tabpaint']}, 11:18:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['a11yr', 11:18:34 INFO - 'ts_paint', 11:18:34 INFO - 'tpaint', 11:18:34 INFO - 'sessionrestore', 11:18:34 INFO - 'sessionrestore_no_auto_restore', 11:18:34 INFO - 'tabpaint']}, 11:18:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['tsvgx', 11:18:34 INFO - 'tsvgr_opacity', 11:18:34 INFO - 'tart', 11:18:34 INFO - 'tscrollx', 11:18:34 INFO - 'cart']}, 11:18:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:34 INFO - 'tsvgr_opacity', 11:18:34 INFO - 'tart', 11:18:34 INFO - 'tscrollx', 11:18:34 INFO - 'cart']}, 11:18:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:34 INFO - 'talos_options': ['--disable-e10s'], 11:18:34 INFO - 'tests': ['tp5o']}, 11:18:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:34 INFO - 'tests': ['tp5o']}, 11:18:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:34 INFO - 'talos_options': ['--disable-e10s', 11:18:34 INFO - '--xperf_path', 11:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:34 INFO - 'tests': ['tp5n']}, 11:18:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:34 INFO - 'talos_options': ['--xperf_path', 11:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:34 INFO - 'tests': ['tp5n']}}, 11:18:34 INFO - 'talos.zip': {'path': '', 11:18:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:34 INFO - Running post-action listener: _resource_record_post_action 11:18:34 INFO - ##### 11:18:34 INFO - ##### Finished populate-webroot step (success) 11:18:34 INFO - ##### 11:18:34 INFO - ##### 11:18:34 INFO - ##### Running create-virtualenv step. 11:18:34 INFO - ##### 11:18:34 INFO - Running pre-action listener: _resource_record_pre_action 11:18:34 INFO - Running main action method: create_virtualenv 11:18:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:34 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:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:34 INFO - Using real prefix '/usr' 11:18:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:34 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:36 INFO - Installing pip.................done. 11:18:36 INFO - Return code: 0 11:18:36 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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', 'pip>=1.5'] 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 pip>=1.5 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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 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 - 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:36 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:36 INFO - '_': '/tools/buildbot/bin/python'} 11:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:37 INFO - Downloading/unpacking psutil>=3.1.1 11:18:37 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:37 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:37 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:37 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:37 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:37 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:39 INFO - Installing collected packages: psutil 11:18:39 INFO - Running setup.py install for psutil 11:18:39 INFO - building 'psutil._psutil_linux' extension 11:18:39 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:39 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:39 INFO - building 'psutil._psutil_posix' extension 11:18:39 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:39 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:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:39 INFO - Successfully installed psutil 11:18:39 INFO - Cleaning up... 11:18:39 INFO - Return code: 0 11:18:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18:39 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:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:39 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:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:39 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 11:18:39 INFO - 'HOME': '/home/cltbld', 11:18:39 INFO - 'LANG': 'en_US.UTF-8', 11:18:39 INFO - 'LANGUAGE': 'en_US:en', 11:18:39 INFO - 'LOGNAME': 'cltbld', 11:18:39 INFO - 'MAIL': '/var/mail/cltbld', 11:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:39 INFO - 'MOZ_NO_REMOTE': '1', 11:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:39 INFO - 'NO_EM_RESTART': '1', 11:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:39 INFO - 'PWD': '/builds/slave/test', 11:18:39 INFO - 'SHELL': '/bin/bash', 11:18:39 INFO - 'SHLVL': '1', 11:18:39 INFO - 'TERM': 'linux', 11:18:39 INFO - 'TMOUT': '86400', 11:18:39 INFO - 'USER': 'cltbld', 11:18:39 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:39 INFO - '_': '/tools/buildbot/bin/python'} 11:18:39 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:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:41 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:41 INFO - Installing collected packages: mozsystemmonitor 11:18:41 INFO - Running setup.py install for mozsystemmonitor 11:18:42 INFO - Successfully installed mozsystemmonitor 11:18:42 INFO - Cleaning up... 11:18:42 INFO - Return code: 0 11:18:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:42 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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:42 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:42 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:42 INFO - Using env: {'DISPLAY': ':0', 11:18:42 INFO - 'HOME': '/home/cltbld', 11:18:42 INFO - 'LANG': 'en_US.UTF-8', 11:18:42 INFO - 'LANGUAGE': 'en_US:en', 11:18:42 INFO - 'LOGNAME': 'cltbld', 11:18:42 INFO - 'MAIL': '/var/mail/cltbld', 11:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:42 INFO - 'MOZ_NO_REMOTE': '1', 11:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:42 INFO - 'NO_EM_RESTART': '1', 11:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:42 INFO - 'PWD': '/builds/slave/test', 11:18:42 INFO - 'SHELL': '/bin/bash', 11:18:42 INFO - 'SHLVL': '1', 11:18:42 INFO - 'TERM': 'linux', 11:18:42 INFO - 'TMOUT': '86400', 11:18:42 INFO - 'USER': 'cltbld', 11:18:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:42 INFO - '_': '/tools/buildbot/bin/python'} 11:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:42 INFO - Downloading/unpacking jsonschema==2.5.1 11:18:42 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:42 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:42 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:42 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:42 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:42 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:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18:44 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:44 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:44 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:44 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:44 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:44 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:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:44 INFO - warning: no files found matching '*.txt' 11:18:44 INFO - no previously-included directories found matching 'build' 11:18:44 INFO - no previously-included directories found matching 'dist' 11:18:44 INFO - no previously-included directories found matching '.git*' 11:18:44 INFO - Installing collected packages: jsonschema, functools32 11:18:45 INFO - Running setup.py install for functools32 11:18:45 INFO - warning: no files found matching '*.txt' 11:18:45 INFO - no previously-included directories found matching 'build' 11:18:45 INFO - no previously-included directories found matching 'dist' 11:18:45 INFO - no previously-included directories found matching '.git*' 11:18:45 INFO - Successfully installed jsonschema functools32 11:18:45 INFO - Cleaning up... 11:18:45 INFO - Return code: 0 11:18:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:45 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 11:18:45 INFO - 'HOME': '/home/cltbld', 11:18:45 INFO - 'LANG': 'en_US.UTF-8', 11:18:45 INFO - 'LANGUAGE': 'en_US:en', 11:18:45 INFO - 'LOGNAME': 'cltbld', 11:18:45 INFO - 'MAIL': '/var/mail/cltbld', 11:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:45 INFO - 'MOZ_NO_REMOTE': '1', 11:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:45 INFO - 'NO_EM_RESTART': '1', 11:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:45 INFO - 'PWD': '/builds/slave/test', 11:18:45 INFO - 'SHELL': '/bin/bash', 11:18:45 INFO - 'SHLVL': '1', 11:18:45 INFO - 'TERM': 'linux', 11:18:45 INFO - 'TMOUT': '86400', 11:18:45 INFO - 'USER': 'cltbld', 11:18:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:45 INFO - '_': '/tools/buildbot/bin/python'} 11:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:45 INFO - Downloading/unpacking 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:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Downloading docopt-0.6.1.tar.gz 11:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:48 INFO - Running setup.py install for blobuploader 11:18:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:48 INFO - Running setup.py install for requests 11:18:48 INFO - Running setup.py install for docopt 11:18:48 INFO - Successfully installed blobuploader requests docopt 11:18:48 INFO - Cleaning up... 11:18:48 INFO - Return code: 0 11:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 11:18:48 INFO - 'HOME': '/home/cltbld', 11:18:48 INFO - 'LANG': 'en_US.UTF-8', 11:18:48 INFO - 'LANGUAGE': 'en_US:en', 11:18:48 INFO - 'LOGNAME': 'cltbld', 11:18:48 INFO - 'MAIL': '/var/mail/cltbld', 11:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:48 INFO - 'MOZ_NO_REMOTE': '1', 11:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:48 INFO - 'NO_EM_RESTART': '1', 11:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:48 INFO - 'PWD': '/builds/slave/test', 11:18:48 INFO - 'SHELL': '/bin/bash', 11:18:48 INFO - 'SHLVL': '1', 11:18:48 INFO - 'TERM': 'linux', 11:18:48 INFO - 'TMOUT': '86400', 11:18:48 INFO - 'USER': 'cltbld', 11:18:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:48 INFO - '_': '/tools/buildbot/bin/python'} 11:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:48 INFO - Running setup.py (path:/tmp/pip-j51YJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:48 INFO - Running setup.py (path:/tmp/pip-O3wuTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:49 INFO - Running setup.py (path:/tmp/pip-l7mndj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:49 INFO - Running setup.py (path:/tmp/pip-xucrE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:49 INFO - Running setup.py (path:/tmp/pip-szyhL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:49 INFO - Running setup.py (path:/tmp/pip-PX5CJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:49 INFO - Running setup.py (path:/tmp/pip-3J1Vvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:49 INFO - Running setup.py (path:/tmp/pip-gB3KKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:49 INFO - Running setup.py (path:/tmp/pip-qsj38B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:49 INFO - Running setup.py (path:/tmp/pip-3_dZlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:49 INFO - Running setup.py (path:/tmp/pip-yAjxsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:49 INFO - Running setup.py (path:/tmp/pip-aLA3EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:49 INFO - Running setup.py (path:/tmp/pip-ko3Prz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:49 INFO - Running setup.py (path:/tmp/pip-5CsuxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:49 INFO - Running setup.py (path:/tmp/pip-zJzobl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:49 INFO - Running setup.py (path:/tmp/pip-Jip_9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:50 INFO - Running setup.py (path:/tmp/pip-qOMbVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:50 INFO - Running setup.py install for manifestparser 11:18:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozcrash 11:18:50 INFO - Running setup.py install for mozdebug 11:18:50 INFO - Running setup.py install for mozdevice 11:18:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozfile 11:18:50 INFO - Running setup.py install for mozhttpd 11:18:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozinfo 11:18:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozInstall 11:18:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozleak 11:18:50 INFO - Running setup.py install for mozlog 11:18:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Running setup.py install for moznetwork 11:18:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Running setup.py install for mozprocess 11:18:51 INFO - Running setup.py install for mozprofile 11:18:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Running setup.py install for mozrunner 11:18:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Running setup.py install for mozscreenshot 11:18:51 INFO - Running setup.py install for moztest 11:18:51 INFO - Running setup.py install for mozversion 11:18:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:51 INFO - Cleaning up... 11:18:51 INFO - Return code: 0 11:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:51 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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:51 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:51 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:51 INFO - Using env: {'DISPLAY': ':0', 11:18:51 INFO - 'HOME': '/home/cltbld', 11:18:51 INFO - 'LANG': 'en_US.UTF-8', 11:18:51 INFO - 'LANGUAGE': 'en_US:en', 11:18:51 INFO - 'LOGNAME': 'cltbld', 11:18:51 INFO - 'MAIL': '/var/mail/cltbld', 11:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:51 INFO - 'MOZ_NO_REMOTE': '1', 11:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:51 INFO - 'NO_EM_RESTART': '1', 11:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:51 INFO - 'PWD': '/builds/slave/test', 11:18:51 INFO - 'SHELL': '/bin/bash', 11:18:51 INFO - 'SHLVL': '1', 11:18:51 INFO - 'TERM': 'linux', 11:18:51 INFO - 'TMOUT': '86400', 11:18:51 INFO - 'USER': 'cltbld', 11:18:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:51 INFO - '_': '/tools/buildbot/bin/python'} 11:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:52 INFO - Running setup.py (path:/tmp/pip-jyD8oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:52 INFO - Running setup.py (path:/tmp/pip-A_svNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:52 INFO - Running setup.py (path:/tmp/pip-dgSdiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:52 INFO - Running setup.py (path:/tmp/pip-uVbMoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:52 INFO - Running setup.py (path:/tmp/pip-seiVkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:52 INFO - Running setup.py (path:/tmp/pip-K9qqvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:52 INFO - Running setup.py (path:/tmp/pip-A3truk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:52 INFO - Running setup.py (path:/tmp/pip-7SnAE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:52 INFO - Running setup.py (path:/tmp/pip-YwTYiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:52 INFO - Running setup.py (path:/tmp/pip-K0JQMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:52 INFO - Running setup.py (path:/tmp/pip-8MgwOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:52 INFO - Running setup.py (path:/tmp/pip-u1BzGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:52 INFO - Running setup.py (path:/tmp/pip-Hf27hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:53 INFO - Running setup.py (path:/tmp/pip-bJvQYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:53 INFO - Running setup.py (path:/tmp/pip-Z_nn5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:53 INFO - Running setup.py (path:/tmp/pip-o4mch1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:53 INFO - Running setup.py (path:/tmp/pip-DcP5UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - Downloading blessings-1.6.tar.gz 11:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:55 INFO - Installing collected packages: blessings 11:18:55 INFO - Running setup.py install for blessings 11:18:55 INFO - Successfully installed blessings 11:18:55 INFO - Cleaning up... 11:18:55 INFO - Return code: 0 11:18:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:55 INFO - Reading from file tmpfile_stdout 11:18:55 INFO - Current package versions: 11:18:55 INFO - argparse == 1.2.1 11:18:55 INFO - blessings == 1.6 11:18:55 INFO - blobuploader == 1.2.4 11:18:55 INFO - docopt == 0.6.1 11:18:55 INFO - functools32 == 3.2.3-2 11:18:55 INFO - jsonschema == 2.5.1 11:18:55 INFO - manifestparser == 1.1 11:18:55 INFO - mozInstall == 1.12 11:18:55 INFO - mozcrash == 0.17 11:18:55 INFO - mozdebug == 0.1 11:18:55 INFO - mozdevice == 0.48 11:18:55 INFO - mozfile == 1.2 11:18:55 INFO - mozhttpd == 0.7 11:18:55 INFO - mozinfo == 0.9 11:18:55 INFO - mozleak == 0.1 11:18:55 INFO - mozlog == 3.2 11:18:55 INFO - moznetwork == 0.27 11:18:55 INFO - mozprocess == 0.22 11:18:55 INFO - mozprofile == 0.28 11:18:55 INFO - mozrunner == 6.11 11:18:55 INFO - mozscreenshot == 0.1 11:18:55 INFO - mozsystemmonitor == 0.3 11:18:55 INFO - moztest == 0.7 11:18:55 INFO - mozversion == 1.4 11:18:55 INFO - psutil == 3.1.1 11:18:55 INFO - requests == 1.2.3 11:18:55 INFO - wsgiref == 0.1.2 11:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 11:18:55 INFO - 'HOME': '/home/cltbld', 11:18:55 INFO - 'LANG': 'en_US.UTF-8', 11:18:55 INFO - 'LANGUAGE': 'en_US:en', 11:18:55 INFO - 'LOGNAME': 'cltbld', 11:18:55 INFO - 'MAIL': '/var/mail/cltbld', 11:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:55 INFO - 'MOZ_NO_REMOTE': '1', 11:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:55 INFO - 'NO_EM_RESTART': '1', 11:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:55 INFO - 'PWD': '/builds/slave/test', 11:18:55 INFO - 'SHELL': '/bin/bash', 11:18:55 INFO - 'SHLVL': '1', 11:18:55 INFO - 'TERM': 'linux', 11:18:55 INFO - 'TMOUT': '86400', 11:18:55 INFO - 'USER': 'cltbld', 11:18:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:55 INFO - '_': '/tools/buildbot/bin/python'} 11:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 INFO - Cleaning up... 11:18:55 INFO - Return code: 0 11:18:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 11:18:55 INFO - 'HOME': '/home/cltbld', 11:18:55 INFO - 'LANG': 'en_US.UTF-8', 11:18:55 INFO - 'LANGUAGE': 'en_US:en', 11:18:55 INFO - 'LOGNAME': 'cltbld', 11:18:55 INFO - 'MAIL': '/var/mail/cltbld', 11:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:55 INFO - 'MOZ_NO_REMOTE': '1', 11:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:55 INFO - 'NO_EM_RESTART': '1', 11:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:55 INFO - 'PWD': '/builds/slave/test', 11:18:55 INFO - 'SHELL': '/bin/bash', 11:18:55 INFO - 'SHLVL': '1', 11:18:55 INFO - 'TERM': 'linux', 11:18:55 INFO - 'TMOUT': '86400', 11:18:55 INFO - 'USER': 'cltbld', 11:18:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:55 INFO - '_': '/tools/buildbot/bin/python'} 11:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:56 INFO - Cleaning up... 11:18:56 INFO - Return code: 0 11:18:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:56 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 0x7f9f63db6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 11:18:56 INFO - 'HOME': '/home/cltbld', 11:18:56 INFO - 'LANG': 'en_US.UTF-8', 11:18:56 INFO - 'LANGUAGE': 'en_US:en', 11:18:56 INFO - 'LOGNAME': 'cltbld', 11:18:56 INFO - 'MAIL': '/var/mail/cltbld', 11:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:56 INFO - 'MOZ_NO_REMOTE': '1', 11:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:56 INFO - 'NO_EM_RESTART': '1', 11:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:56 INFO - 'PWD': '/builds/slave/test', 11:18:56 INFO - 'SHELL': '/bin/bash', 11:18:56 INFO - 'SHLVL': '1', 11:18:56 INFO - 'TERM': 'linux', 11:18:56 INFO - 'TMOUT': '86400', 11:18:56 INFO - 'USER': 'cltbld', 11:18:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:56 INFO - '_': '/tools/buildbot/bin/python'} 11:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:56 INFO - Downloading/unpacking 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:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:18:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:18:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:58 INFO - no previously-included directories found matching 'docs/_build' 11:18:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:18:59 INFO - Running setup.py install for pep8 11:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:59 INFO - no previously-included directories found matching 'docs/_build' 11:18:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:18:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:18:59 INFO - Cleaning up... 11:18:59 INFO - Return code: 0 11:18:59 INFO - Running post-action listener: _resource_record_post_action 11:18:59 INFO - Running post-action listener: _start_resource_monitoring 11:18:59 INFO - Starting resource monitoring. 11:18:59 INFO - ##### 11:18:59 INFO - ##### Finished create-virtualenv step (success) 11:18:59 INFO - ##### 11:18:59 INFO - ##### 11:18:59 INFO - ##### Running install step. 11:18:59 INFO - ##### 11:18:59 INFO - Running pre-action listener: _resource_record_pre_action 11:18:59 INFO - Running main action method: install 11:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:59 INFO - Reading from file tmpfile_stdout 11:18:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:59 INFO - Reading from file tmpfile_stdout 11:18:59 INFO - Output received: 11:18:59 INFO - Usage: mozinstall [options] installer 11:18:59 INFO - Options: 11:18:59 INFO - -h, --help show this help message and exit 11:18:59 INFO - -d DEST, --destination=DEST 11:18:59 INFO - Directory to install application into. [default: 11:18:59 INFO - "/builds/slave/test"] 11:18:59 INFO - --app=APP Application being installed. [default: firefox] 11:18:59 INFO - mkdir: /builds/slave/test/build/application 11:18:59 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:59 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:16 INFO - Reading from file tmpfile_stdout 11:19:16 INFO - Output received: 11:19:16 INFO - /builds/slave/test/build/application/firefox/firefox 11:19:16 INFO - Running post-action listener: _resource_record_post_action 11:19:16 INFO - ##### 11:19:16 INFO - ##### Finished install step (success) 11:19:16 INFO - ##### 11:19:16 INFO - ##### 11:19:16 INFO - ##### Running run-tests step. 11:19:16 INFO - ##### 11:19:16 INFO - Running pre-action listener: _resource_record_pre_action 11:19:16 INFO - Running main action method: run_tests 11:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:16 INFO - Python 2.7.3 11:19:16 INFO - Return code: 0 11:19:16 INFO - grabbing minidump binary from tooltool 11:19: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:19:16 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 0x1c8b1c0>, '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 0x1c8c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:16 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:16 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:16 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:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:16 INFO - Return code: 0 11:19:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:19:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:19:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:19:17 INFO - Return code: 0 11:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:19:17 INFO - Using env: {'DISPLAY': ':0', 11:19:17 INFO - 'HOME': '/home/cltbld', 11:19:17 INFO - 'LANG': 'en_US.UTF-8', 11:19:17 INFO - 'LANGUAGE': 'en_US:en', 11:19:17 INFO - 'LOGNAME': 'cltbld', 11:19:17 INFO - 'MAIL': '/var/mail/cltbld', 11:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:17 INFO - 'MOZ_NO_REMOTE': '1', 11:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:17 INFO - 'NO_EM_RESTART': '1', 11:19:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:17 INFO - 'PWD': '/builds/slave/test', 11:19:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:17 INFO - 'SHELL': '/bin/bash', 11:19:17 INFO - 'SHLVL': '1', 11:19:17 INFO - 'TERM': 'linux', 11:19:17 INFO - 'TMOUT': '86400', 11:19:17 INFO - 'USER': 'cltbld', 11:19:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889', 11:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:17 INFO - '_': '/tools/buildbot/bin/python'} 11:19:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M_1zSSGPRAuHpBlKbeeI5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:19:17 INFO - mozversion application_buildid: 20160615083055 11:19:17 INFO - mozversion application_changeset: 153553aecf160632bbcb50906ba135511da138e6 11:19:17 INFO - mozversion application_display_name: Nightly 11:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:17 INFO - mozversion application_name: Firefox 11:19:17 INFO - mozversion application_remotingname: firefox 11:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:19:17 INFO - mozversion application_vendor: Mozilla 11:19:17 INFO - mozversion application_version: 50.0a1 11:19:17 INFO - mozversion platform_buildid: 20160615083055 11:19:17 INFO - mozversion platform_changeset: 153553aecf160632bbcb50906ba135511da138e6 11:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:19:17 INFO - mozversion platform_version: 50.0a1 11:19:17 INFO - using testdate: 1466014757 11:19:17 INFO - actual date: 1466014757 11:19:17 INFO - starting webserver on 'localhost:39814' 11:19:17 INFO - SUITE-START | Running 2 tests 11:19:17 INFO - TEST-START | dromaeo_css 11:19:17 INFO - operating with platform_type : linux_ 11:19:17 INFO - Initialising browser for dromaeo_css test... 11:19:17 INFO - TEST-INFO | started process 4270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSbgeaH/profile http://localhost:39814/getInfo.html) 11:19:22 INFO - PROCESS | 4270 | __metrics Screen width/height:1600/1200 11:19:22 INFO - PROCESS | 4270 | colorDepth:24 11:19:22 INFO - PROCESS | 4270 | Browser inner width/height: 1024/697 11:19:22 INFO - PROCESS | 4270 | __metrics 11:19:22 ERROR - PROCESS | 4270 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:19:23 INFO - TEST-INFO | 4270: exit 0 11:19:23 INFO - Browser initialized. 11:19:23 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:23 INFO - TEST-INFO | started process 4388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSbgeaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:35 INFO - PROCESS | 4388 | RSS: Main: 185495552 11:19:35 INFO - PROCESS | 4388 | 11:20:25 INFO - PROCESS | 4388 | 1466014825339 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:33 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:39814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39814/tests/dromaeo/cssquery-ext.html) 11:22:34 INFO - PROCESS | 4388 | RSS: Main: 188502016 11:22:34 INFO - PROCESS | 4388 | 11:25:36 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:39814/tests/dromaeo/cssquery-ext.html (next: http://localhost:39814/tests/dromaeo/cssquery-jquery.html) 11:25:37 INFO - PROCESS | 4388 | RSS: Main: 187613184 11:25:37 INFO - PROCESS | 4388 | 11:28:39 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:39814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39814/tests/dromaeo/cssquery-mootools.html) 11:28:39 INFO - PROCESS | 4388 | RSS: Main: 188989440 11:28:39 INFO - PROCESS | 4388 | 11:31:41 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:39814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39814/tests/dromaeo/cssquery-prototype.html) 11:31:42 INFO - PROCESS | 4388 | RSS: Main: 186658816 11:31:42 INFO - PROCESS | 4388 | 11:34:44 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:39814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39814/tests/dromaeo/cssquery-yui.html) 11:34:45 INFO - PROCESS | 4388 | RSS: Main: 189198336 11:34:45 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | Cycle 1(1): loaded http://localhost:39814/tests/dromaeo/cssquery-yui.html (next: http://localhost:39814/tests/dromaeo/cssquery-dojo.html) 11:37:47 INFO - PROCESS | 4388 | RSS: Main: 189661184 11:37:47 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | __start_tp_report 11:37:47 INFO - PROCESS | 4388 | _x_x_mozilla_page_load 11:37:47 INFO - PROCESS | 4388 | _x_x_mozilla_page_load_details 11:37:47 INFO - PROCESS | 4388 | |i|pagename|runs| 11:37:47 INFO - PROCESS | 4388 | |0;dojo.html;3132.8120312781234;3181.904542863712;3186.649468558459;3188.3304506053714;3197;5406.107992181285;5414.783408663654;5416.187571864218;5472.753726082326;5502.669839809614;5269.710165940872;5391.32608423947;5451.509364157225;5472.534834539059;5478.315210598676;4879.634027447938;4917.188663870457;5029.597632189416;5058.24126381044;5112.642115051948;774.341207394676;4923.803047878098;4980.053789779949;5011;5024.84925452237;4900.8774780630765;4933.679310844784;4934.55588996992;4948.628852836034;4991.900161996739;4871.36672232611;4953.23224900141;4959.082569724576;4976.129177393977;5011.924821127686;4828.613710903154;4831.516848315176;4837.467878533358;4859.416869975626;4866.780994855205;5330.786768529254;5398.8586238692;5428.972855135738;5436.91844622331;5484.808031718911;5737.598368114233;5792.739326730307;5794.565407594448;5797.623154494944;5810.634500892287;5814.622049566807;5864.091065884794;5869.941300586982;5888.735006924699;5941.138534912457;5533.976214400309;5535.944640553583;5538.6399884008215;5550.4727050930505;5553.861153471114;5737.569682273763;5892.7642894283745;5954.612950158313;5964.254468191476;5978.222831031938;5732.971335143297;5754.769809207669;5757.136429535603;5757.366689664133;5765.423457654201;5840.649561026352;5842.328132264759;5844.824655260349;5849.151872978395;5873;5590.105583106683;5784.4504772046585;5793.768249269982;5804.564657650693;5908.438698323653;5621.606487545914;5784.161296611967;5787.450192231731;5836.9124463133085;5901.881962360729;4442;4463.5759602838325;4465.799039043251;4484.551544845554;4506.3465797459185;3922.5881282465502;3952.5454572724507;3957.445957565943;3991.880243592697;3994.6604538614542;5596.076647353222;5634.098544232985;5661.575381846378;5671.262735844396;5714.657120572779;5709.25779648643;5866.6480011199465;5924.9703751480965;5934.19888315072;5942.138389933435;5544.805931792368;5565.220869078333;5614;5625.184348269559;5660.349059858169;5112.207607820719;5119.718415487184;5121.718305493234;5134.948650513522;5192;5824.796132135355;5938.465538101592;6088.969555152196;6093.634381937098;6123.785667501616;5783.103618939155;5855.648661080349;5856.443637854397;5857.58996870215;5873.50075243592;6059.878802424015;6065.6663883486835;6070.817875463743;6078.240219972504;6080.118382834553;5554.583406244467;5730.312362516524;5744.109663002241;5747.4252574742195;5771.8557036074435;5914.556408269483;5916.615419997686;5933.465988060922;5943.524518038633;5956.731947062306;5738;5786.884262314814;5791.594588378942;5795.971020144872;5799.710014499174;5545.195946587642;5676.574256930664;5694.4590263924865;5754.251947246831;5758.62568933018;5404.135338345845;5512.586556008396;5609.943900560942;5633.267675202197;5693.089105743061;5804.65172089676;5830.329512105993;5833.300003999378;5841.269841269841;5852.707364631666;5446.509814116748;5532.778688852401;5555.472230138131;5588.41321661236;5699.829005129853 11:37:47 INFO - PROCESS | 4388 | |1;ext.html;567.6367125039975;605.1104875832527;616.7163104971713;623.4513628007353;637.9106925030495;41666.79166604167;42256.577434225685;42598.57401425985;43092;45919;44214.778926105406;44993.550064499344;45096.54903450965;45131.548684513145;45228.773856130756;9005.36962412633;9075.95462022689;9106.043865394138;9106.817863642724;9156.72529824103;8987.460752354848;9111.772205694844;9115.270778337717;9121.908780912172;9122.498262595554;9189.448633082004;9233.307501937348;9249;9250.814983700322;9254;9149.634014639407;9184.770380740469;9189.218916392081;9201.677941272057;9212;9052.366334356597;9112.81774364509;9115.635374585076;9120.954395228047;9123.452592844384;41215.1756964862;41342.37986430206;41401.585984140074;41419.585804142174;41761.164776704296;3657.3599620066384;3809.9238015239816;4034.757914525138;4339.067100573392;4374.671899607511;31831.204219894455;32422;32665.673343266502;32689.182770430692;33567.83216083929;4526.6831321807485;4531.478879928817;4539.251023581105;4572.041430401503;4652.74409907455;334847;334925;337508;337678;338040;34403.311933761186;56283.15575266374;56925.01524893301;57062.714686426305;57166.71416642973;34524.13689657779;35619.79421851994;36004.459933101025;36147.27705445876;36277.818610906776;14522.564323070324;14574.562763117123;14646.121232726071;14651.706965860836;14705.338259778335;11571.305721656727;11676.357800320893;11721.179517433698;11739.647810565697;11803.704907377385;8316.41785075039;8323.708670196515;8340.666373345119;8340.958295208606;8421.326293896474;3217.871285148615;3263.151580589064;3290.4241757692785;3294.0776582556923;3323.5347051412823;1015.9339642923334;1034.4362322534237;1044.5038606661774;1098.2696506822874;1116.6761639124725;32409.35181296361;32416.35167296688;32730.345393092004;32823.17942051468;33221.16947076294;1147.701597584634;1164.9631827673377;1174.9823752643717;1175.4710380328886;1178.7347846734417;16872.325106995828;17017;17108.401205957733;17235.74146387805;17530.386436474917;564572;566216;568816;570985;571184;59785.40214597886;59958;60096.29566669423;60156.699216504516;60288.397116029155;1305.6213698027466;1338.2438922009035;1349.5344106283317;1377.4903285784324;1382.7165431086403;30640.540391893694;30902.845485773327;31377.8431107843;31548.211294717814;32222;50756;52799.73600131975;54221;54377;54504.18243726268;525006;527250;532401;532425;533295;39177.80411097926;39405.408918866815;39899;39994.000149996486;44310.335344970495;49349.506504935925;49645.25532116949;50112.24831627601;50197;50757;41405.58594414017;42688.78655606702;42759;43442;43713;41428.79285603553;41703.58296416997;41936.1612767749;42569.787151065284;42630.78684606557;36359;40404;40647.39028914509;41480.170396592504;41771.74684759462;35883.46174807328;37403.81298093601;37596.812015939744;37816.62183378131;38663.61336386712;28883.422331552832;28987.710122899345;29191.562126568544;29306;29558 11:37:47 INFO - PROCESS | 4388 | |2;jquery.html;372.3205150600154;373.8990472572404;384.571203108534;386.4705353665475;387.3743903595692;17687.66349376858;20124.798752012477;20240.898795506;20255.189792408324;20467.590648187044;18533.721994170097;18665.533361665966;18999.715004274945;19250.61498770024;19393.515162120955;5538.141588053838;5649.23735295736;5724.742386592592;5738.081906894898;5762.193292938971;5589.357223919261;5681.687507187103;5700.629459085167;5730.570207234453;5741.397153298906;5074.619403544731;5422.4306447823;5671.432856714337;5682.6306290091015;5709;5518.91721624176;5551.306086739158;5563.582731295149;5594.8601284968;5748.7125643717645;5452.40023597404;5578.219049333056;5579.469950354751;5595.244641973322;5610.859728506779;12872.22766634005;13110.213387196798;19627.705584416246;22915.312540623807;23006.7699323008;2255.8872056397113;2267.4104732769433;2267.8299127565497;2283.897224624879;2329.429289823987;9806.411615303105;9917.851232231522;9983.051610097029;10069.647562335284;10089.09198172168;1876.6246750649789;1878.8309052185368;1878.8684792064562;1974.1072897401245;1982.0981453438794;52954;67834.66082669554;68219.65890170517;77907.6104619479;80361.59819200866;10349.223808214414;10358.171346292278;10562.155027597773;10727;10936.726581835517;14766.335514901855;14774.778378324334;14836.3323650436;14903.552893413214;14927.477538286108;7727.690892364355;8009.519428834288;8143.144969778206;8190.672373105009;8209.79475513117;7594.924050759532;7616.885746713804;7818.374530037583;8004.119546849842;8033.1163572007035;4616.307553866947;4647.883802904887;4664.416947881515;4678.76606169697;4757.833475828329;1839.3102586530051;1840.9079546022645;1889.5748456597155;1889.9055047247582;1924.1437560285538;955.3408148377736;960.7117864640719;1025.2003437318904;1053.6944286157081;1070.6092276319087;18914.81085189158;19145.712814307797;19325.164109409863;19369.322073727635;19466.610667786565;950.4059962523423;967.9128878400978;980.4852452462515;1007.8488226766044;1016.3444578246989;10540.789184216273;10916.563337466412;10944.01503864656;11009.83485247722;11050.060744836617;485544;486793;495637;499819;499934.00329983357;85034;91644.54177729202;92742.53628731813;93546;94307;1003.7189586915675;1004.7940172264668;1006.1598565197995;1015.8120747661707;1019.5972590826582;17892.731609026134;17927.820721792614;17973.910130449265;18020.18909149118;18269.634607308046;41084.79457602693;41714.58285417107;42116;42610.5738942619;43269.78365108154;57956.4204357951;58025.70987145037;59549.404505954386;60389;61065.389346107746;7433.182349941394;7789.727359542616;8146.103928567972;8425.4944703318;8647.827043459221;9657.951710241405;13977.161370317814;13985.370658320604;14333.140011599337;14333.426662933365;12155.149139560146;12247.081468890046;12282.692932676397;12325.568605098779;12499.625011249676;11376.43117844088;12222.20555663879;12431.191972521758;12440.502379905065;12637.873621264038;12495.437705303464;12590;12712.809307860574;12808.871911281141;12966.675833104247;8833.911660883567;8858.11418858109;8909.866352004854;9062.50156241413;9110.453372797389;11197.496112675111;11570.305781653127;11788.115891308358;11922.52309907594;12183.512659493876 11:37:47 INFO - PROCESS | 4388 | |3;mootools.html;1473.469550961654;1480.1637075052595;1641.4911377472984;1756.1394916490924;1758.226380392628;7384.076990376203;8082.393820463474;8132.4713893596945;8702.173293537111;8717.78205544861;8158.184181581839;8385.161483851627;8456.788580285496;8472.237498625123;8475.78810529737;2263.3323169664986;2271.1029143488313;2284.097781376355;2289.267434420986;2290.4617414907566;2253.9323820285335;2259;2292.6561015847587;2292.816574674022;2317.351141680324;2228.6545585434283;2245.404967683557;2281.1103669568797;2320.408295884547;2323.6979192704925;2264.30938563738;2273.465735552144;2281.817454603636;2284.417473544244;2293.334932869466;2246.5169988452562;2252.6170551006203;2252.662100684894;2259.6836442898007;2264.230161745015;8424.115467875847;8444.873326900102;8470.872936905951;8547.786305342353;8552.144785521461;5032.4212715537815;5106.9489305106845;5145.099607568698;5146.742662866842;5159.74201289934;3196.6323872754697;3211.973261845205;3358.0933148050135;3360.462326027824;3363.1423986883433;1080.524569189554;1090.1496832470687;1098.3903933317006;1112.232559533919;1131.5360702112177;11762.647120586396;11778.11664125194;11801.40992950349;11803.173777835555;11819.704507387298;4497.6851620386915;4502.909941801146;4585.656075794262;4587.151376995266;4604.815807367735;9936.254780891462;9936.602535898628;9948.204143668489;9955.900440995641;9964.153046990941;5135.435102138762;5148.099082660519;5157.510036546522;5170.844874653766;5192.792288308426;4141.8964525887095;4580.679352445297;4624.1676498230645;4714.528547145258;4749.4063242094735;3823.101571130782;3828;3949.763014219156;3961.286968345668;4021.6581590564547;1187.252031220343;1195.7190060335813;1207.849018872641;1213.1447329632588;1251.5619533163501;851.4082712514743;946;951.5052172870069;963.8746962894779;978.9657361992296;5659.462351076641;5747.166660834156;5765.682887441231;5847.736851841677;5849.298084229919;431.99136017279477;447.230763087489;451.2464184811373;454.4455763967954;460.1533178950747;3994.6404823565435;4048.716589838683;4083.9387409188885;4105.199486100182;4122.216778812076;10164.847527287096;10313.896861031444;10429.322094063862;10540.736481587868;10576.206784491194;10276.897231027595;10279.691609251735;10287.27989040775;10300.948495257475;10318.277720559488;7792.454528183086;7808.843823123506;7891.368690504746;7932.920670793334;7959.801004974922;5451;5594.720263986866;5699.831534535493;5702.45826646468;5724.971375143097;9393.201577865959;9672.032796720272;9699.466529340954;9750.317477776487;9756.21950243993;9440.244780417413;9731.951340243253;9761.85357219628;9825.16486098661;9859.507024648596;6959.582425054513;7624.123225829101;7637.083549974039;7685.346745526693;7815.921840781747;8432.114627964222;8435.283000944743;8435.746927592181;8438.957805210935;8451.746447606582;7366.6684999174095;7691.73086440731;7696.884546731691;7701.4608977371045;7723.7682869514;7392.815179620337;7529.435292352986;7534.434917381328;7596.734114305973;7606.429517786299;6605.933940660724;6671.166104236971;6675.198976122896;6700.4639628830555;6700.6984685688285;4769.928451073306;4821.349117869183;4886.95113048865;4897.216445368724;4916;4892.828750993698;4944.826931057396;4971.676841005323;4972.453030166751;4987.401511818605 11:37:47 INFO - PROCESS | 4388 | |4;prototype.html;316.51257064121256;318.75137392833585;319.3214419358862;319.7426072012031;320.57043561627415;5580.748866301016;5581.804636837712;5599.160125981105;5625.212470254168;5641.435856414357;5507.752151153198;5525.972370138154;5533.723313834303;5534.169874518824;5614.831555053344;4015.6787457003443;4106.958930410688;4199.55904630014;4224.281872081738;4226.387173859788;4176.331786914095;4198.475190601175;4214.936775948363;4216.810243539048;4230.809613567381;4188.371744238359;4193.832246710128;4210.263203939314;4212.389203565481;4226.175895700339;4059.7767122808086;4200.810963506649;4201.45381100455;4204.5375008749015;4217.114405974749;3654.3422184006868;3659.5608526976935;3659.652333028358;3671.8714844980564;3671.9265614687556;5330.893382132374;5335.733213339317;5370.43610420904;5372.838814835562;5383.973080134613;4729.976350118227;4790.736509491977;4840.741407234109;4881.682690625134;4893.314935908976;5676.2620859288445;5685.289338832646;5699.57253206007;5730.312362516524;5735.942640573624;4071.226466971266;4082.8979275518054;4096.201240758053;4102.620480121552;4113.128526520426;5780.9710951445395;5881.823545293648;5924.398557623513;5936.762529498815;6065.332813390523;4130.112025914383;4140.23405669952;4143.7928103594695;4159.896002599899;4173.165366926627;4157.584241575879;4193.30810416284;4198.433211516406;4205.600467955539;4213.431186789744;4563.726176429424;4808.495108013678;4818.68678535894;4819.180739274332;4859.975700121477;5791.768329266866;5818.592698511148;5821.941780582225;5822.388649191858;5900.940990590125;1426.265473281261;1429.0354011042712;1432.3196481671123;1438.2736717957573;1454.62179833242;896.2784958108786;912.3841407050214;912.7489940266347;935.8409070458039;978.280963491833;5634.802781902614;5650.378458369576;5663.207150998864;5674.290713660793;5707.543396528268;5864.589478736448;5884.823455296348;5978.461938425476;6005.759769609254;6018.548608854266;5330.680159190461;5555.555555555546;5564.527015203672;5574.494886380736;5593.776248950077;3142.6700196479496;3143.402753476832;3192.1700357906648;3197.4564324064963;3198.328351046306;5826.388229235954;6070.514358851281;6078.753855459709;6082.844259590752;6102.908456373158;6016.187814644967;6018.398160184034;6020.518358531307;6044.516438684895;6080.361562036011;6143.477804386677;6162.876742465126;6163.476104531075;6164.99637617776;6187.535934804998;5675.943240567542;5811.4479124483105;5817;5858;5885.264341957255;5809.331926828469;5869.442402971711;5873.823785286449;5890.793822216202;5894.410558944242;5882.911756323744;6060.303065147388;6102.6643534604245;6191.473724733448;6203.96898015507;4073.3889916512762;4078.225137223918;4080.510338759368;4083.7141400102896;4095.385692146202;5821.185034095315;5918.467337939606;5929.733162007634;5964.254468191476;5990.191324171181;5484.232207490874;5806.1000544915605;5814.854628634318;5817.883642327214;5870.853228669317;5788.363280039276;5793.884122317614;5820.447057529528;5823.388544202967;5842.941570584239;5498.780048798003;5574.470425309589;5700.173474846207;5725.828225153252;5768.423157684198;5802.462347478006;5830.8804789437445;5849.970750146222;5868.882622347614;5889.263842019747;5487.259220005249;5742.569307302053;5763.731978964621;5781.21953536284;5809.796657116981 11:37:47 INFO - PROCESS | 4388 | |5;yui.html;749.8912657664639;797.9321757650603;832.1886160993032;847.8897743293379;888.8000199955009;15915.761263581055;16055.116968566725;16406.589835254126;16453.917730411333;16457.34170633176;14845.331960061823;15042.699146017101;15051.397944082224;15135.924320378383;15179.241037948086;769.1116760142017;784.560646038219;822.9629666665014;833.0212000898949;834.6619619054293;816.8529664660359;823.7322870067222;826.8139668574553;827.1645637905729;828.3207769628907;854.7393045121236;856.5888373580685;858.8153546987396;860.7030574451804;861.5003298087095;856.648774002656;856.7472595584318;857.7555396711938;859.5487369131193;859.6690274244398;624.3101372982834;625.2684359299585;627.1157667688537;627.3976982097192;627.6830200748639;15696.76454853178;15713.68572628541;15755.68488630221;15763.369465221378;15784.131872746995;14162.929185354007;14488.20314882681;14635.487757928422;14660.56018319452;14685.70628587433;12100.515979360815;12122.090843186708;12173.695657608541;12221.572244971383;12632.621021369374;3850.5186851643543;3863.111484358585;3873.593272706353;3917.118648304109;3994.0613955720382;78796;79349;79402.20597794064;79722;79754.20245797526;11404.771904561861;11459.77080458386;11499.252548584482;11528.827067593993;11614.825777613343;21875.890620546794;21922.780772192073;21928.122875084817;21971.450713732283;22002.559948801256;8089.47418417801;8148.307393871587;8202.26179643835;8378.706745264008;8645.524496152771;4621.722696638212;4624.9768751156025;4684.273937539687;4729.668923175344;4745.217039188564;3805.562360328542;3999.64003239704;4002.3796311571755;4009.3585026395635;4014.8996275092773;688.0814113158989;706.2407911495163;709.6380845768695;714.8891921752032;714.8927660850914;657.3689258311979;707.3563057617544;787.1144961917843;796.9203079692101;804.6620419423739;10097.293189476666;10188.847167292497;10429.113525350278;10585.523651435704;10619.469026548797;748.46858730301;752.8983587215765;754.453021559376;759.8062494064089;781.1563511407666;4855.781489832966;5067.265246539305;5104.310918026019;5104.668196567285;5107.387113546398;73666;73787.26212737912;73972;121022;123150;65981.6700916502;111651;113728;114391.42804286092;114543;58978;59436.70281648564;97534;97613.51193244131;98619.50690246503;9148.176664100263;9497.053924371794;9549.665761698307;9576.138147566753;9662.95168524181;53290.46709532855;54598.18102728383;54763;55104.448955511536;56693.14960275517;67231.3276867225;76128;77288.61355693186;78742.60628697049;79016.20983790318;11747.530098795953;11768.176227663982;12107.455164517794;12171.33057681836;12283.815742764044;12778.105532612628;12877.484900603871;13656.248906310248;14201.360938757987;14865.702685946004;13290.734185316047;13568;13896.444142234603;14052.718945621235;14397.064190827563;13667.31663416845;13788.862111378758;14189.29053547298;14282;14321.427142914166;13473.86526134726;13885.097468664504;13892.791608125684;13925.582232533041;14105.576832695035;11330.60342887995;11385.772284554429;11389.772204555697;11573.594924177612;11910.583129590423;11617.76764464689;11685.474153662935;11939;11940.70148246266;12097.939510302393 11:37:47 INFO - PROCESS | 4388 | __end_tp_report 11:37:47 INFO - PROCESS | 4388 | __start_cc_report 11:37:47 INFO - PROCESS | 4388 | _x_x_mozilla_cycle_collect,357 11:37:47 INFO - PROCESS | 4388 | __end_cc_report 11:37:47 INFO - PROCESS | 4388 | __startTimestamp1466015867718__endTimestamp 11:37:47 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | ------- Summary: start ------- 11:37:47 INFO - PROCESS | 4388 | Number of tests: 6 11:37:47 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | [#0] dojo.html Cycles:165 Average:5403.71 Median:5660.35 stddev:716.05 (12.7%) stddev-sans-first:695.73 11:37:47 INFO - PROCESS | 4388 | Values: 3132.8 3181.9 3186.6 3188.3 3197.0 5406.1 5414.8 5416.2 5472.8 5502.7 5269.7 5391.3 5451.5 5472.5 5478.3 4879.6 4917.2 5029.6 5058.2 5112.6 774.3 4923.8 4980.1 5011.0 5024.8 4900.9 4933.7 4934.6 4948.6 4991.9 4871.4 4953.2 4959.1 4976.1 5011.9 4828.6 4831.5 4837.5 4859.4 4866.8 5330.8 5398.9 5429.0 5436.9 5484.8 5737.6 5792.7 5794.6 5797.6 5810.6 5814.6 5864.1 5869.9 5888.7 5941.1 5534.0 5535.9 5538.6 5550.5 5553.9 5737.6 5892.8 5954.6 5964.3 5978.2 5733.0 5754.8 5757.1 5757.4 5765.4 5840.6 5842.3 5844.8 5849.2 5873.0 5590.1 5784.5 5793.8 5804.6 5908.4 5621.6 5784.2 5787.5 5836.9 5901.9 4442.0 4463.6 4465.8 4484.6 4506.3 3922.6 3952.5 3957.4 3991.9 3994.7 5596.1 5634.1 5661.6 5671.3 5714.7 5709.3 5866.6 5925.0 5934.2 5942.1 5544.8 5565.2 5614.0 5625.2 5660.3 5112.2 5119.7 5121.7 5134.9 5192.0 5824.8 5938.5 6089.0 6093.6 6123.8 5783.1 5855.6 5856.4 5857.6 5873.5 6059.9 6065.7 6070.8 6078.2 6080.1 5554.6 5730.3 5744.1 5747.4 5771.9 5914.6 5916.6 5933.5 5943.5 5956.7 5738.0 5786.9 5791.6 5796.0 5799.7 5545.2 5676.6 5694.5 5754.3 5758.6 5404.1 5512.6 5609.9 5633.3 5693.1 5804.7 5830.3 5833.3 5841.3 5852.7 5446.5 5532.8 5555.5 5588.4 5699.8 11:37:47 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | [#1] ext.html Cycles:180 Average:62735.78 Median:41766.46 stddev:130288.94 (311.9%) stddev-sans-first:130570.82 11:37:47 INFO - PROCESS | 4388 | Values: 567.6 605.1 616.7 623.5 637.9 41666.8 42256.6 42598.6 43092.0 45919.0 44214.8 44993.6 45096.5 45131.5 45228.8 9005.4 9076.0 9106.0 9106.8 9156.7 8987.5 9111.8 9115.3 9121.9 9122.5 9189.4 9233.3 9249.0 9250.8 9254.0 9149.6 9184.8 9189.2 9201.7 9212.0 9052.4 9112.8 9115.6 9121.0 9123.5 41215.2 41342.4 41401.6 41419.6 41761.2 3657.4 3809.9 4034.8 4339.1 4374.7 31831.2 32422.0 32665.7 32689.2 33567.8 4526.7 4531.5 4539.3 4572.0 4652.7 334847.0 334925.0 337508.0 337678.0 338040.0 34403.3 56283.2 56925.0 57062.7 57166.7 34524.1 35619.8 36004.5 36147.3 36277.8 14522.6 14574.6 14646.1 14651.7 14705.3 11571.3 11676.4 11721.2 11739.6 11803.7 8316.4 8323.7 8340.7 8341.0 8421.3 3217.9 3263.2 3290.4 3294.1 3323.5 1015.9 1034.4 1044.5 1098.3 1116.7 32409.4 32416.4 32730.3 32823.2 33221.2 1147.7 1165.0 1175.0 1175.5 1178.7 16872.3 17017.0 17108.4 17235.7 17530.4 564572.0 566216.0 568816.0 570985.0 571184.0 59785.4 59958.0 60096.3 60156.7 60288.4 1305.6 1338.2 1349.5 1377.5 1382.7 30640.5 30902.8 31377.8 31548.2 32222.0 50756.0 52799.7 54221.0 54377.0 54504.2 525006.0 527250.0 532401.0 532425.0 533295.0 39177.8 39405.4 39899.0 39994.0 44310.3 49349.5 49645.3 50112.2 50197.0 50757.0 41405.6 42688.8 42759.0 43442.0 43713.0 41428.8 41703.6 41936.2 42569.8 42630.8 36359.0 40404.0 40647.4 41480.2 41771.7 35883.5 37403.8 37596.8 37816.6 38663.6 28883.4 28987.7 29191.6 29306.0 29558.0 11:37:47 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | [#2] jquery.html Cycles:180 Average:28719.95 Median:1350.87 stddev:81214.62 (6012.0%) stddev-sans-first:81414.55 11:37:47 INFO - PROCESS | 4388 | Values: 372.3 373.9 384.6 386.5 387.4 17687.7 20124.8 20240.9 20255.2 20467.6 18533.7 18665.5 18999.7 19250.6 19393.5 5538.1 5649.2 5724.7 5738.1 5762.2 5589.4 5681.7 5700.6 5730.6 5741.4 5074.6 5422.4 5671.4 5682.6 5709.0 5518.9 5551.3 5563.6 5594.9 5748.7 5452.4 5578.2 5579.5 5595.2 5610.9 12872.2 13110.2 19627.7 22915.3 23006.8 2255.9 2267.4 2267.8 2283.9 2329.4 9806.4 9917.9 9983.1 10069.6 10089.1 1876.6 1878.8 1878.9 1974.1 1982.1 52954.0 67834.7 68219.7 77907.6 80361.6 10349.2 10358.2 10562.2 10727.0 10936.7 14766.3 14774.8 14836.3 14903.6 14927.5 7727.7 8009.5 8143.1 8190.7 8209.8 7594.9 7616.9 7818.4 8004.1 8033.1 4616.3 4647.9 4664.4 4678.8 4757.8 1839.3 1840.9 1889.6 1889.9 1924.1 955.3 960.7 1025.2 1053.7 1070.6 18914.8 19145.7 19325.2 19369.3 19466.6 950.4 967.9 980.5 1007.8 1016.3 10540.8 10916.6 10944.0 11009.8 11050.1 485544.0 486793.0 495637.0 499819.0 499934.0 85034.0 91644.5 92742.5 93546.0 94307.0 1003.7 1004.8 1006.2 1015.8 1019.6 17892.7 17927.8 17973.9 18020.2 18269.6 41084.8 41714.6 42116.0 42610.6 43269.8 57956.4 58025.7 59549.4 60389.0 61065.4 7433.2 7789.7 8146.1 8425.5 8647.8 9658.0 13977.2 13985.4 14333.1 14333.4 12155.1 12247.1 12282.7 12325.6 12499.6 11376.4 12222.2 12431.2 12440.5 12637.9 12495.4 12590.0 12712.8 12808.9 12966.7 8833.9 8858.1 8909.9 9062.5 9110.5 11197.5 11570.3 11788.1 11922.5 12183.5 11:37:47 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | [#3] mootools.html Cycles:180 Average:5588.91 Median:4930.41 stddev:3163.21 (64.2%) stddev-sans-first:3156.96 11:37:47 INFO - PROCESS | 4388 | Values: 1473.5 1480.2 1641.5 1756.1 1758.2 7384.1 8082.4 8132.5 8702.2 8717.8 8158.2 8385.2 8456.8 8472.2 8475.8 2263.3 2271.1 2284.1 2289.3 2290.5 2253.9 2259.0 2292.7 2292.8 2317.4 2228.7 2245.4 2281.1 2320.4 2323.7 2264.3 2273.5 2281.8 2284.4 2293.3 2246.5 2252.6 2252.7 2259.7 2264.2 8424.1 8444.9 8470.9 8547.8 8552.1 5032.4 5106.9 5145.1 5146.7 5159.7 3196.6 3212.0 3358.1 3360.5 3363.1 1080.5 1090.1 1098.4 1112.2 1131.5 11762.6 11778.1 11801.4 11803.2 11819.7 4497.7 4502.9 4585.7 4587.2 4604.8 9936.3 9936.6 9948.2 9955.9 9964.2 5135.4 5148.1 5157.5 5170.8 5192.8 4141.9 4580.7 4624.2 4714.5 4749.4 3823.1 3828.0 3949.8 3961.3 4021.7 1187.3 1195.7 1207.8 1213.1 1251.6 851.4 946.0 951.5 963.9 979.0 5659.5 5747.2 5765.7 5847.7 5849.3 432.0 447.2 451.2 454.4 460.2 3994.6 4048.7 4083.9 4105.2 4122.2 10164.8 10313.9 10429.3 10540.7 10576.2 10276.9 10279.7 10287.3 10300.9 10318.3 7792.5 7808.8 7891.4 7932.9 7959.8 5451.0 5594.7 5699.8 5702.5 5725.0 9393.2 9672.0 9699.5 9750.3 9756.2 9440.2 9732.0 9761.9 9825.2 9859.5 6959.6 7624.1 7637.1 7685.3 7815.9 8432.1 8435.3 8435.7 8439.0 8451.7 7366.7 7691.7 7696.9 7701.5 7723.8 7392.8 7529.4 7534.4 7596.7 7606.4 6605.9 6671.2 6675.2 6700.5 6700.7 4769.9 4821.3 4887.0 4897.2 4916.0 4892.8 4944.8 4971.7 4972.5 4987.4 11:37:47 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | [#4] prototype.html Cycles:180 Average:4838.95 Median:5607.00 stddev:1452.93 (25.9%) stddev-sans-first:1416.80 11:37:47 INFO - PROCESS | 4388 | Values: 316.5 318.8 319.3 319.7 320.6 5580.7 5581.8 5599.2 5625.2 5641.4 5507.8 5526.0 5533.7 5534.2 5614.8 4015.7 4107.0 4199.6 4224.3 4226.4 4176.3 4198.5 4214.9 4216.8 4230.8 4188.4 4193.8 4210.3 4212.4 4226.2 4059.8 4200.8 4201.5 4204.5 4217.1 3654.3 3659.6 3659.7 3671.9 3671.9 5330.9 5335.7 5370.4 5372.8 5384.0 4730.0 4790.7 4840.7 4881.7 4893.3 5676.3 5685.3 5699.6 5730.3 5735.9 4071.2 4082.9 4096.2 4102.6 4113.1 5781.0 5881.8 5924.4 5936.8 6065.3 4130.1 4140.2 4143.8 4159.9 4173.2 4157.6 4193.3 4198.4 4205.6 4213.4 4563.7 4808.5 4818.7 4819.2 4860.0 5791.8 5818.6 5821.9 5822.4 5900.9 1426.3 1429.0 1432.3 1438.3 1454.6 896.3 912.4 912.7 935.8 978.3 5634.8 5650.4 5663.2 5674.3 5707.5 5864.6 5884.8 5978.5 6005.8 6018.5 5330.7 5555.6 5564.5 5574.5 5593.8 3142.7 3143.4 3192.2 3197.5 3198.3 5826.4 6070.5 6078.8 6082.8 6102.9 6016.2 6018.4 6020.5 6044.5 6080.4 6143.5 6162.9 6163.5 6165.0 6187.5 5675.9 5811.4 5817.0 5858.0 5885.3 5809.3 5869.4 5873.8 5890.8 5894.4 5882.9 6060.3 6102.7 6191.5 6204.0 4073.4 4078.2 4080.5 4083.7 4095.4 5821.2 5918.5 5929.7 5964.3 5990.2 5484.2 5806.1 5814.9 5817.9 5870.9 5788.4 5793.9 5820.4 5823.4 5842.9 5498.8 5574.5 5700.2 5725.8 5768.4 5802.5 5830.9 5850.0 5868.9 5889.3 5487.3 5742.6 5763.7 5781.2 5809.8 11:37:47 INFO - PROCESS | 4388 | 11:37:47 INFO - PROCESS | 4388 | [#5] yui.html Cycles:180 Average:20568.02 Median:4318.31 stddev:29267.44 (677.8%) stddev-sans-first:29311.71 11:37:47 INFO - PROCESS | 4388 | Values: 749.9 797.9 832.2 847.9 888.8 15915.8 16055.1 16406.6 16453.9 16457.3 14845.3 15042.7 15051.4 15135.9 15179.2 769.1 784.6 823.0 833.0 834.7 816.9 823.7 826.8 827.2 828.3 854.7 856.6 858.8 860.7 861.5 856.6 856.7 857.8 859.5 859.7 624.3 625.3 627.1 627.4 627.7 15696.8 15713.7 15755.7 15763.4 15784.1 14162.9 14488.2 14635.5 14660.6 14685.7 12100.5 12122.1 12173.7 12221.6 12632.6 3850.5 3863.1 3873.6 3917.1 3994.1 78796.0 79349.0 79402.2 79722.0 79754.2 11404.8 11459.8 11499.3 11528.8 11614.8 21875.9 21922.8 21928.1 21971.5 22002.6 8089.5 8148.3 8202.3 8378.7 8645.5 4621.7 4625.0 4684.3 4729.7 4745.2 3805.6 3999.6 4002.4 4009.4 4014.9 688.1 706.2 709.6 714.9 714.9 657.4 707.4 787.1 796.9 804.7 10097.3 10188.8 10429.1 10585.5 10619.5 748.5 752.9 754.5 759.8 781.2 4855.8 5067.3 5104.3 5104.7 5107.4 73666.0 73787.3 73972.0 121022.0 123150.0 65981.7 111651.0 113728.0 114391.4 114543.0 58978.0 59436.7 97534.0 97613.5 98619.5 9148.2 9497.1 9549.7 9576.1 9663.0 53290.5 54598.2 54763.0 55104.4 56693.1 67231.3 76128.0 77288.6 78742.6 79016.2 11747.5 11768.2 12107.5 12171.3 12283.8 12778.1 12877.5 13656.2 14201.4 14865.7 13290.7 13568.0 13896.4 14052.7 14397.1 13667.3 13788.9 14189.3 14282.0 14321.4 13473.9 13885.1 13892.8 13925.6 14105.6 11330.6 11385.8 11389.8 11573.6 11910.6 11617.8 11685.5 11939.0 11940.7 12097.9 11:37:47 INFO - PROCESS | 4388 | -------- Summary: end -------- 11:37:47 INFO - PROCESS | 4388 | 11:37:48 INFO - TEST-INFO | 4388: exit 0 11:37:48 INFO - TEST-OK | dromaeo_css | took 1110931ms 11:37:48 INFO - TEST-START | kraken 11:37:48 INFO - operating with platform_type : linux_ 11:37:48 INFO - Initialising browser for kraken test... 11:37:48 INFO - TEST-INFO | started process 4622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnPN15/profile http://localhost:39814/getInfo.html) 11:37:53 INFO - PROCESS | 4622 | __metrics Screen width/height:1600/1200 11:37:53 INFO - PROCESS | 4622 | colorDepth:24 11:37:53 INFO - PROCESS | 4622 | Browser inner width/height: 1024/697 11:37:53 INFO - PROCESS | 4622 | __metrics 11:37:53 ERROR - PROCESS | 4622 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:37:54 INFO - TEST-INFO | 4622: exit 0 11:37:54 INFO - Browser initialized. 11:37:54 INFO - Running cycle 1/1 for kraken test... 11:37:54 INFO - TEST-INFO | started process 4742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnPN15/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:06 INFO - PROCESS | 4742 | RSS: Main: 185036800 11:38:06 INFO - PROCESS | 4742 | 11:38:09 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39814/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:10 INFO - PROCESS | 4742 | RSS: Main: 191053824 11:38:10 INFO - PROCESS | 4742 | 11:38:12 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39814/tests/kraken/driver.html?testName=audio-dft) 11:38:13 INFO - PROCESS | 4742 | RSS: Main: 190586880 11:38:13 INFO - PROCESS | 4742 | 11:38:16 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39814/tests/kraken/driver.html?testName=audio-fft) 11:38:16 INFO - PROCESS | 4742 | RSS: Main: 185929728 11:38:16 INFO - PROCESS | 4742 | 11:38:18 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39814/tests/kraken/driver.html?testName=audio-oscillator) 11:38:19 INFO - PROCESS | 4742 | RSS: Main: 186015744 11:38:19 INFO - PROCESS | 4742 | 11:38:21 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:22 INFO - PROCESS | 4742 | RSS: Main: 186101760 11:38:22 INFO - PROCESS | 4742 | 11:38:25 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39814/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:26 INFO - PROCESS | 4742 | RSS: Main: 185618432 11:38:26 INFO - PROCESS | 4742 | 11:38:29 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39814/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:30 INFO - PROCESS | 4742 | RSS: Main: 184242176 11:38:30 INFO - PROCESS | 4742 | 11:38:32 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39814/tests/kraken/driver.html?testName=json-parse-financial) 11:38:33 INFO - PROCESS | 4742 | RSS: Main: 185188352 11:38:33 INFO - PROCESS | 4742 | 11:38:35 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:35 INFO - PROCESS | 4742 | RSS: Main: 185880576 11:38:35 INFO - PROCESS | 4742 | 11:38:37 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39814/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:38 INFO - PROCESS | 4742 | RSS: Main: 186515456 11:38:38 INFO - PROCESS | 4742 | 11:38:40 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:40 INFO - PROCESS | 4742 | RSS: Main: 186785792 11:38:40 INFO - PROCESS | 4742 | 11:38:43 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:44 INFO - PROCESS | 4742 | RSS: Main: 187088896 11:38:44 INFO - PROCESS | 4742 | 11:38:46 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:47 INFO - PROCESS | 4742 | RSS: Main: 186773504 11:38:47 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | Cycle 1(1): loaded http://localhost:39814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39814/tests/kraken/driver.html?testName=ai-astar) 11:38:49 INFO - PROCESS | 4742 | RSS: Main: 187596800 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | __start_tp_report 11:38:49 INFO - PROCESS | 4742 | _x_x_mozilla_page_load 11:38:49 INFO - PROCESS | 4742 | _x_x_mozilla_page_load_details 11:38:49 INFO - PROCESS | 4742 | |i|pagename|runs| 11:38:49 INFO - PROCESS | 4742 | |0;ai-astar;111;107;110;109;111;110;110;110;111;110 11:38:49 INFO - PROCESS | 4742 | |1;audio-beat-detection;154;127;152;191;135;151;151;133;193;124 11:38:49 INFO - PROCESS | 4742 | |2;audio-dft;162;163;161;162;169;174;160;161;161;164 11:38:49 INFO - PROCESS | 4742 | |3;audio-fft;74;74;76;156;75;75;76;75;179;75 11:38:49 INFO - PROCESS | 4742 | |4;audio-oscillator;85;85;153;85;86;86;136;86;87;141 11:38:49 INFO - PROCESS | 4742 | |5;imaging-gaussian-blur;118;118;118;118;119;117;117;118;118;118 11:38:49 INFO - PROCESS | 4742 | |6;imaging-darkroom;147;149;148;151;146;146;147;147;147;147 11:38:49 INFO - PROCESS | 4742 | |7;imaging-desaturate;95;96;95;95;96;96;97;96;96;96 11:38:49 INFO - PROCESS | 4742 | |8;json-parse-financial;53;55;54;56;55;54;56;53;64;54 11:38:49 INFO - PROCESS | 4742 | |9;json-stringify-tinderbox;61;65;62;60;61;61;60;61;61;61 11:38:49 INFO - PROCESS | 4742 | |10;stanford-crypto-aes;85;80;81;80;82;86;81;80;102;83 11:38:49 INFO - PROCESS | 4742 | |11;stanford-crypto-ccm;122;137;129;121;122;119;134;124;125;122 11:38:49 INFO - PROCESS | 4742 | |12;stanford-crypto-pbkdf2;166;171;171;168;163;167;163;166;165;165 11:38:49 INFO - PROCESS | 4742 | |13;stanford-crypto-sha256-iterative;64;64;68;64;66;62;64;67;63;67 11:38:49 INFO - PROCESS | 4742 | __end_tp_report 11:38:49 INFO - PROCESS | 4742 | __start_cc_report 11:38:49 INFO - PROCESS | 4742 | _x_x_mozilla_cycle_collect,873 11:38:49 INFO - PROCESS | 4742 | __end_cc_report 11:38:49 INFO - PROCESS | 4742 | __startTimestamp1466015929536__endTimestamp 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | ------- Summary: start ------- 11:38:49 INFO - PROCESS | 4742 | Number of tests: 14 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.20 (1.1%) stddev-sans-first:1.20 11:38:49 INFO - PROCESS | 4742 | Values: 111.0 107.0 110.0 109.0 111.0 110.0 110.0 110.0 111.0 110.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:151.50 stddev:24.17 (16.0%) stddev-sans-first:25.62 11:38:49 INFO - PROCESS | 4742 | Values: 154.0 127.0 152.0 191.0 135.0 151.0 151.0 133.0 193.0 124.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#2] audio-dft Cycles:10 Average:163.70 Median:162.50 stddev:4.42 (2.7%) stddev-sans-first:4.65 11:38:49 INFO - PROCESS | 4742 | Values: 162.0 163.0 161.0 162.0 169.0 174.0 160.0 161.0 161.0 164.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:39.38 (52.5%) stddev-sans-first:41.13 11:38:49 INFO - PROCESS | 4742 | Values: 74.0 74.0 76.0 156.0 75.0 75.0 76.0 75.0 179.0 75.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.50 stddev:28.14 (32.9%) stddev-sans-first:29.09 11:38:49 INFO - PROCESS | 4742 | Values: 85.0 85.0 153.0 85.0 86.0 86.0 136.0 86.0 87.0 141.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:38:49 INFO - PROCESS | 4742 | Values: 118.0 118.0 118.0 118.0 119.0 117.0 117.0 118.0 118.0 118.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.51 (1.0%) stddev-sans-first:1.59 11:38:49 INFO - PROCESS | 4742 | Values: 147.0 149.0 148.0 151.0 146.0 146.0 147.0 147.0 147.0 147.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 11:38:49 INFO - PROCESS | 4742 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.20 (5.8%) stddev-sans-first:3.28 11:38:49 INFO - PROCESS | 4742 | Values: 53.0 55.0 54.0 56.0 55.0 54.0 56.0 53.0 64.0 54.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:1.42 (2.3%) stddev-sans-first:1.50 11:38:49 INFO - PROCESS | 4742 | Values: 61.0 65.0 62.0 60.0 61.0 61.0 60.0 61.0 61.0 61.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.50 stddev:6.67 (8.2%) stddev-sans-first:7.06 11:38:49 INFO - PROCESS | 4742 | Values: 85.0 80.0 81.0 80.0 82.0 86.0 81.0 80.0 102.0 83.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:124.50 stddev:5.95 (4.8%) stddev-sans-first:6.17 11:38:49 INFO - PROCESS | 4742 | Values: 122.0 137.0 129.0 121.0 122.0 119.0 134.0 124.0 125.0 122.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.50 stddev:2.84 (1.7%) stddev-sans-first:3.00 11:38:49 INFO - PROCESS | 4742 | Values: 166.0 171.0 171.0 168.0 163.0 167.0 163.0 166.0 165.0 165.0 11:38:49 INFO - PROCESS | 4742 | 11:38:49 INFO - PROCESS | 4742 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.97 (3.0%) stddev-sans-first:2.06 11:38:49 INFO - PROCESS | 4742 | Values: 64.0 64.0 68.0 64.0 66.0 62.0 64.0 67.0 63.0 67.0 11:38:49 INFO - PROCESS | 4742 | -------- Summary: end -------- 11:38:49 INFO - PROCESS | 4742 | 11:38:50 INFO - TEST-INFO | 4742: exit 0 11:38:50 INFO - TEST-OK | kraken | took 62082ms 11:38:50 INFO - SUITE-END | took 1173s 11:38:50 INFO - Completed test suite (00:19:33) 11:38:50 INFO - javascript benchmark 11:38:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7215.649117699859, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.8120312781234, 3181.904542863712, 3186.649468558459, 3188.3304506053714, 3197.0, 5406.107992181285, 5414.783408663654, 5416.187571864218, 5472.753726082326, 5502.669839809614, 5269.710165940872, 5391.32608423947, 5451.509364157225, 5472.534834539059, 5478.315210598676, 4879.634027447938, 4917.188663870457, 5029.597632189416, 5058.24126381044, 5112.642115051948, 774.341207394676, 4923.803047878098, 4980.053789779949, 5011.0, 5024.84925452237, 4900.8774780630765, 4933.679310844784, 4934.55588996992, 4948.628852836034, 4991.900161996739, 4871.36672232611, 4953.23224900141, 4959.082569724576, 4976.129177393977, 5011.924821127686, 4828.613710903154, 4831.516848315176, 4837.467878533358, 4859.416869975626, 4866.780994855205, 5330.786768529254, 5398.8586238692, 5428.972855135738, 5436.91844622331, 5484.808031718911, 5737.598368114233, 5792.739326730307, 5794.565407594448, 5797.623154494944, 5810.634500892287, 5814.622049566807, 5864.091065884794, 5869.941300586982, 5888.735006924699, 5941.138534912457, 5533.976214400309, 5535.944640553583, 5538.6399884008215, 5550.4727050930505, 5553.861153471114, 5737.569682273763, 5892.7642894283745, 5954.612950158313, 5964.254468191476, 5978.222831031938, 5732.971335143297, 5754.769809207669, 5757.136429535603, 5757.366689664133, 5765.423457654201, 5840.649561026352, 5842.328132264759, 5844.824655260349, 5849.151872978395, 5873.0, 5590.105583106683, 5784.4504772046585, 5793.768249269982, 5804.564657650693, 5908.438698323653, 5621.606487545914, 5784.161296611967, 5787.450192231731, 5836.9124463133085, 5901.881962360729, 4442.0, 4463.5759602838325, 4465.799039043251, 4484.551544845554, 4506.3465797459185, 3922.5881282465502, 3952.5454572724507, 3957.445957565943, 3991.880243592697, 3994.6604538614542, 5596.076647353222, 5634.098544232985, 5661.575381846378, 5671.262735844396, 5714.657120572779, 5709.25779648643, 5866.6480011199465, 5924.9703751480965, 5934.19888315072, 5942.138389933435, 5544.805931792368, 5565.220869078333, 5614.0, 5625.184348269559, 5660.349059858169, 5112.207607820719, 5119.718415487184, 5121.718305493234, 5134.948650513522, 5192.0, 5824.796132135355, 5938.465538101592, 6088.969555152196, 6093.634381937098, 6123.785667501616, 5783.103618939155, 5855.648661080349, 5856.443637854397, 5857.58996870215, 5873.50075243592, 6059.878802424015, 6065.6663883486835, 6070.817875463743, 6078.240219972504, 6080.118382834553, 5554.583406244467, 5730.312362516524, 5744.109663002241, 5747.4252574742195, 5771.8557036074435, 5914.556408269483, 5916.615419997686, 5933.465988060922, 5943.524518038633, 5956.731947062306, 5738.0, 5786.884262314814, 5791.594588378942, 5795.971020144872, 5799.710014499174, 5545.195946587642, 5676.574256930664, 5694.4590263924865, 5754.251947246831, 5758.62568933018, 5404.135338345845, 5512.586556008396, 5609.943900560942, 5633.267675202197, 5693.089105743061, 5804.65172089676, 5830.329512105993, 5833.300003999378, 5841.269841269841, 5852.707364631666, 5446.509814116748, 5532.778688852401, 5555.472230138131, 5588.41321661236, 5699.829005129853], "value": 5357.329964960465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6367125039975, 605.1104875832527, 616.7163104971713, 623.4513628007353, 637.9106925030495, 41666.79166604167, 42256.577434225685, 42598.57401425985, 43092.0, 45919.0, 44214.778926105406, 44993.550064499344, 45096.54903450965, 45131.548684513145, 45228.773856130756, 9005.36962412633, 9075.95462022689, 9106.043865394138, 9106.817863642724, 9156.72529824103, 8987.460752354848, 9111.772205694844, 9115.270778337717, 9121.908780912172, 9122.498262595554, 9189.448633082004, 9233.307501937348, 9249.0, 9250.814983700322, 9254.0, 9149.634014639407, 9184.770380740469, 9189.218916392081, 9201.677941272057, 9212.0, 9052.366334356597, 9112.81774364509, 9115.635374585076, 9120.954395228047, 9123.452592844384, 41215.1756964862, 41342.37986430206, 41401.585984140074, 41419.585804142174, 41761.164776704296, 3657.3599620066384, 3809.9238015239816, 4034.757914525138, 4339.067100573392, 4374.671899607511, 31831.204219894455, 32422.0, 32665.673343266502, 32689.182770430692, 33567.83216083929, 4526.6831321807485, 4531.478879928817, 4539.251023581105, 4572.041430401503, 4652.74409907455, 334847.0, 334925.0, 337508.0, 337678.0, 338040.0, 34403.311933761186, 56283.15575266374, 56925.01524893301, 57062.714686426305, 57166.71416642973, 34524.13689657779, 35619.79421851994, 36004.459933101025, 36147.27705445876, 36277.818610906776, 14522.564323070324, 14574.562763117123, 14646.121232726071, 14651.706965860836, 14705.338259778335, 11571.305721656727, 11676.357800320893, 11721.179517433698, 11739.647810565697, 11803.704907377385, 8316.41785075039, 8323.708670196515, 8340.666373345119, 8340.958295208606, 8421.326293896474, 3217.871285148615, 3263.151580589064, 3290.4241757692785, 3294.0776582556923, 3323.5347051412823, 1015.9339642923334, 1034.4362322534237, 1044.5038606661774, 1098.2696506822874, 1116.6761639124725, 32409.35181296361, 32416.35167296688, 32730.345393092004, 32823.17942051468, 33221.16947076294, 1147.701597584634, 1164.9631827673377, 1174.9823752643717, 1175.4710380328886, 1178.7347846734417, 16872.325106995828, 17017.0, 17108.401205957733, 17235.74146387805, 17530.386436474917, 564572.0, 566216.0, 568816.0, 570985.0, 571184.0, 59785.40214597886, 59958.0, 60096.29566669423, 60156.699216504516, 60288.397116029155, 1305.6213698027466, 1338.2438922009035, 1349.5344106283317, 1377.4903285784324, 1382.7165431086403, 30640.540391893694, 30902.845485773327, 31377.8431107843, 31548.211294717814, 32222.0, 50756.0, 52799.73600131975, 54221.0, 54377.0, 54504.18243726268, 525006.0, 527250.0, 532401.0, 532425.0, 533295.0, 39177.80411097926, 39405.408918866815, 39899.0, 39994.000149996486, 44310.335344970495, 49349.506504935925, 49645.25532116949, 50112.24831627601, 50197.0, 50757.0, 41405.58594414017, 42688.78655606702, 42759.0, 43442.0, 43713.0, 41428.79285603553, 41703.58296416997, 41936.1612767749, 42569.787151065284, 42630.78684606557, 36359.0, 40404.0, 40647.39028914509, 41480.170396592504, 41771.74684759462, 35883.46174807328, 37403.81298093601, 37596.812015939744, 37816.62183378131, 38663.61336386712, 28883.422331552832, 28987.710122899345, 29191.562126568544, 29306.0, 29558.0], "value": 19454.762579460956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.3205150600154, 373.8990472572404, 384.571203108534, 386.4705353665475, 387.3743903595692, 17687.66349376858, 20124.798752012477, 20240.898795506, 20255.189792408324, 20467.590648187044, 18533.721994170097, 18665.533361665966, 18999.715004274945, 19250.61498770024, 19393.515162120955, 5538.141588053838, 5649.23735295736, 5724.742386592592, 5738.081906894898, 5762.193292938971, 5589.357223919261, 5681.687507187103, 5700.629459085167, 5730.570207234453, 5741.397153298906, 5074.619403544731, 5422.4306447823, 5671.432856714337, 5682.6306290091015, 5709.0, 5518.91721624176, 5551.306086739158, 5563.582731295149, 5594.8601284968, 5748.7125643717645, 5452.40023597404, 5578.219049333056, 5579.469950354751, 5595.244641973322, 5610.859728506779, 12872.22766634005, 13110.213387196798, 19627.705584416246, 22915.312540623807, 23006.7699323008, 2255.8872056397113, 2267.4104732769433, 2267.8299127565497, 2283.897224624879, 2329.429289823987, 9806.411615303105, 9917.851232231522, 9983.051610097029, 10069.647562335284, 10089.09198172168, 1876.6246750649789, 1878.8309052185368, 1878.8684792064562, 1974.1072897401245, 1982.0981453438794, 52954.0, 67834.66082669554, 68219.65890170517, 77907.6104619479, 80361.59819200866, 10349.223808214414, 10358.171346292278, 10562.155027597773, 10727.0, 10936.726581835517, 14766.335514901855, 14774.778378324334, 14836.3323650436, 14903.552893413214, 14927.477538286108, 7727.690892364355, 8009.519428834288, 8143.144969778206, 8190.672373105009, 8209.79475513117, 7594.924050759532, 7616.885746713804, 7818.374530037583, 8004.119546849842, 8033.1163572007035, 4616.307553866947, 4647.883802904887, 4664.416947881515, 4678.76606169697, 4757.833475828329, 1839.3102586530051, 1840.9079546022645, 1889.5748456597155, 1889.9055047247582, 1924.1437560285538, 955.3408148377736, 960.7117864640719, 1025.2003437318904, 1053.6944286157081, 1070.6092276319087, 18914.81085189158, 19145.712814307797, 19325.164109409863, 19369.322073727635, 19466.610667786565, 950.4059962523423, 967.9128878400978, 980.4852452462515, 1007.8488226766044, 1016.3444578246989, 10540.789184216273, 10916.563337466412, 10944.01503864656, 11009.83485247722, 11050.060744836617, 485544.0, 486793.0, 495637.0, 499819.0, 499934.00329983357, 85034.0, 91644.54177729202, 92742.53628731813, 93546.0, 94307.0, 1003.7189586915675, 1004.7940172264668, 1006.1598565197995, 1015.8120747661707, 1019.5972590826582, 17892.731609026134, 17927.820721792614, 17973.910130449265, 18020.18909149118, 18269.634607308046, 41084.79457602693, 41714.58285417107, 42116.0, 42610.5738942619, 43269.78365108154, 57956.4204357951, 58025.70987145037, 59549.404505954386, 60389.0, 61065.389346107746, 7433.182349941394, 7789.727359542616, 8146.103928567972, 8425.4944703318, 8647.827043459221, 9657.951710241405, 13977.161370317814, 13985.370658320604, 14333.140011599337, 14333.426662933365, 12155.149139560146, 12247.081468890046, 12282.692932676397, 12325.568605098779, 12499.625011249676, 11376.43117844088, 12222.20555663879, 12431.191972521758, 12440.502379905065, 12637.873621264038, 12495.437705303464, 12590.0, 12712.809307860574, 12808.871911281141, 12966.675833104247, 8833.911660883567, 8858.11418858109, 8909.866352004854, 9062.50156241413, 9110.453372797389, 11197.496112675111, 11570.305781653127, 11788.115891308358, 11922.52309907594, 12183.512659493876], "value": 9114.39250447576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.469550961654, 1480.1637075052595, 1641.4911377472984, 1756.1394916490924, 1758.226380392628, 7384.076990376203, 8082.393820463474, 8132.4713893596945, 8702.173293537111, 8717.78205544861, 8158.184181581839, 8385.161483851627, 8456.788580285496, 8472.237498625123, 8475.78810529737, 2263.3323169664986, 2271.1029143488313, 2284.097781376355, 2289.267434420986, 2290.4617414907566, 2253.9323820285335, 2259.0, 2292.6561015847587, 2292.816574674022, 2317.351141680324, 2228.6545585434283, 2245.404967683557, 2281.1103669568797, 2320.408295884547, 2323.6979192704925, 2264.30938563738, 2273.465735552144, 2281.817454603636, 2284.417473544244, 2293.334932869466, 2246.5169988452562, 2252.6170551006203, 2252.662100684894, 2259.6836442898007, 2264.230161745015, 8424.115467875847, 8444.873326900102, 8470.872936905951, 8547.786305342353, 8552.144785521461, 5032.4212715537815, 5106.9489305106845, 5145.099607568698, 5146.742662866842, 5159.74201289934, 3196.6323872754697, 3211.973261845205, 3358.0933148050135, 3360.462326027824, 3363.1423986883433, 1080.524569189554, 1090.1496832470687, 1098.3903933317006, 1112.232559533919, 1131.5360702112177, 11762.647120586396, 11778.11664125194, 11801.40992950349, 11803.173777835555, 11819.704507387298, 4497.6851620386915, 4502.909941801146, 4585.656075794262, 4587.151376995266, 4604.815807367735, 9936.254780891462, 9936.602535898628, 9948.204143668489, 9955.900440995641, 9964.153046990941, 5135.435102138762, 5148.099082660519, 5157.510036546522, 5170.844874653766, 5192.792288308426, 4141.8964525887095, 4580.679352445297, 4624.1676498230645, 4714.528547145258, 4749.4063242094735, 3823.101571130782, 3828.0, 3949.763014219156, 3961.286968345668, 4021.6581590564547, 1187.252031220343, 1195.7190060335813, 1207.849018872641, 1213.1447329632588, 1251.5619533163501, 851.4082712514743, 946.0, 951.5052172870069, 963.8746962894779, 978.9657361992296, 5659.462351076641, 5747.166660834156, 5765.682887441231, 5847.736851841677, 5849.298084229919, 431.99136017279477, 447.230763087489, 451.2464184811373, 454.4455763967954, 460.1533178950747, 3994.6404823565435, 4048.716589838683, 4083.9387409188885, 4105.199486100182, 4122.216778812076, 10164.847527287096, 10313.896861031444, 10429.322094063862, 10540.736481587868, 10576.206784491194, 10276.897231027595, 10279.691609251735, 10287.27989040775, 10300.948495257475, 10318.277720559488, 7792.454528183086, 7808.843823123506, 7891.368690504746, 7932.920670793334, 7959.801004974922, 5451.0, 5594.720263986866, 5699.831534535493, 5702.45826646468, 5724.971375143097, 9393.201577865959, 9672.032796720272, 9699.466529340954, 9750.317477776487, 9756.21950243993, 9440.244780417413, 9731.951340243253, 9761.85357219628, 9825.16486098661, 9859.507024648596, 6959.582425054513, 7624.123225829101, 7637.083549974039, 7685.346745526693, 7815.921840781747, 8432.114627964222, 8435.283000944743, 8435.746927592181, 8438.957805210935, 8451.746447606582, 7366.6684999174095, 7691.73086440731, 7696.884546731691, 7701.4608977371045, 7723.7682869514, 7392.815179620337, 7529.435292352986, 7534.434917381328, 7596.734114305973, 7606.429517786299, 6605.933940660724, 6671.166104236971, 6675.198976122896, 6700.4639628830555, 6700.6984685688285, 4769.928451073306, 4821.349117869183, 4886.95113048865, 4897.216445368724, 4916.0, 4892.828750993698, 4944.826931057396, 4971.676841005323, 4972.453030166751, 4987.401511818605], "value": 4416.799846980674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.51257064121256, 318.75137392833585, 319.3214419358862, 319.7426072012031, 320.57043561627415, 5580.748866301016, 5581.804636837712, 5599.160125981105, 5625.212470254168, 5641.435856414357, 5507.752151153198, 5525.972370138154, 5533.723313834303, 5534.169874518824, 5614.831555053344, 4015.6787457003443, 4106.958930410688, 4199.55904630014, 4224.281872081738, 4226.387173859788, 4176.331786914095, 4198.475190601175, 4214.936775948363, 4216.810243539048, 4230.809613567381, 4188.371744238359, 4193.832246710128, 4210.263203939314, 4212.389203565481, 4226.175895700339, 4059.7767122808086, 4200.810963506649, 4201.45381100455, 4204.5375008749015, 4217.114405974749, 3654.3422184006868, 3659.5608526976935, 3659.652333028358, 3671.8714844980564, 3671.9265614687556, 5330.893382132374, 5335.733213339317, 5370.43610420904, 5372.838814835562, 5383.973080134613, 4729.976350118227, 4790.736509491977, 4840.741407234109, 4881.682690625134, 4893.314935908976, 5676.2620859288445, 5685.289338832646, 5699.57253206007, 5730.312362516524, 5735.942640573624, 4071.226466971266, 4082.8979275518054, 4096.201240758053, 4102.620480121552, 4113.128526520426, 5780.9710951445395, 5881.823545293648, 5924.398557623513, 5936.762529498815, 6065.332813390523, 4130.112025914383, 4140.23405669952, 4143.7928103594695, 4159.896002599899, 4173.165366926627, 4157.584241575879, 4193.30810416284, 4198.433211516406, 4205.600467955539, 4213.431186789744, 4563.726176429424, 4808.495108013678, 4818.68678535894, 4819.180739274332, 4859.975700121477, 5791.768329266866, 5818.592698511148, 5821.941780582225, 5822.388649191858, 5900.940990590125, 1426.265473281261, 1429.0354011042712, 1432.3196481671123, 1438.2736717957573, 1454.62179833242, 896.2784958108786, 912.3841407050214, 912.7489940266347, 935.8409070458039, 978.280963491833, 5634.802781902614, 5650.378458369576, 5663.207150998864, 5674.290713660793, 5707.543396528268, 5864.589478736448, 5884.823455296348, 5978.461938425476, 6005.759769609254, 6018.548608854266, 5330.680159190461, 5555.555555555546, 5564.527015203672, 5574.494886380736, 5593.776248950077, 3142.6700196479496, 3143.402753476832, 3192.1700357906648, 3197.4564324064963, 3198.328351046306, 5826.388229235954, 6070.514358851281, 6078.753855459709, 6082.844259590752, 6102.908456373158, 6016.187814644967, 6018.398160184034, 6020.518358531307, 6044.516438684895, 6080.361562036011, 6143.477804386677, 6162.876742465126, 6163.476104531075, 6164.99637617776, 6187.535934804998, 5675.943240567542, 5811.4479124483105, 5817.0, 5858.0, 5885.264341957255, 5809.331926828469, 5869.442402971711, 5873.823785286449, 5890.793822216202, 5894.410558944242, 5882.911756323744, 6060.303065147388, 6102.6643534604245, 6191.473724733448, 6203.96898015507, 4073.3889916512762, 4078.225137223918, 4080.510338759368, 4083.7141400102896, 4095.385692146202, 5821.185034095315, 5918.467337939606, 5929.733162007634, 5964.254468191476, 5990.191324171181, 5484.232207490874, 5806.1000544915605, 5814.854628634318, 5817.883642327214, 5870.853228669317, 5788.363280039276, 5793.884122317614, 5820.447057529528, 5823.388544202967, 5842.941570584239, 5498.780048798003, 5574.470425309589, 5700.173474846207, 5725.828225153252, 5768.423157684198, 5802.462347478006, 5830.8804789437445, 5849.970750146222, 5868.882622347614, 5889.263842019747, 5487.259220005249, 5742.569307302053, 5763.731978964621, 5781.21953536284, 5809.796657116981], "value": 4364.1591754440105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.8912657664639, 797.9321757650603, 832.1886160993032, 847.8897743293379, 888.8000199955009, 15915.761263581055, 16055.116968566725, 16406.589835254126, 16453.917730411333, 16457.34170633176, 14845.331960061823, 15042.699146017101, 15051.397944082224, 15135.924320378383, 15179.241037948086, 769.1116760142017, 784.560646038219, 822.9629666665014, 833.0212000898949, 834.6619619054293, 816.8529664660359, 823.7322870067222, 826.8139668574553, 827.1645637905729, 828.3207769628907, 854.7393045121236, 856.5888373580685, 858.8153546987396, 860.7030574451804, 861.5003298087095, 856.648774002656, 856.7472595584318, 857.7555396711938, 859.5487369131193, 859.6690274244398, 624.3101372982834, 625.2684359299585, 627.1157667688537, 627.3976982097192, 627.6830200748639, 15696.76454853178, 15713.68572628541, 15755.68488630221, 15763.369465221378, 15784.131872746995, 14162.929185354007, 14488.20314882681, 14635.487757928422, 14660.56018319452, 14685.70628587433, 12100.515979360815, 12122.090843186708, 12173.695657608541, 12221.572244971383, 12632.621021369374, 3850.5186851643543, 3863.111484358585, 3873.593272706353, 3917.118648304109, 3994.0613955720382, 78796.0, 79349.0, 79402.20597794064, 79722.0, 79754.20245797526, 11404.771904561861, 11459.77080458386, 11499.252548584482, 11528.827067593993, 11614.825777613343, 21875.890620546794, 21922.780772192073, 21928.122875084817, 21971.450713732283, 22002.559948801256, 8089.47418417801, 8148.307393871587, 8202.26179643835, 8378.706745264008, 8645.524496152771, 4621.722696638212, 4624.9768751156025, 4684.273937539687, 4729.668923175344, 4745.217039188564, 3805.562360328542, 3999.64003239704, 4002.3796311571755, 4009.3585026395635, 4014.8996275092773, 688.0814113158989, 706.2407911495163, 709.6380845768695, 714.8891921752032, 714.8927660850914, 657.3689258311979, 707.3563057617544, 787.1144961917843, 796.9203079692101, 804.6620419423739, 10097.293189476666, 10188.847167292497, 10429.113525350278, 10585.523651435704, 10619.469026548797, 748.46858730301, 752.8983587215765, 754.453021559376, 759.8062494064089, 781.1563511407666, 4855.781489832966, 5067.265246539305, 5104.310918026019, 5104.668196567285, 5107.387113546398, 73666.0, 73787.26212737912, 73972.0, 121022.0, 123150.0, 65981.6700916502, 111651.0, 113728.0, 114391.42804286092, 114543.0, 58978.0, 59436.70281648564, 97534.0, 97613.51193244131, 98619.50690246503, 9148.176664100263, 9497.053924371794, 9549.665761698307, 9576.138147566753, 9662.95168524181, 53290.46709532855, 54598.18102728383, 54763.0, 55104.448955511536, 56693.14960275517, 67231.3276867225, 76128.0, 77288.61355693186, 78742.60628697049, 79016.20983790318, 11747.530098795953, 11768.176227663982, 12107.455164517794, 12171.33057681836, 12283.815742764044, 12778.105532612628, 12877.484900603871, 13656.248906310248, 14201.360938757987, 14865.702685946004, 13290.734185316047, 13568.0, 13896.444142234603, 14052.718945621235, 14397.064190827563, 13667.31663416845, 13788.862111378758, 14189.29053547298, 14282.0, 14321.427142914166, 13473.86526134726, 13885.097468664504, 13892.791608125684, 13925.582232533041, 14105.576832695035, 11330.60342887995, 11385.772284554429, 11389.772204555697, 11573.594924177612, 11910.583129590423, 11617.76764464689, 11685.474153662935, 11939.0, 11940.70148246266, 12097.939510302393], "value": 7707.224110656099, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 152.0, 191.0, 135.0, 151.0, 151.0, 133.0, 193.0, 124.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 169.0, 174.0, 160.0, 161.0, 161.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 156.0, 75.0, 75.0, 76.0, 75.0, 179.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 153.0, 85.0, 86.0, 86.0, 136.0, 86.0, 87.0, 141.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 151.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 56.0, 55.0, 54.0, 56.0, 53.0, 64.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 62.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 81.0, 80.0, 82.0, 86.0, 81.0, 80.0, 102.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 137.0, 129.0, 121.0, 122.0, 119.0, 134.0, 124.0, 125.0, 122.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 171.0, 168.0, 163.0, 167.0, 163.0, 166.0, 165.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 64.0, 66.0, 62.0, 64.0, 67.0, 63.0, 67.0], "value": 64.9, "unit": "score"}]}]} 11:38:50 INFO - Return code: 0 11:38:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:50 ERROR - # TBPL SUCCESS # 11:38:50 INFO - Running post-action listener: _resource_record_post_action 11:38:50 INFO - ##### 11:38:50 INFO - ##### Finished run-tests step (success) 11:38:50 INFO - ##### 11:38:50 INFO - Running post-run listener: _resource_record_post_run 11:38:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294883328; Read time: 20; Write time: 217672 11:38:50 INFO - TinderboxPrint: CPU usage
13.4% 11:38:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 11:38:50 INFO - TinderboxPrint: I/O write bytes / time
294,883,328 / 217,672 11:38:50 INFO - TinderboxPrint: CPU idle
8,229.1 (86.6%) 11:38:50 INFO - TinderboxPrint: CPU user
1,217.1 (12.8%) 11:38:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:38:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5226496; Read time: 0; Write time: 440 11:38:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289656832; Read time: 20; Write time: 217232 11:38:51 INFO - Running post-run listener: _upload_blobber_files 11:38:51 INFO - Blob upload gear active. 11:38:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:51 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:51 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:51 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:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:52 INFO - (blobuploader) - INFO - Done attempting. 11:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:52 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-e10s_raw.log ... 11:38:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: 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 - Iteration through files over. 11:38:57 INFO - Return code: 0 11:38:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711044fa8aa14819f73439ef51e39085657bd798ba90dcfbaad4db850c8bb0e4f06eb36ef3ba0724914ba1ddbf42f20a816554df7552ccea6e1f648b690d862d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763dd00cab0606fca9fec9041de235339f2fc810be96c84766dd8bb9080e183d5a607e95e7d376ae6860a6d5d63fbb47935939092e11e2f17821a1e53972e09e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b95da9ea200cfafe89784372e5cca3f794dbe4af1ead911c3ae5e60c478189315c799c47927214ff7138448eefaea3a4c2aab06af5cb506343a7d2fae05bb06"} 11:38:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:57 INFO - Contents: 11:38:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711044fa8aa14819f73439ef51e39085657bd798ba90dcfbaad4db850c8bb0e4f06eb36ef3ba0724914ba1ddbf42f20a816554df7552ccea6e1f648b690d862d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763dd00cab0606fca9fec9041de235339f2fc810be96c84766dd8bb9080e183d5a607e95e7d376ae6860a6d5d63fbb47935939092e11e2f17821a1e53972e09e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b95da9ea200cfafe89784372e5cca3f794dbe4af1ead911c3ae5e60c478189315c799c47927214ff7138448eefaea3a4c2aab06af5cb506343a7d2fae05bb06"} 11:38:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:57 INFO - Copying logs to upload dir... 11:38:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.328643 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-15 11:38:57.966311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 11:38:57.969911) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711044fa8aa14819f73439ef51e39085657bd798ba90dcfbaad4db850c8bb0e4f06eb36ef3ba0724914ba1ddbf42f20a816554df7552ccea6e1f648b690d862d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763dd00cab0606fca9fec9041de235339f2fc810be96c84766dd8bb9080e183d5a607e95e7d376ae6860a6d5d63fbb47935939092e11e2f17821a1e53972e09e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b95da9ea200cfafe89784372e5cca3f794dbe4af1ead911c3ae5e60c478189315c799c47927214ff7138448eefaea3a4c2aab06af5cb506343a7d2fae05bb06"} 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.011284 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711044fa8aa14819f73439ef51e39085657bd798ba90dcfbaad4db850c8bb0e4f06eb36ef3ba0724914ba1ddbf42f20a816554df7552ccea6e1f648b690d862d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763dd00cab0606fca9fec9041de235339f2fc810be96c84766dd8bb9080e183d5a607e95e7d376ae6860a6d5d63fbb47935939092e11e2f17821a1e53972e09e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b95da9ea200cfafe89784372e5cca3f794dbe4af1ead911c3ae5e60c478189315c799c47927214ff7138448eefaea3a4c2aab06af5cb506343a7d2fae05bb06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 11:38:57.994611) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:38:57.994911) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466014256.952729-1193874889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:38:58.079086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 11:38:58.079381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 11:38:58.079670) ========= ========= Total master_lag: 0.20 =========