builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1465293609.6 results: success (0) buildid: 20160607021232 builduid: dcb4d0e1056840f6a39fa80363c9f039 revision: c227ee36b4844af150165c64e13347f483db8284 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.599089) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.599586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.599913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.620863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.621159) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 03:00:09-- 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% 102M=0s 2016-06-07 03:00:09 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.750572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.750987) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019374 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.801508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:09.801904) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c227ee36b4844af150165c64e13347f483db8284 --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 c227ee36b4844af150165c64e13347f483db8284 --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=6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 03:00:10,004 truncating revision to first 12 chars 2016-06-07 03:00:10,004 Setting DEBUG logging. 2016-06-07 03:00:10,004 attempt 1/10 2016-06-07 03:00:10,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c227ee36b484?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 03:00:10,409 unpacking tar archive at: fx-team-c227ee36b484/testing/mozharness/ program finished with exit code 0 elapsedTime=0.906388 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:10.725560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:10.725955) ========= script_repo_revision: c227ee36b4844af150165c64e13347f483db8284 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:10.726424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:10.726756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 03:00:10.738065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-07 03:00:10.738516) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:00:11 INFO - MultiFileLogger online at 20160607 03:00:11 in /builds/slave/test 03:00:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:00:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:11 INFO - {'append_to_log': False, 03:00:11 INFO - 'base_work_dir': '/builds/slave/test', 03:00:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:00:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:11 INFO - 'branch': 'Fx-Team-Non-PGO', 03:00:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:11 INFO - 'config_files': ('talos/linux_config.py',), 03:00:11 INFO - 'default_actions': ('clobber', 03:00:11 INFO - 'read-buildbot-config', 03:00:11 INFO - 'download-and-extract', 03:00:11 INFO - 'populate-webroot', 03:00:11 INFO - 'create-virtualenv', 03:00:11 INFO - 'install', 03:00:11 INFO - 'run-tests'), 03:00:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:11 INFO - 'download_minidump_stackwalk': True, 03:00:11 INFO - 'download_symbols': 'ondemand', 03:00:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:11 INFO - 'installer_path': 'installer.exe', 03:00:11 INFO - 'log_level': 'info', 03:00:11 INFO - 'log_name': 'talos', 03:00:11 INFO - 'log_to_console': True, 03:00:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:00:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:00:11 INFO - 'opt_config_files': (), 03:00:11 INFO - 'pip_index': False, 03:00:11 INFO - 'sps_profile': False, 03:00:11 INFO - 'sps_profile_interval': 0, 03:00:11 INFO - 'suite': 'dromaeojs-e10s', 03:00:11 INFO - 'system_bits': '32', 03:00:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:11 INFO - 'title': 'talos-linux64-ix-023', 03:00:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:11 INFO - 'use_talos_json': True, 03:00:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:11 INFO - 'work_dir': 'build'} 03:00:11 INFO - ##### 03:00:11 INFO - ##### Running clobber step. 03:00:11 INFO - ##### 03:00:11 INFO - Running pre-action listener: _resource_record_pre_action 03:00:11 INFO - Running main action method: clobber 03:00:11 INFO - rmtree: /builds/slave/test/build 03:00:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:12 INFO - Running post-action listener: _resource_record_post_action 03:00:12 INFO - ##### 03:00:12 INFO - ##### Finished clobber step (success) 03:00:12 INFO - ##### 03:00:12 INFO - ##### 03:00:12 INFO - ##### Running read-buildbot-config step. 03:00:12 INFO - ##### 03:00:12 INFO - Running pre-action listener: _resource_record_pre_action 03:00:12 INFO - Running main action method: read_buildbot_config 03:00:12 INFO - Using buildbot properties: 03:00:12 INFO - { 03:00:12 INFO - "project": "", 03:00:12 INFO - "product": "firefox", 03:00:12 INFO - "script_repo_revision": "production", 03:00:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:00:12 INFO - "repository": "", 03:00:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:00:12 INFO - "buildid": "20160607021232", 03:00:12 INFO - "pgo_build": "False", 03:00:12 INFO - "basedir": "/builds/slave/test", 03:00:12 INFO - "buildnumber": 1564, 03:00:12 INFO - "slavename": "talos-linux64-ix-023", 03:00:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:00:12 INFO - "platform": "ubuntu64_hw", 03:00:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:00:12 INFO - "branch": "fx-team", 03:00:12 INFO - "repo_path": "integration/fx-team", 03:00:12 INFO - "revision": "c227ee36b4844af150165c64e13347f483db8284", 03:00:12 INFO - "stage_platform": "linux64", 03:00:12 INFO - "builduid": "dcb4d0e1056840f6a39fa80363c9f039", 03:00:12 INFO - "slavebuilddir": "test" 03:00:12 INFO - } 03:00:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:00:12 INFO - Running post-action listener: _resource_record_post_action 03:00:12 INFO - ##### 03:00:12 INFO - ##### Finished read-buildbot-config step (success) 03:00:12 INFO - ##### 03:00:12 INFO - ##### 03:00:12 INFO - ##### Running download-and-extract step. 03:00:12 INFO - ##### 03:00:12 INFO - Running pre-action listener: _resource_record_pre_action 03:00:12 INFO - Running main action method: download_and_extract 03:00:12 INFO - mkdir: /builds/slave/test/build/tests 03:00: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')]} 03:00:12 INFO - https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:00:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:00:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:00:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:12 INFO - Downloaded 1361 bytes. 03:00:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:00:12 INFO - Using the following test package requirements: 03:00:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:00:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:00:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:00:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:12 INFO - u'jsshell-linux-x86_64.zip'], 03:00:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:00:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:00:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:00:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:00:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:00:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:00:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:00: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')]} 03:00:12 INFO - https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:00:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:13 INFO - Downloaded 22871657 bytes. 03:00:13 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'] 03:00:13 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 03:00:14 INFO - Return code: 0 03:00:14 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 03:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:14 INFO - https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:15 INFO - Downloaded 22871657 bytes. 03:00:15 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'] 03:00:15 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 03:00:17 INFO - Return code: 0 03:00:17 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')]} 03:00:17 INFO - https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:18 INFO - Downloaded 10833369 bytes. 03:00:18 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'] 03:00:18 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 03:00:18 INFO - Return code: 0 03:00: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')]} 03:00:18 INFO - https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDiZD77oRhqEelakNvpExw/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 03:00:20 INFO - Downloaded 55204465 bytes. 03:00:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:20 INFO - mkdir: /builds/slave/test/properties 03:00:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:20 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:20 INFO - Contents: 03:00:20 INFO - build_url:https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:21 INFO - Running post-action listener: _resource_record_post_action 03:00:21 INFO - Running post-action listener: set_extra_try_arguments 03:00:21 INFO - ##### 03:00:21 INFO - ##### Finished download-and-extract step (success) 03:00:21 INFO - ##### 03:00:21 INFO - ##### 03:00:21 INFO - ##### Running populate-webroot step. 03:00:21 INFO - ##### 03:00:21 INFO - Running pre-action listener: _resource_record_pre_action 03:00:21 INFO - Running main action method: populate_webroot 03:00:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:21 INFO - '--tppagecycles', 03:00:21 INFO - '7'], 03:00:21 INFO - 'tests': ['tsvgm']}}, 03:00:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:00:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:21 INFO - 'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:21 INFO - 'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['damp', 'tps']}, 03:00:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:21 INFO - 'tests': ['damp', 'tps']}, 03:00:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['dromaeo_dom']}, 03:00:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['a11yr', 03:00:21 INFO - 'ts_paint', 03:00:21 INFO - 'tpaint', 03:00:21 INFO - 'sessionrestore', 03:00:21 INFO - 'sessionrestore_no_auto_restore', 03:00:21 INFO - 'tabpaint']}, 03:00:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['tsvgx', 03:00:21 INFO - 'tsvgr_opacity', 03:00:21 INFO - 'tart', 03:00:21 INFO - 'tscrollx', 03:00:21 INFO - 'cart']}, 03:00:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:21 INFO - 'tsvgr_opacity', 03:00:21 INFO - 'tart', 03:00:21 INFO - 'tscrollx', 03:00:21 INFO - 'cart']}, 03:00:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:21 INFO - 'talos_options': ['--disable-e10s'], 03:00:21 INFO - 'tests': ['tp5o']}, 03:00:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:21 INFO - 'tests': ['tp5o']}, 03:00:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:21 INFO - 'talos_options': ['--disable-e10s', 03:00:21 INFO - '--xperf_path', 03:00:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:21 INFO - 'tests': ['tp5n']}, 03:00:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:21 INFO - 'talos_options': ['--xperf_path', 03:00:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:21 INFO - 'tests': ['tp5n']}}, 03:00:21 INFO - 'talos.zip': {'path': '', 03:00:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:21 INFO - Running post-action listener: _resource_record_post_action 03:00:21 INFO - ##### 03:00:21 INFO - ##### Finished populate-webroot step (success) 03:00:21 INFO - ##### 03:00:21 INFO - ##### 03:00:21 INFO - ##### Running create-virtualenv step. 03:00:21 INFO - ##### 03:00:21 INFO - Running pre-action listener: _resource_record_pre_action 03:00:21 INFO - Running main action method: create_virtualenv 03:00:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:21 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 03:00:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:21 INFO - Using real prefix '/usr' 03:00:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:23 INFO - Installing pip.................done. 03:00:23 INFO - Return code: 0 03:00:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:23 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 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00:23 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 03:00:23 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 03:00:23 INFO - Using env: {'DISPLAY': ':0', 03:00:23 INFO - 'HOME': '/home/cltbld', 03:00:23 INFO - 'LANG': 'en_US.UTF-8', 03:00:23 INFO - 'LANGUAGE': 'en_US:en', 03:00:23 INFO - 'LOGNAME': 'cltbld', 03:00:23 INFO - 'MAIL': '/var/mail/cltbld', 03:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:23 INFO - 'MOZ_NO_REMOTE': '1', 03:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:23 INFO - 'NO_EM_RESTART': '1', 03:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:23 INFO - 'PWD': '/builds/slave/test', 03:00:23 INFO - 'SHELL': '/bin/bash', 03:00:23 INFO - 'SHLVL': '1', 03:00:23 INFO - 'TERM': 'linux', 03:00:23 INFO - 'TMOUT': '86400', 03:00:23 INFO - 'USER': 'cltbld', 03:00:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:23 INFO - '_': '/tools/buildbot/bin/python'} 03:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:23 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 03:00:23 INFO - Cleaning up... 03:00:23 INFO - Return code: 0 03:00:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:23 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 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00:23 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 03:00:23 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 03:00:23 INFO - Using env: {'DISPLAY': ':0', 03:00:23 INFO - 'HOME': '/home/cltbld', 03:00:23 INFO - 'LANG': 'en_US.UTF-8', 03:00:23 INFO - 'LANGUAGE': 'en_US:en', 03:00:23 INFO - 'LOGNAME': 'cltbld', 03:00:23 INFO - 'MAIL': '/var/mail/cltbld', 03:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:23 INFO - 'MOZ_NO_REMOTE': '1', 03:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:23 INFO - 'NO_EM_RESTART': '1', 03:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:23 INFO - 'PWD': '/builds/slave/test', 03:00:23 INFO - 'SHELL': '/bin/bash', 03:00:23 INFO - 'SHLVL': '1', 03:00:23 INFO - 'TERM': 'linux', 03:00:23 INFO - 'TMOUT': '86400', 03:00:23 INFO - 'USER': 'cltbld', 03:00:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:23 INFO - '_': '/tools/buildbot/bin/python'} 03:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:24 INFO - Downloading/unpacking psutil>=3.1.1 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:26 INFO - Installing collected packages: psutil 03:00:26 INFO - Running setup.py install for psutil 03:00:26 INFO - building 'psutil._psutil_linux' extension 03:00:26 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 03:00:26 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 03:00:26 INFO - building 'psutil._psutil_posix' extension 03:00:26 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 03:00:26 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 03:00:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:26 INFO - Successfully installed psutil 03:00:26 INFO - Cleaning up... 03:00:26 INFO - Return code: 0 03:00:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:26 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')]} 03:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:26 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')]} 03:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:26 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 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00:26 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 03:00:26 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 03:00:26 INFO - Using env: {'DISPLAY': ':0', 03:00:26 INFO - 'HOME': '/home/cltbld', 03:00:26 INFO - 'LANG': 'en_US.UTF-8', 03:00:26 INFO - 'LANGUAGE': 'en_US:en', 03:00:26 INFO - 'LOGNAME': 'cltbld', 03:00:26 INFO - 'MAIL': '/var/mail/cltbld', 03:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:26 INFO - 'MOZ_NO_REMOTE': '1', 03:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:26 INFO - 'NO_EM_RESTART': '1', 03:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:26 INFO - 'PWD': '/builds/slave/test', 03:00:26 INFO - 'SHELL': '/bin/bash', 03:00:26 INFO - 'SHLVL': '1', 03:00:26 INFO - 'TERM': 'linux', 03:00:26 INFO - 'TMOUT': '86400', 03:00:26 INFO - 'USER': 'cltbld', 03:00:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:26 INFO - '_': '/tools/buildbot/bin/python'} 03:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:28 INFO - Installing collected packages: mozsystemmonitor 03:00:28 INFO - Running setup.py install for mozsystemmonitor 03:00:28 INFO - Successfully installed mozsystemmonitor 03:00:28 INFO - Cleaning up... 03:00:28 INFO - Return code: 0 03:00:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:28 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 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00:28 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 03:00:28 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 03:00:29 INFO - Using env: {'DISPLAY': ':0', 03:00:29 INFO - 'HOME': '/home/cltbld', 03:00:29 INFO - 'LANG': 'en_US.UTF-8', 03:00:29 INFO - 'LANGUAGE': 'en_US:en', 03:00:29 INFO - 'LOGNAME': 'cltbld', 03:00:29 INFO - 'MAIL': '/var/mail/cltbld', 03:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:29 INFO - 'MOZ_NO_REMOTE': '1', 03:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:29 INFO - 'NO_EM_RESTART': '1', 03:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:29 INFO - 'PWD': '/builds/slave/test', 03:00:29 INFO - 'SHELL': '/bin/bash', 03:00:29 INFO - 'SHLVL': '1', 03:00:29 INFO - 'TERM': 'linux', 03:00:29 INFO - 'TMOUT': '86400', 03:00:29 INFO - 'USER': 'cltbld', 03:00:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:29 INFO - '_': '/tools/buildbot/bin/python'} 03:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:29 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:31 INFO - warning: no files found matching '*.txt' 03:00:31 INFO - no previously-included directories found matching 'build' 03:00:31 INFO - no previously-included directories found matching 'dist' 03:00:31 INFO - no previously-included directories found matching '.git*' 03:00:31 INFO - Installing collected packages: jsonschema, functools32 03:00:31 INFO - Running setup.py install for functools32 03:00:31 INFO - warning: no files found matching '*.txt' 03:00:31 INFO - no previously-included directories found matching 'build' 03:00:31 INFO - no previously-included directories found matching 'dist' 03:00:31 INFO - no previously-included directories found matching '.git*' 03:00:31 INFO - Successfully installed jsonschema functools32 03:00:31 INFO - Cleaning up... 03:00:31 INFO - Return code: 0 03:00:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:31 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 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00:31 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 03:00:31 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 03:00:31 INFO - Using env: {'DISPLAY': ':0', 03:00:31 INFO - 'HOME': '/home/cltbld', 03:00:31 INFO - 'LANG': 'en_US.UTF-8', 03:00:31 INFO - 'LANGUAGE': 'en_US:en', 03:00:31 INFO - 'LOGNAME': 'cltbld', 03:00:31 INFO - 'MAIL': '/var/mail/cltbld', 03:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:31 INFO - 'MOZ_NO_REMOTE': '1', 03:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:31 INFO - 'NO_EM_RESTART': '1', 03:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:31 INFO - 'PWD': '/builds/slave/test', 03:00:31 INFO - 'SHELL': '/bin/bash', 03:00:31 INFO - 'SHLVL': '1', 03:00:31 INFO - 'TERM': 'linux', 03:00:31 INFO - 'TMOUT': '86400', 03:00:31 INFO - 'USER': 'cltbld', 03:00:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:31 INFO - '_': '/tools/buildbot/bin/python'} 03:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 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 03:00:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:33 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 03:00:33 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 03:00:33 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 03:00:33 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 03:00:33 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 03:00:33 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 03:00:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:34 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 03:00:34 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 03:00:34 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 03:00:34 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 03:00:34 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 03:00:34 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 03:00:34 INFO - Downloading docopt-0.6.1.tar.gz 03:00:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:34 INFO - Running setup.py install for blobuploader 03:00:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:34 INFO - Running setup.py install for requests 03:00:35 INFO - Running setup.py install for docopt 03:00:35 INFO - Successfully installed blobuploader requests docopt 03:00:35 INFO - Cleaning up... 03:00:35 INFO - Return code: 0 03:00:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:35 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 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00:35 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 03:00:35 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 03:00:35 INFO - Using env: {'DISPLAY': ':0', 03:00:35 INFO - 'HOME': '/home/cltbld', 03:00:35 INFO - 'LANG': 'en_US.UTF-8', 03:00:35 INFO - 'LANGUAGE': 'en_US:en', 03:00:35 INFO - 'LOGNAME': 'cltbld', 03:00:35 INFO - 'MAIL': '/var/mail/cltbld', 03:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:35 INFO - 'MOZ_NO_REMOTE': '1', 03:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:35 INFO - 'NO_EM_RESTART': '1', 03:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:35 INFO - 'PWD': '/builds/slave/test', 03:00:35 INFO - 'SHELL': '/bin/bash', 03:00:35 INFO - 'SHLVL': '1', 03:00:35 INFO - 'TERM': 'linux', 03:00:35 INFO - 'TMOUT': '86400', 03:00:35 INFO - 'USER': 'cltbld', 03:00:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:35 INFO - '_': '/tools/buildbot/bin/python'} 03:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:35 INFO - Running setup.py (path:/tmp/pip-hKN9aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:35 INFO - Running setup.py (path:/tmp/pip-MmdRzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:35 INFO - Running setup.py (path:/tmp/pip-DC_rjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:35 INFO - Running setup.py (path:/tmp/pip-iE26C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:35 INFO - Running setup.py (path:/tmp/pip-1BYrHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:35 INFO - Running setup.py (path:/tmp/pip-rh_yIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:35 INFO - Running setup.py (path:/tmp/pip-W186OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:35 INFO - Running setup.py (path:/tmp/pip-usQVGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:35 INFO - Running setup.py (path:/tmp/pip-bFJY4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:36 INFO - Running setup.py (path:/tmp/pip-AG5mGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:36 INFO - Running setup.py (path:/tmp/pip-M1LcRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:36 INFO - Running setup.py (path:/tmp/pip-AbmNYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:36 INFO - Running setup.py (path:/tmp/pip-KTDKzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:36 INFO - Running setup.py (path:/tmp/pip-QaHVp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:36 INFO - Running setup.py (path:/tmp/pip-0ds1hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:36 INFO - Running setup.py (path:/tmp/pip-2UH_qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:36 INFO - Running setup.py (path:/tmp/pip-TidJLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:36 INFO - Running setup.py install for manifestparser 03:00:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:36 INFO - Running setup.py install for mozcrash 03:00:36 INFO - Running setup.py install for mozdebug 03:00:36 INFO - Running setup.py install for mozdevice 03:00:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Running setup.py install for mozfile 03:00:37 INFO - Running setup.py install for mozhttpd 03:00:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Running setup.py install for mozinfo 03:00:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Running setup.py install for mozInstall 03:00:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Running setup.py install for mozleak 03:00:37 INFO - Running setup.py install for mozlog 03:00:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Running setup.py install for moznetwork 03:00:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Running setup.py install for mozprocess 03:00:37 INFO - Running setup.py install for mozprofile 03:00:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:37 INFO - Running setup.py install for mozrunner 03:00:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:38 INFO - Running setup.py install for mozscreenshot 03:00:38 INFO - Running setup.py install for moztest 03:00:38 INFO - Running setup.py install for mozversion 03:00:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:38 INFO - Cleaning up... 03:00:38 INFO - Return code: 0 03:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:38 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 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00:38 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 03:00:38 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 03:00:38 INFO - Using env: {'DISPLAY': ':0', 03:00:38 INFO - 'HOME': '/home/cltbld', 03:00:38 INFO - 'LANG': 'en_US.UTF-8', 03:00:38 INFO - 'LANGUAGE': 'en_US:en', 03:00:38 INFO - 'LOGNAME': 'cltbld', 03:00:38 INFO - 'MAIL': '/var/mail/cltbld', 03:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:38 INFO - 'MOZ_NO_REMOTE': '1', 03:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:38 INFO - 'NO_EM_RESTART': '1', 03:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:38 INFO - 'PWD': '/builds/slave/test', 03:00:38 INFO - 'SHELL': '/bin/bash', 03:00:38 INFO - 'SHLVL': '1', 03:00:38 INFO - 'TERM': 'linux', 03:00:38 INFO - 'TMOUT': '86400', 03:00:38 INFO - 'USER': 'cltbld', 03:00:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:38 INFO - '_': '/tools/buildbot/bin/python'} 03:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:38 INFO - Running setup.py (path:/tmp/pip-mVfNZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:38 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)) 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:38 INFO - Running setup.py (path:/tmp/pip-crofmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:38 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)) 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:38 INFO - Running setup.py (path:/tmp/pip-aPPonD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:38 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)) 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:38 INFO - Running setup.py (path:/tmp/pip-k7_QLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:38 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)) 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:38 INFO - Running setup.py (path:/tmp/pip-XAmo_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:38 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)) 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:38 INFO - Running setup.py (path:/tmp/pip-ntfu77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:39 INFO - Running setup.py (path:/tmp/pip-ucPCsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:39 INFO - Running setup.py (path:/tmp/pip-5SjhFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:39 INFO - Running setup.py (path:/tmp/pip-xlru90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:39 INFO - Running setup.py (path:/tmp/pip-1l1H0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:39 INFO - Running setup.py (path:/tmp/pip-bCFYJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:39 INFO - Running setup.py (path:/tmp/pip-INlYZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:39 INFO - Running setup.py (path:/tmp/pip-u5I99x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:39 INFO - Running setup.py (path:/tmp/pip-IEGEx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:39 INFO - Running setup.py (path:/tmp/pip-bAuy7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:39 INFO - Running setup.py (path:/tmp/pip-H7kFBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:39 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)) 03:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:39 INFO - Running setup.py (path:/tmp/pip-UmNXMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 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)) 03:00:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:41 INFO - Downloading blessings-1.6.tar.gz 03:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:41 INFO - Installing collected packages: blessings 03:00:41 INFO - Running setup.py install for blessings 03:00:41 INFO - Successfully installed blessings 03:00:41 INFO - Cleaning up... 03:00:41 INFO - Return code: 0 03:00:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:42 INFO - Reading from file tmpfile_stdout 03:00:42 INFO - Current package versions: 03:00:42 INFO - argparse == 1.2.1 03:00:42 INFO - blessings == 1.6 03:00:42 INFO - blobuploader == 1.2.4 03:00:42 INFO - docopt == 0.6.1 03:00:42 INFO - functools32 == 3.2.3-2 03:00:42 INFO - jsonschema == 2.5.1 03:00:42 INFO - manifestparser == 1.1 03:00:42 INFO - mozInstall == 1.12 03:00:42 INFO - mozcrash == 0.17 03:00:42 INFO - mozdebug == 0.1 03:00:42 INFO - mozdevice == 0.48 03:00:42 INFO - mozfile == 1.2 03:00:42 INFO - mozhttpd == 0.7 03:00:42 INFO - mozinfo == 0.9 03:00:42 INFO - mozleak == 0.1 03:00:42 INFO - mozlog == 3.2 03:00:42 INFO - moznetwork == 0.27 03:00:42 INFO - mozprocess == 0.22 03:00:42 INFO - mozprofile == 0.28 03:00:42 INFO - mozrunner == 6.11 03:00:42 INFO - mozscreenshot == 0.1 03:00:42 INFO - mozsystemmonitor == 0.3 03:00:42 INFO - moztest == 0.7 03:00:42 INFO - mozversion == 1.4 03:00:42 INFO - psutil == 3.1.1 03:00:42 INFO - requests == 1.2.3 03:00:42 INFO - wsgiref == 0.1.2 03:00:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:42 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 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00:42 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 03:00:42 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 03:00:42 INFO - Using env: {'DISPLAY': ':0', 03:00:42 INFO - 'HOME': '/home/cltbld', 03:00:42 INFO - 'LANG': 'en_US.UTF-8', 03:00:42 INFO - 'LANGUAGE': 'en_US:en', 03:00:42 INFO - 'LOGNAME': 'cltbld', 03:00:42 INFO - 'MAIL': '/var/mail/cltbld', 03:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:42 INFO - 'MOZ_NO_REMOTE': '1', 03:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:42 INFO - 'NO_EM_RESTART': '1', 03:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:42 INFO - 'PWD': '/builds/slave/test', 03:00:42 INFO - 'SHELL': '/bin/bash', 03:00:42 INFO - 'SHLVL': '1', 03:00:42 INFO - 'TERM': 'linux', 03:00:42 INFO - 'TMOUT': '86400', 03:00:42 INFO - 'USER': 'cltbld', 03:00:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:42 INFO - '_': '/tools/buildbot/bin/python'} 03:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 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)) 03:00:42 INFO - Cleaning up... 03:00:42 INFO - Return code: 0 03:00:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00: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'] in /builds/slave/test/build 03:00: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 03:00:42 INFO - Using env: {'DISPLAY': ':0', 03:00:42 INFO - 'HOME': '/home/cltbld', 03:00:42 INFO - 'LANG': 'en_US.UTF-8', 03:00:42 INFO - 'LANGUAGE': 'en_US:en', 03:00:42 INFO - 'LOGNAME': 'cltbld', 03:00:42 INFO - 'MAIL': '/var/mail/cltbld', 03:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:42 INFO - 'MOZ_NO_REMOTE': '1', 03:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:42 INFO - 'NO_EM_RESTART': '1', 03:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:42 INFO - 'PWD': '/builds/slave/test', 03:00:42 INFO - 'SHELL': '/bin/bash', 03:00:42 INFO - 'SHLVL': '1', 03:00:42 INFO - 'TERM': 'linux', 03:00:42 INFO - 'TMOUT': '86400', 03:00:42 INFO - 'USER': 'cltbld', 03:00:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:42 INFO - '_': '/tools/buildbot/bin/python'} 03:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:42 INFO - Cleaning up... 03:00:42 INFO - Return code: 0 03:00:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f50899f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, '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': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', '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 03:00: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', 'flake8'] in /builds/slave/test/build 03:00: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 flake8 03:00:42 INFO - Using env: {'DISPLAY': ':0', 03:00:42 INFO - 'HOME': '/home/cltbld', 03:00:42 INFO - 'LANG': 'en_US.UTF-8', 03:00:42 INFO - 'LANGUAGE': 'en_US:en', 03:00:42 INFO - 'LOGNAME': 'cltbld', 03:00:42 INFO - 'MAIL': '/var/mail/cltbld', 03:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:42 INFO - 'MOZ_NO_REMOTE': '1', 03:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:42 INFO - 'NO_EM_RESTART': '1', 03:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:42 INFO - 'PWD': '/builds/slave/test', 03:00:42 INFO - 'SHELL': '/bin/bash', 03:00:42 INFO - 'SHLVL': '1', 03:00:42 INFO - 'TERM': 'linux', 03:00:42 INFO - 'TMOUT': '86400', 03:00:42 INFO - 'USER': 'cltbld', 03:00:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:42 INFO - '_': '/tools/buildbot/bin/python'} 03:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:42 INFO - Downloading/unpacking flake8 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:00:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:00:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:00:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:45 INFO - no previously-included directories found matching 'docs/_build' 03:00:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:00:45 INFO - Running setup.py install for pep8 03:00:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:45 INFO - no previously-included directories found matching 'docs/_build' 03:00:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:00:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:00:45 INFO - Cleaning up... 03:00:45 INFO - Return code: 0 03:00:45 INFO - Running post-action listener: _resource_record_post_action 03:00:45 INFO - Running post-action listener: _start_resource_monitoring 03:00:45 INFO - Starting resource monitoring. 03:00:45 INFO - ##### 03:00:45 INFO - ##### Finished create-virtualenv step (success) 03:00:45 INFO - ##### 03:00:45 INFO - ##### 03:00:45 INFO - ##### Running install step. 03:00:45 INFO - ##### 03:00:45 INFO - Running pre-action listener: _resource_record_pre_action 03:00:45 INFO - Running main action method: install 03:00:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:45 INFO - Reading from file tmpfile_stdout 03:00:45 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:46 INFO - Reading from file tmpfile_stdout 03:00:46 INFO - Output received: 03:00:46 INFO - Usage: mozinstall [options] installer 03:00:46 INFO - Options: 03:00:46 INFO - -h, --help show this help message and exit 03:00:46 INFO - -d DEST, --destination=DEST 03:00:46 INFO - Directory to install application into. [default: 03:00:46 INFO - "/builds/slave/test"] 03:00:46 INFO - --app=APP Application being installed. [default: firefox] 03:00:46 INFO - mkdir: /builds/slave/test/build/application 03:00:46 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'] 03:00:46 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 03:01:01 INFO - Reading from file tmpfile_stdout 03:01:01 INFO - Output received: 03:01:01 INFO - /builds/slave/test/build/application/firefox/firefox 03:01:01 INFO - Running post-action listener: _resource_record_post_action 03:01:01 INFO - ##### 03:01:01 INFO - ##### Finished install step (success) 03:01:01 INFO - ##### 03:01:01 INFO - ##### 03:01:01 INFO - ##### Running run-tests step. 03:01:01 INFO - ##### 03:01:01 INFO - Running pre-action listener: _resource_record_pre_action 03:01:01 INFO - Running main action method: run_tests 03:01:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:01 INFO - Python 2.7.3 03:01:01 INFO - Return code: 0 03:01:01 INFO - grabbing minidump binary from tooltool 03:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:01 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 0x1f06990>, '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 0x1e72470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e72900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:01 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 03:01:01 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 03:01:01 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 03:01:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:02 INFO - Return code: 0 03:01:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:01:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:01:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:01:02 INFO - Return code: 0 03:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 03:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 03:01:02 INFO - Using env: {'DISPLAY': ':0', 03:01:02 INFO - 'HOME': '/home/cltbld', 03:01:02 INFO - 'LANG': 'en_US.UTF-8', 03:01:02 INFO - 'LANGUAGE': 'en_US:en', 03:01:02 INFO - 'LOGNAME': 'cltbld', 03:01:02 INFO - 'MAIL': '/var/mail/cltbld', 03:01:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:02 INFO - 'MOZ_NO_REMOTE': '1', 03:01:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:02 INFO - 'NO_EM_RESTART': '1', 03:01:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:02 INFO - 'PWD': '/builds/slave/test', 03:01:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:02 INFO - 'SHELL': '/bin/bash', 03:01:02 INFO - 'SHLVL': '1', 03:01:02 INFO - 'TERM': 'linux', 03:01:02 INFO - 'TMOUT': '86400', 03:01:02 INFO - 'USER': 'cltbld', 03:01:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958', 03:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:02 INFO - '_': '/tools/buildbot/bin/python'} 03:01:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 03:01:03 INFO - mozversion application_buildid: 20160607021232 03:01:03 INFO - mozversion application_changeset: c227ee36b4844af150165c64e13347f483db8284 03:01:03 INFO - mozversion application_display_name: Nightly 03:01:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:03 INFO - mozversion application_name: Firefox 03:01:03 INFO - mozversion application_remotingname: firefox 03:01:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:01:03 INFO - mozversion application_vendor: Mozilla 03:01:03 INFO - mozversion application_version: 50.0a1 03:01:03 INFO - mozversion platform_buildid: 20160607021232 03:01:03 INFO - mozversion platform_changeset: c227ee36b4844af150165c64e13347f483db8284 03:01:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:01:03 INFO - mozversion platform_version: 50.0a1 03:01:03 INFO - using testdate: 1465293663 03:01:03 INFO - actual date: 1465293663 03:01:03 INFO - starting webserver on 'localhost:50507' 03:01:03 INFO - SUITE-START | Running 2 tests 03:01:03 INFO - TEST-START | dromaeo_css 03:01:03 INFO - operating with platform_type : linux_ 03:01:03 INFO - Initialising browser for dromaeo_css test... 03:01:03 INFO - TEST-INFO | started process 22964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptk7pyW/profile http://localhost:50507/getInfo.html) 03:01:07 INFO - PROCESS | 22964 | __metrics Screen width/height:1600/1200 03:01:07 INFO - PROCESS | 22964 | colorDepth:24 03:01:07 INFO - PROCESS | 22964 | Browser inner width/height: 1024/697 03:01:07 INFO - PROCESS | 22964 | __metrics 03:01:08 ERROR - PROCESS | 22964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 03:01:09 INFO - TEST-INFO | 22964: exit 0 03:01:09 INFO - Browser initialized. 03:01:09 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:09 INFO - TEST-INFO | started process 23082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptk7pyW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:21 INFO - PROCESS | 23082 | RSS: Main: 168239104 03:01:21 INFO - PROCESS | 23082 | 03:02:10 INFO - PROCESS | 23082 | 1465293730993 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] 03:04:22 INFO - PROCESS | 23082 | Cycle 1(1): loaded http://localhost:50507/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50507/tests/dromaeo/cssquery-ext.html) 03:04:23 INFO - PROCESS | 23082 | RSS: Main: 171040768 03:04:23 INFO - PROCESS | 23082 | 03:07:25 INFO - PROCESS | 23082 | Cycle 1(1): loaded http://localhost:50507/tests/dromaeo/cssquery-ext.html (next: http://localhost:50507/tests/dromaeo/cssquery-jquery.html) 03:07:26 INFO - PROCESS | 23082 | RSS: Main: 170377216 03:07:26 INFO - PROCESS | 23082 | 03:10:28 INFO - PROCESS | 23082 | Cycle 1(1): loaded http://localhost:50507/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50507/tests/dromaeo/cssquery-mootools.html) 03:10:28 INFO - PROCESS | 23082 | RSS: Main: 171544576 03:10:28 INFO - PROCESS | 23082 | 03:13:30 INFO - PROCESS | 23082 | Cycle 1(1): loaded http://localhost:50507/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50507/tests/dromaeo/cssquery-prototype.html) 03:13:31 INFO - PROCESS | 23082 | RSS: Main: 169639936 03:13:31 INFO - PROCESS | 23082 | 03:16:33 INFO - PROCESS | 23082 | Cycle 1(1): loaded http://localhost:50507/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50507/tests/dromaeo/cssquery-yui.html) 03:16:34 INFO - PROCESS | 23082 | RSS: Main: 171479040 03:16:34 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | Cycle 1(1): loaded http://localhost:50507/tests/dromaeo/cssquery-yui.html (next: http://localhost:50507/tests/dromaeo/cssquery-dojo.html) 03:19:37 INFO - PROCESS | 23082 | RSS: Main: 172548096 03:19:37 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | __start_tp_report 03:19:37 INFO - PROCESS | 23082 | _x_x_mozilla_page_load 03:19:37 INFO - PROCESS | 23082 | _x_x_mozilla_page_load_details 03:19:37 INFO - PROCESS | 23082 | |i|pagename|runs| 03:19:37 INFO - PROCESS | 23082 | |0;dojo.html;2623.252373073674;2696.245051385613;2697.3661189620434;2700.068476375651;2714.904978325758;4607.009492959013;4632.5135860734645;4641.814327426903;4712.976435117819;4739.052189562093;4569.657275704319;4673.696209746364;4682.601978831794;4691.249400095985;4726.574608285254;4261.595148460891;4354.738715677054;4399.714018588797;4416.359627853959;4418.756968366754;618.6397906045939;4224.366345048236;4252.957470425303;4295.828166873322;4305.138972205556;4282.828686852522;4331.393604895317;4339.566043395666;4356.4336636237085;4403.779811009436;4324.2648749712625;4357.1721372939355;4359.215341238576;4364.061726728737;4399.406080179199;4289.742615443083;4302.591253830881;4310.633596144332;4336.7831608419765;4356.978215108936;4628.560286772751;4635.605973492224;4639.884002899921;4648.209804333272;4675.298705194214;4843.66094373394;5008.023435430093;5015.699058056528;5018.2974383586325;5024.221245706921;5048.596112311043;5079.974600127012;5103.157978933472;5105.004524117761;5157.277981082651;4693.225617773063;4756.215224487955;4769.046190761862;4771.379720636295;4802.567768900815;5039.697618142924;5102.3877134743325;5149.2276158576515;5202.3497062867145;5255.5795536357;4933.629977751683;4963.230699241623;4971.577415919615;4979.477154898684;5006.74966251686;5038.571721403721;5041.546260836542;5044.54599086084;5067.442581316052;5099.821506247264;4832.34763306949;4970.478099799469;5005.799768009311;5039.77321020555;5040.79836806531;4978.601711863114;4995.100881841304;5023.673461225008;5027.472115427828;5034.144195486703;4222.514410842731;4262.829486820492;4265.50946641134;4270.594293542109;4301.78491075445;3620.855165793339;3657.305112028759;3680.3375392429084;3694.2796154750104;3711.480392745018;4374.62815660666;4400.295952647561;4407.382966384709;4433.512313645497;4504.2793153095345;5070;5081.390233171969;5086.491350864884;5086.720230387365;5101.234814777813;4260.914781704349;4354.521002689701;4419.64642828573;4421.690481666253;4431.689781715249;4496.123255965121;4508.368828364031;4514.187446259705;4516.187086324493;4551.954480455153;4689.976550117364;4739.289106634033;4769.332293478985;4774.904501910012;4782;5024.924626130538;5072.315237442898;5078.568321692697;5089.109405854035;5142.614303927146;4757.738324392191;4781.4501332345835;4781.737004464788;4803.0153818467825;4835.443923948791;4862.440819305825;4936.481669424802;4942;4998.100341938486;5005.249212618136;4980.078685443204;5007.824726134713;5012.348394708811;5016.924746128884;5049;4850.684705494132;4890.559849613552;4907.116718990616;4907.55831975124;4944.703317800943;4721.834735784369;4882.902341953212;4885.828995985124;4910.3125562422;4938.308636790924;4819.927701084416;4842.83050093245;4847.733374664427;4885.096257192431;4924.482929292372;4977.402711674477;4985.850424487271;4987.0524600325825;4989.725565093955;5021.397432308147;4755.334253204624;4816.325714399917;4832.057748739103;4834.7824347903725;4908.950910490992 03:19:37 INFO - PROCESS | 23082 | |1;ext.html;557.2555165808393;586.5747333183442;598.4195330529386;611.1260896917406;628.3276893723718;34745.30509389811;38073.428898566475;38487.42268865962;38570.4214436783;38603.613963860385;40134.598654013455;40313.59686403135;40571.797141014256;40598;40638;7753.108392534874;7904.486208396436;7923.366130709558;7926.841463170733;7942.563159026251;7764.3788496920115;7815.413843961725;7818.960905195466;7841.451098423113;7865.095514015904;7776.261255180777;7782.18287079857;7803;7848.254415830487;7857.6856925722905;7773.416993725465;7791.337736292366;7812.257835505618;7843.686252549891;7856.450048496607;7729.420293478011;7814.3357814585825;7819.726309579194;7824;7827.295543401121;37562.248755024746;37738;37770.622293776985;37802.43296350557;38067.80966095152;2619.6725409323835;3000.2799328161304;3055.847207639609;3210.82340471274;3212.052444528846;27785.583216251773;28204.858975705196;28326.575101373495;28476.85761571179;29441.411171776446;3392.6268110507826;3412.0787387405508;3419.2135808764124;3432.3993301172445;3471.7222622190166;218200;219756;220140;220246;220253;32006.519902201486;32365;32572.511412328833;32781.344373112406;32945.505817412755;33634.49548256778;33839.154021149174;33895.32209355848;33967.66032339645;34023.489647655304;12620;12775.361231938366;12783.296918669377;12802.359882005863;12813.615591532269;10243.282970192015;10267.897321026843;10278.280520363653;10313.896861031444;10324.483775811179;7878.72424465141;7906.288434040964;7957.761267161879;7977.48146370484;8004.439689221815;3099.6745341739243;3139.293658926769;3180.3639272145665;3183.6179658441133;3195.0734287056957;861.8534849075672;949.5774380400655;1011.5801942193907;1043.436544266103;1060.7242117049623;28636.570451443244;28656.426871462452;29268;29346;29600.851995740315;956.4404823178379;996.7657600463886;1019.4698756646502;1059.5761695321933;1112.9721756955978;14724.779128313085;15482.148481833383;15543.378264869505;15994.920025399799;16235.188240587924;384421;386138;386975;388180;388818;50936.49063509318;51056.234156487684;51128.48871511312;51246.23130653043;51273.74363128235;1188.0198835960196;1231.3289257354584;1247.7005518675635;1249.668837758013;1262.7158889249845;28458.288542786595;29794;29825.105246842628;29941.850290748407;29949.401011980073;43880.56119438765;44814;44815;45003.09993800171;45026;347193;351700;354157;355687;356321;25035.74964250407;25411.745882540938;25543.744562554137;25553.87223063947;25747.6137857936;41372;41601.79199103985;41810.163796724504;42304.78847605742;42806.57193428151;36313.45529817002;36638.8168059158;36746.816265918496;37197.44203836891;37529.249415011;35544.45287058982;35993.64006359903;36291.45562816507;36394.8180259097;36520.63479365173;30800.845995769876;35269.470957936166;35456.64543354533;35560.64439355573;36173;31236.843815780776;32381.676183237865;32491.675083248865;32824.50763238601;32996.67003330032;25562.488750225264;25732.742672573033;25805.741942580335;25807.483850323264;25959.610605841306 03:19:37 INFO - PROCESS | 23082 | |2;jquery.html;356.87509371719904;364.2914531236744;367.992640147197;385.7550455460782;386.67712460095817;14799.63000924976;15680.76478852818;16629.91685041576;16734.66530669386;16833.663326733473;15489.922550387233;16534.586635334123;16727.83272167278;16763.161841907888;16782.160891955413;4856.854294371175;5034.295198672189;5048.091343558176;5054.671446355994;5063.594912406998;4936.654434189591;4987.526185012436;4987.576056035241;5012.473690262506;5023.045621331935;4571.200039993005;4832.87917802056;4847.5394837490385;4886.53577910098;4909.3126962225315;4745.976270118645;4827.710337379751;4865.14859899518;5066.41736200338;5076.720780357079;4871.4154301483695;4909.263610458424;4913.115639184945;4924.704517728947;4959.404871415417;11213.383263920481;11248.325100493996;11277.887221127765;11372.37451940143;11432.37121958292;1828.9725654115198;1879.248300679739;1886.500077479469;1993.043339197179;2075.647139986206;8367.581620918929;8449.662013519452;8755.912440875638;8841.557922103933;8846.734597962008;1699.4646686293777;1734.7051001329678;1750.1249375312343;1750.7986581543157;1818.6544556534348;51029.23456148161;58490.41509584892;64142.67928660327;66564;69267.65366173137;9266.258699304039;9323.533823308808;9703.951480242695;9842.114209721016;9963.950180249052;13504.392302346418;13512;13566.59300220995;13623.795643065361;13629;6571.737130514822;6655.567388119756;6694.933050669431;6778.4577233822165;6790.524663273523;6275.435210830956;6284.900142475049;6285.842853928689;6296.779612713533;6326.240851097898;3936.527616686016;3992.7005474589523;4198.832046718158;4202.621764041251;4368.672349573794;1784.2773676660972;1792.1308165539704;1824.9270029198683;1827.2873579304082;1831.560425497871;875.1991927386371;916.9037251088673;919.7884486568126;951.5052172870207;962.4898803634085;16119.919400402923;16549.420770272984;16814.83185168157;16841.747373789403;17150.228239728993;866.2896424931496;874.1171416868881;887.7425546591545;904.3217586809892;909.8953620333747;9245.768855778659;9413.717588472357;9458.148766611039;9524.714258572254;9557.139857412867;284445;286603;288259;398648;402717;76734.61632691801;83028;84884;85232.57383713042;86166.56916715502;898.5237823953315;937.690562114487;952.9475878826731;955.2024059909915;959.0792838874759;15144.939854210099;15434.45979390716;15591.29839157218;15691.529254122395;15936.840631593535;36028.27943441169;37334.25331493409;37627;37740.2451950965;38199.42700859545;52160.47839521556;52167.47832521626;52312.7384363091;52379.59532630367;52415;7096.148462184571;7244.130704315516;7372.96313518429;7474.327310542078;7502.512336698097;9973.900260997587;10714.089302409071;11157.497912594115;11632.709182270512;11708.590199342982;9620.230381569318;9725.951370243103;9911.306208565331;10023.849642255518;10196.38821670702;9665.323427360017;10166.949165254126;10173.491325433552;10298;10352.948235258775;7157.427405807627;7221.133463984355;7258.3104605062435;7525.58609276495;9969.900300997188;10238.590456381959;10884.401357925073;11042.779144417227;11457.484413201259;11517.884821152016;7151.463640227108;7288.489805713762;7370.889436658347;7641;11224.719382015515 03:19:37 INFO - PROCESS | 23082 | |3;mootools.html;1346.9865301346986;1413.688988422547;1489.2107183192904;1678.91605419729;1693.7036018696724;6822.7612033578835;7316.780496585097;7397.408207343413;7776.844463110734;7795.6102194890245;7133.322334378226;7333.779986600397;7491.475596708233;7561.962190189055;7585.81035474112;2124.3945475539476;2171.6308227601344;2181.1166477576608;2182.138055468089;2182.5416662500893;2140.2509121807398;2164.863446690484;2196.8132708719777;2206.172685243034;2207.23850271656;2156.6010288096672;2173.1959175105235;2183.5851188274255;2189.0805861538192;2205.757366689671;2069.079259729421;2069.4102180878376;2072.0572139676487;2076.3459510254297;2086.8747875127387;2067.3281183615236;2114.661654135331;2116.428564287634;2117.2060477321006;2127.2235633993637;7539.698412063511;7555.357794587467;7613.885791713129;7618.542887426772;7623.199564045751;4249.553796851348;4344.304911214191;4354.368616550614;4381.671374646914;4402.449693788277;2757.379589592346;2849;2926.166042677848;2927.9121626351243;2938.5885975963383;855.5978690015683;896.332232486795;897.6274845938927;904.4076130134772;913.8537833946536;10065.849012264822;10382.013708697737;10408.219383546264;10426.582936682524;10444.007819257235;4104.0970986382945;4134.937975930303;4221.02916329246;4291.356296555542;4294.677899157576;9010.909890901139;9020.323475739346;9027.14242146995;9065.365424420228;9072.228860546928;4354.891127721832;4411.7573533455325;4431.645468362523;4431.800568974404;4443.466783985942;3524.8942531724088;3709.2581483703366;3828.1003964068423;3935.685145188378;3968.1666849961252;3571.321448924696;3611.7832930024283;3665.083729067733;3713.8885833425043;3789.5831458539537;1155.8092914668985;1192.8508936382952;1205.3732059329275;1207.4083698987433;1219.0552321950381;821.7288294862681;829.9917000829914;884.1777147253116;887.1704955866286;916.6287653500343;5341.4925582069645;5430.13117901134;5431.945680543223;5494.560435165177;5530.059889818741;834.7412302186342;898.5776684958059;915.2952226785338;928.8978212396631;948.7485816258697;3718.5537735471917;3796.37359835624;3831.1571454280015;3839.7504162229366;3865.9613403866165;9160.312976526788;9240.07599240084;9380.108889655472;9431.858522122173;9454.621815127319;9323.533823308808;9330.346875718635;9342.06579342074;9357.578908949114;9449.38578992377;6973.302669732986;7117.89323160153;7196.532225405332;7220.747273845495;7287.781366558906;5158.871028224175;5197.8440646780655;5266.368035835724;5321.574274058144;5323.600729945347;8186.345092392475;8201.753947381589;8435.620397082022;8470.49177049379;8474.703385381483;8463;8491.74524764258;8524.531150786766;8681.045085040767;8685.174908383693;5549;5984.910226346521;6075.30134034574;6162;6376.553641245254;7475;7515.6242187891485;7516.3986881048295;7517.323440890346;7547.358474529727;6617.536772426077;6631.834204144935;6656.400923916871;6665.100211471389;6926.203486598904;6470.482361410982;6486.967565162144;6627.635480048643;6687.431568316748;6762.053312536151;6257.937420625735;6308.936910631019;6309.779157729457;6320.241571011508;6323.430891219628;4682.157211701926;4713.622910167247;4787.808487660454;4795.760211989456;4828.855134345975;4683.625309975126;4692.061587682409;4765.8093676252565;4855.6601037927;4866.051120031701 03:19:37 INFO - PROCESS | 23082 | |4;prototype.html;291.1948462501185;291.84240510124533;297.48238065765577;299.0862913798345;299.12655047261984;4955.677880937741;4977.328060711812;4993.375828021492;5002.774875130619;5021.17150670139;4898.681585696936;4921.926171107436;4933.815884187796;4942.87642808929;4971.552560269575;3850.345441274983;3873.4383514390397;3890.4942357493487;3912.56961734209;3916.530016398022;3498.195415054526;3834.9424758628643;3935.1736135411597;3937.1731936293268;3941.664958478518;3721.3301605710963;3804.980975095121;3806.4861243732157;3817.980910095446;3819.178876541543;3787.696984241282;3815.1415931415486;3818.217265460574;3822.636849499293;3856.421536769479;3377.847996840148;3380.8140552269615;3394.389009978203;3402.2855200407944;3403.4894765785084;4573.268277075686;4639.930401043987;4640.79116439761;4665.370175026396;4767.666263361566;4363.410939523155;4372.322290045048;4380.663897511257;4391.824327026947;4420.734755914623;4906.675197696602;5152.681293417977;5158.819441319536;5212.50481204285;5222.556082732972;3593.7484376093685;3677.9080522987138;3680.576733675608;3684.0237337105686;3688.4282936144673;5394.271773310631;5396.568274538066;5413.242146099549;5413.648112872651;5440.401555828896;3742.1018955450495;3754.5119134512884;3759.605241449663;3774.245150969817;3778.2065766189407;3524.9295014099575;3738.158914244273;3743.1952130292116;3743.494628225209;3815.5612104608326;4283.121959998193;4313.309870420718;4325.675574331937;4329.415528903621;4339.500957389878;5192.844214673566;5201.581264711927;5221.686698798084;5254.737263136828;5256.185291279858;1267.3219827392302;1279.5137847618032;1282.3203702037936;1292.38611659461;1313.40240190713;806.6329819931917;813.2233716800441;821.9054808696957;823.3125340340763;826.8801023851628;4078.7960601969785;4126.958730412717;4141.420201171838;4188.392683060939;4192.937105943413;4789.443430884976;4803.543663351976;4818.036392721469;4824.059308434892;4846.151923413388;4146.66826653867;4189.350650649154;4232.217039847638;4265.87202383929;4267.935980960288;2410.722766881831;2530.4559519703353;2555.5783295756364;2568.871556422209;2621.84268943864;4539.591436770706;4549.977250113729;4551.314724312605;4556.589906908394;4567.077070674771;4847.230760772292;4874.268859671078;4881.95118048822;4892.059020389361;4925.975370123127;4349.478062632505;4547.954520454819;4555.97027976392;4560.6351491879905;4580.8167673293365;4778.880527986828;4807.927881081857;5161.716105614228;5209.791608335624;5378.247045413724;5202.907389448258;5261.947380526146;5266.578673706018;5275.7362131894015;5301;5058.822941197041;5081.72050537224;5096.108181068373;5099.23511473282;5121.155009423553;3492.2491664292297;3674.246779410268;3702.611225821358;3709.1098136446517;3720.311742327678;5380.9014484350355;5396.1905714143195;5424.647397919122;5425.728713564385;5471.671699698031;5263.526282634582;5272;5292.391374991771;5292.655977361459;5295;5012.423571289202;5222.6083043771105;5231;5255.423372988012;5269.947300526946;5114.74426278692;5126.359924638739;5133.640645154804;5148.510891465305;5191.22131680251;5257.8159764408065;5290.444503327095;5303.973480132575;5324;5324.600654950972;4853.344798452164;5188.844334669966;5223.981323641853;5229.346331708536;5257.369115705987 03:19:37 INFO - PROCESS | 23082 | |5;yui.html;651.4560342114335;652.4128284543913;697.8011266788963;701.2601705201013;768.335389887747;11229.270097443661;12081.456334464949;12275.386230688475;12280.14039017267;12313.630591082281;12856.93571532141;12870.806937895915;12928.159669621467;12936.547220847273;13002.219866807998;737.7454778101546;748.1246941078923;778.9026371703522;798.2297083314629;803.9678412863478;631.2897989761518;737.2885165814987;751.4889874885076;767.9116901556308;793.3851265269434;821.5153059694779;825.7233826668044;827.0612854410227;828.5235989306143;829.8630725930244;813.9064007639108;817.4196320612373;818.0265484073963;819.5369616166877;819.5902048975512;597.0954004682909;598.1327075740151;601.0983524712931;601.3175046322411;601.5187849720206;11938.64184074479;12037;12038.4582693779;12039.699007524794;12047.216930899463;13657.795133073012;13668.863311366958;13685;13839.446422143103;14078.436862525487;10446.843297350546;10452.895471045269;10555.366677999267;10604.68185954415;10893.509792059298;3352.463605823081;3409.8465569049454;3412.5051867479324;3413.607435144965;3504.141485336109;60303;60947.39052609461;61352.386476135114;61611;61630.383696163364;10835.83746243807;10852.782944341227;10874.782504349869;10902.753987994985;10920.781584368267;20081;20112.296069637785;20120.597588048156;20123.29568465126;20178.091985860672;6895.103636527319;6939.959006149017;6957.791266261919;6981.406580440618;7123.608201548861;3732.2162345907122;3846.769193848378;3853.3641949078087;3934.8229329680235;4008.2584721826556;3197.1367730712577;3419.7264218862433;3428.280061187129;3444.4661077533024;3452.7755695879687;601.1974014690437;601.6239850093691;605.7213681706464;606.3905774696402;610.664134725899;529.121658047639;571.8598943258928;590.5806877117295;595.2291782142137;595.6426144313464;8149.921769948625;8153.8776918346275;8365.874511882326;8395.538245396561;8431.747047588582;520.0171675533245;591.1664552980363;595.4373117404098;602.6113157013701;628.3873223607038;3902.161035377351;4084.591540845951;4110.547839737626;4129.834806607762;4189.07840275139;59631.403685962585;60974;61316.69341653263;61654;90239.19521609531;56880;67661;86582;88620.11379886119;89166;49913.50086499161;60941.39058609446;78024.19758024153;79022.20977790264;79238.60380698174;7852.411069169721;7943.165967573322;8178.795530111557;8495.405321627673;8845.380823342304;30914;31100;39067.02332441598;39811.60188398079;43890.341644874716;52351.214731778295;57996.680132794216;59811.700941495015;59885.70057149686;59939;10937.070349020423;11044.558217671525;11111.222214444912;11465.885341146815;11512.251703639236;12582.370881456074;12974.156679816158;13050.34748262602;13093.083484156017;13147.474101035852;11716.414179291172;11843.407829608657;12181.33002684861;12210.572629958264;12444.440000200193;11399.886001139883;11633.941830290794;11789.351585662871;11858.584949526725;11958.46186921608;10557.683269501927;11031.503582338653;11603.419829008348;11779.941100294443;11951.521939122686;9853.408795472295;9970.202383809134;10055.798884022424;10153.136983356497;10600.946995264974;10089.747756306151;10343.482825858526;10450.686479405325;10466;10530.31552949056 03:19:37 INFO - PROCESS | 23082 | __end_tp_report 03:19:37 INFO - PROCESS | 23082 | __start_cc_report 03:19:37 INFO - PROCESS | 23082 | _x_x_mozilla_cycle_collect,372 03:19:37 INFO - PROCESS | 23082 | __end_cc_report 03:19:37 INFO - PROCESS | 23082 | __startTimestamp1465294777544__endTimestamp 03:19:37 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | ------- Summary: start ------- 03:19:37 INFO - PROCESS | 23082 | Number of tests: 6 03:19:37 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | [#0] dojo.html Cycles:165 Average:4636.06 Median:4782.00 stddev:576.50 (12.1%) stddev-sans-first:556.22 03:19:37 INFO - PROCESS | 23082 | Values: 2623.3 2696.2 2697.4 2700.1 2714.9 4607.0 4632.5 4641.8 4713.0 4739.1 4569.7 4673.7 4682.6 4691.2 4726.6 4261.6 4354.7 4399.7 4416.4 4418.8 618.6 4224.4 4253.0 4295.8 4305.1 4282.8 4331.4 4339.6 4356.4 4403.8 4324.3 4357.2 4359.2 4364.1 4399.4 4289.7 4302.6 4310.6 4336.8 4357.0 4628.6 4635.6 4639.9 4648.2 4675.3 4843.7 5008.0 5015.7 5018.3 5024.2 5048.6 5080.0 5103.2 5105.0 5157.3 4693.2 4756.2 4769.0 4771.4 4802.6 5039.7 5102.4 5149.2 5202.3 5255.6 4933.6 4963.2 4971.6 4979.5 5006.7 5038.6 5041.5 5044.5 5067.4 5099.8 4832.3 4970.5 5005.8 5039.8 5040.8 4978.6 4995.1 5023.7 5027.5 5034.1 4222.5 4262.8 4265.5 4270.6 4301.8 3620.9 3657.3 3680.3 3694.3 3711.5 4374.6 4400.3 4407.4 4433.5 4504.3 5070.0 5081.4 5086.5 5086.7 5101.2 4260.9 4354.5 4419.6 4421.7 4431.7 4496.1 4508.4 4514.2 4516.2 4552.0 4690.0 4739.3 4769.3 4774.9 4782.0 5024.9 5072.3 5078.6 5089.1 5142.6 4757.7 4781.5 4781.7 4803.0 4835.4 4862.4 4936.5 4942.0 4998.1 5005.2 4980.1 5007.8 5012.3 5016.9 5049.0 4850.7 4890.6 4907.1 4907.6 4944.7 4721.8 4882.9 4885.8 4910.3 4938.3 4819.9 4842.8 4847.7 4885.1 4924.5 4977.4 4985.9 4987.1 4989.7 5021.4 4755.3 4816.3 4832.1 4834.8 4909.0 03:19:37 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | [#1] ext.html Cycles:180 Average:46039.47 Median:194713.24 stddev:86691.11 (44.5%) stddev-sans-first:86867.05 03:19:37 INFO - PROCESS | 23082 | Values: 557.3 586.6 598.4 611.1 628.3 34745.3 38073.4 38487.4 38570.4 38603.6 40134.6 40313.6 40571.8 40598.0 40638.0 7753.1 7904.5 7923.4 7926.8 7942.6 7764.4 7815.4 7819.0 7841.5 7865.1 7776.3 7782.2 7803.0 7848.3 7857.7 7773.4 7791.3 7812.3 7843.7 7856.5 7729.4 7814.3 7819.7 7824.0 7827.3 37562.2 37738.0 37770.6 37802.4 38067.8 2619.7 3000.3 3055.8 3210.8 3212.1 27785.6 28204.9 28326.6 28476.9 29441.4 3392.6 3412.1 3419.2 3432.4 3471.7 218200.0 219756.0 220140.0 220246.0 220253.0 32006.5 32365.0 32572.5 32781.3 32945.5 33634.5 33839.2 33895.3 33967.7 34023.5 12620.0 12775.4 12783.3 12802.4 12813.6 10243.3 10267.9 10278.3 10313.9 10324.5 7878.7 7906.3 7957.8 7977.5 8004.4 3099.7 3139.3 3180.4 3183.6 3195.1 861.9 949.6 1011.6 1043.4 1060.7 28636.6 28656.4 29268.0 29346.0 29600.9 956.4 996.8 1019.5 1059.6 1113.0 14724.8 15482.1 15543.4 15994.9 16235.2 384421.0 386138.0 386975.0 388180.0 388818.0 50936.5 51056.2 51128.5 51246.2 51273.7 1188.0 1231.3 1247.7 1249.7 1262.7 28458.3 29794.0 29825.1 29941.9 29949.4 43880.6 44814.0 44815.0 45003.1 45026.0 347193.0 351700.0 354157.0 355687.0 356321.0 25035.7 25411.7 25543.7 25553.9 25747.6 41372.0 41601.8 41810.2 42304.8 42806.6 36313.5 36638.8 36746.8 37197.4 37529.2 35544.5 35993.6 36291.5 36394.8 36520.6 30800.8 35269.5 35456.6 35560.6 36173.0 31236.8 32381.7 32491.7 32824.5 32996.7 25562.5 25732.7 25805.7 25807.5 25959.6 03:19:37 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | [#2] jquery.html Cycles:180 Average:22226.18 Median:4909.29 stddev:56205.25 (1144.9%) stddev-sans-first:56338.93 03:19:37 INFO - PROCESS | 23082 | Values: 356.9 364.3 368.0 385.8 386.7 14799.6 15680.8 16629.9 16734.7 16833.7 15489.9 16534.6 16727.8 16763.2 16782.2 4856.9 5034.3 5048.1 5054.7 5063.6 4936.7 4987.5 4987.6 5012.5 5023.0 4571.2 4832.9 4847.5 4886.5 4909.3 4746.0 4827.7 4865.1 5066.4 5076.7 4871.4 4909.3 4913.1 4924.7 4959.4 11213.4 11248.3 11277.9 11372.4 11432.4 1829.0 1879.2 1886.5 1993.0 2075.6 8367.6 8449.7 8755.9 8841.6 8846.7 1699.5 1734.7 1750.1 1750.8 1818.7 51029.2 58490.4 64142.7 66564.0 69267.7 9266.3 9323.5 9704.0 9842.1 9964.0 13504.4 13512.0 13566.6 13623.8 13629.0 6571.7 6655.6 6694.9 6778.5 6790.5 6275.4 6284.9 6285.8 6296.8 6326.2 3936.5 3992.7 4198.8 4202.6 4368.7 1784.3 1792.1 1824.9 1827.3 1831.6 875.2 916.9 919.8 951.5 962.5 16119.9 16549.4 16814.8 16841.7 17150.2 866.3 874.1 887.7 904.3 909.9 9245.8 9413.7 9458.1 9524.7 9557.1 284445.0 286603.0 288259.0 398648.0 402717.0 76734.6 83028.0 84884.0 85232.6 86166.6 898.5 937.7 952.9 955.2 959.1 15144.9 15434.5 15591.3 15691.5 15936.8 36028.3 37334.3 37627.0 37740.2 38199.4 52160.5 52167.5 52312.7 52379.6 52415.0 7096.1 7244.1 7373.0 7474.3 7502.5 9973.9 10714.1 11157.5 11632.7 11708.6 9620.2 9726.0 9911.3 10023.8 10196.4 9665.3 10166.9 10173.5 10298.0 10352.9 7157.4 7221.1 7258.3 7525.6 9969.9 10238.6 10884.4 11042.8 11457.5 11517.9 7151.5 7288.5 7370.9 7641.0 11224.7 03:19:37 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | [#3] mootools.html Cycles:180 Average:5033.60 Median:5385.81 stddev:2764.85 (51.3%) stddev-sans-first:2758.73 03:19:37 INFO - PROCESS | 23082 | Values: 1347.0 1413.7 1489.2 1678.9 1693.7 6822.8 7316.8 7397.4 7776.8 7795.6 7133.3 7333.8 7491.5 7562.0 7585.8 2124.4 2171.6 2181.1 2182.1 2182.5 2140.3 2164.9 2196.8 2206.2 2207.2 2156.6 2173.2 2183.6 2189.1 2205.8 2069.1 2069.4 2072.1 2076.3 2086.9 2067.3 2114.7 2116.4 2117.2 2127.2 7539.7 7555.4 7613.9 7618.5 7623.2 4249.6 4344.3 4354.4 4381.7 4402.4 2757.4 2849.0 2926.2 2927.9 2938.6 855.6 896.3 897.6 904.4 913.9 10065.8 10382.0 10408.2 10426.6 10444.0 4104.1 4134.9 4221.0 4291.4 4294.7 9010.9 9020.3 9027.1 9065.4 9072.2 4354.9 4411.8 4431.6 4431.8 4443.5 3524.9 3709.3 3828.1 3935.7 3968.2 3571.3 3611.8 3665.1 3713.9 3789.6 1155.8 1192.9 1205.4 1207.4 1219.1 821.7 830.0 884.2 887.2 916.6 5341.5 5430.1 5431.9 5494.6 5530.1 834.7 898.6 915.3 928.9 948.7 3718.6 3796.4 3831.2 3839.8 3866.0 9160.3 9240.1 9380.1 9431.9 9454.6 9323.5 9330.3 9342.1 9357.6 9449.4 6973.3 7117.9 7196.5 7220.7 7287.8 5158.9 5197.8 5266.4 5321.6 5323.6 8186.3 8201.8 8435.6 8470.5 8474.7 8463.0 8491.7 8524.5 8681.0 8685.2 5549.0 5984.9 6075.3 6162.0 6376.6 7475.0 7515.6 7516.4 7517.3 7547.4 6617.5 6631.8 6656.4 6665.1 6926.2 6470.5 6487.0 6627.6 6687.4 6762.1 6257.9 6308.9 6309.8 6320.2 6323.4 4682.2 4713.6 4787.8 4795.8 4828.9 4683.6 4692.1 4765.8 4855.7 4866.1 03:19:37 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | [#4] prototype.html Cycles:180 Average:4210.24 Median:4610.37 stddev:1245.38 (27.0%) stddev-sans-first:1213.64 03:19:37 INFO - PROCESS | 23082 | Values: 291.2 291.8 297.5 299.1 299.1 4955.7 4977.3 4993.4 5002.8 5021.2 4898.7 4921.9 4933.8 4942.9 4971.6 3850.3 3873.4 3890.5 3912.6 3916.5 3498.2 3834.9 3935.2 3937.2 3941.7 3721.3 3805.0 3806.5 3818.0 3819.2 3787.7 3815.1 3818.2 3822.6 3856.4 3377.8 3380.8 3394.4 3402.3 3403.5 4573.3 4639.9 4640.8 4665.4 4767.7 4363.4 4372.3 4380.7 4391.8 4420.7 4906.7 5152.7 5158.8 5212.5 5222.6 3593.7 3677.9 3680.6 3684.0 3688.4 5394.3 5396.6 5413.2 5413.6 5440.4 3742.1 3754.5 3759.6 3774.2 3778.2 3524.9 3738.2 3743.2 3743.5 3815.6 4283.1 4313.3 4325.7 4329.4 4339.5 5192.8 5201.6 5221.7 5254.7 5256.2 1267.3 1279.5 1282.3 1292.4 1313.4 806.6 813.2 821.9 823.3 826.9 4078.8 4127.0 4141.4 4188.4 4192.9 4789.4 4803.5 4818.0 4824.1 4846.2 4146.7 4189.4 4232.2 4265.9 4267.9 2410.7 2530.5 2555.6 2568.9 2621.8 4539.6 4550.0 4551.3 4556.6 4567.1 4847.2 4874.3 4882.0 4892.1 4926.0 4349.5 4548.0 4556.0 4560.6 4580.8 4778.9 4807.9 5161.7 5209.8 5378.2 5202.9 5261.9 5266.6 5275.7 5301.0 5058.8 5081.7 5096.1 5099.2 5121.2 3492.2 3674.2 3702.6 3709.1 3720.3 5380.9 5396.2 5424.6 5425.7 5471.7 5263.5 5272.0 5292.4 5292.7 5295.0 5012.4 5222.6 5231.0 5255.4 5269.9 5114.7 5126.4 5133.6 5148.5 5191.2 5257.8 5290.4 5304.0 5324.0 5324.6 4853.3 5188.8 5224.0 5229.3 5257.4 03:19:37 INFO - PROCESS | 23082 | 03:19:37 INFO - PROCESS | 23082 | [#5] yui.html Cycles:180 Average:16301.40 Median:4159.46 stddev:21897.59 (526.5%) stddev-sans-first:21927.49 03:19:37 INFO - PROCESS | 23082 | Values: 651.5 652.4 697.8 701.3 768.3 11229.3 12081.5 12275.4 12280.1 12313.6 12856.9 12870.8 12928.2 12936.5 13002.2 737.7 748.1 778.9 798.2 804.0 631.3 737.3 751.5 767.9 793.4 821.5 825.7 827.1 828.5 829.9 813.9 817.4 818.0 819.5 819.6 597.1 598.1 601.1 601.3 601.5 11938.6 12037.0 12038.5 12039.7 12047.2 13657.8 13668.9 13685.0 13839.4 14078.4 10446.8 10452.9 10555.4 10604.7 10893.5 3352.5 3409.8 3412.5 3413.6 3504.1 60303.0 60947.4 61352.4 61611.0 61630.4 10835.8 10852.8 10874.8 10902.8 10920.8 20081.0 20112.3 20120.6 20123.3 20178.1 6895.1 6940.0 6957.8 6981.4 7123.6 3732.2 3846.8 3853.4 3934.8 4008.3 3197.1 3419.7 3428.3 3444.5 3452.8 601.2 601.6 605.7 606.4 610.7 529.1 571.9 590.6 595.2 595.6 8149.9 8153.9 8365.9 8395.5 8431.7 520.0 591.2 595.4 602.6 628.4 3902.2 4084.6 4110.5 4129.8 4189.1 59631.4 60974.0 61316.7 61654.0 90239.2 56880.0 67661.0 86582.0 88620.1 89166.0 49913.5 60941.4 78024.2 79022.2 79238.6 7852.4 7943.2 8178.8 8495.4 8845.4 30914.0 31100.0 39067.0 39811.6 43890.3 52351.2 57996.7 59811.7 59885.7 59939.0 10937.1 11044.6 11111.2 11465.9 11512.3 12582.4 12974.2 13050.3 13093.1 13147.5 11716.4 11843.4 12181.3 12210.6 12444.4 11399.9 11633.9 11789.4 11858.6 11958.5 10557.7 11031.5 11603.4 11779.9 11951.5 9853.4 9970.2 10055.8 10153.1 10600.9 10089.7 10343.5 10450.7 10466.0 10530.3 03:19:37 INFO - PROCESS | 23082 | -------- Summary: end -------- 03:19:37 INFO - PROCESS | 23082 | 03:19:38 INFO - TEST-INFO | 23082: exit 0 03:19:38 INFO - TEST-OK | dromaeo_css | took 1115152ms 03:19:38 INFO - TEST-START | kraken 03:19:38 INFO - operating with platform_type : linux_ 03:19:38 INFO - Initialising browser for kraken test... 03:19:38 INFO - TEST-INFO | started process 23319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpknGIkz/profile http://localhost:50507/getInfo.html) 03:19:43 INFO - PROCESS | 23319 | __metrics Screen width/height:1600/1200 03:19:43 INFO - PROCESS | 23319 | colorDepth:24 03:19:43 INFO - PROCESS | 23319 | Browser inner width/height: 1024/697 03:19:43 INFO - PROCESS | 23319 | __metrics 03:19:43 ERROR - PROCESS | 23319 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 03:19:44 INFO - TEST-INFO | 23319: exit 0 03:19:44 INFO - Browser initialized. 03:19:44 INFO - Running cycle 1/1 for kraken test... 03:19:44 INFO - TEST-INFO | started process 23437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpknGIkz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:56 INFO - PROCESS | 23437 | RSS: Main: 168435712 03:19:56 INFO - PROCESS | 23437 | 03:19:59 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50507/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:00 INFO - PROCESS | 23437 | RSS: Main: 173150208 03:20:00 INFO - PROCESS | 23437 | 03:20:02 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50507/tests/kraken/driver.html?testName=audio-dft) 03:20:03 INFO - PROCESS | 23437 | RSS: Main: 173412352 03:20:03 INFO - PROCESS | 23437 | 03:20:06 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50507/tests/kraken/driver.html?testName=audio-fft) 03:20:07 INFO - PROCESS | 23437 | RSS: Main: 167587840 03:20:07 INFO - PROCESS | 23437 | 03:20:09 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50507/tests/kraken/driver.html?testName=audio-oscillator) 03:20:09 INFO - PROCESS | 23437 | RSS: Main: 168448000 03:20:09 INFO - PROCESS | 23437 | 03:20:12 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50507/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:12 INFO - PROCESS | 23437 | RSS: Main: 168529920 03:20:12 INFO - PROCESS | 23437 | 03:20:15 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50507/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:16 INFO - PROCESS | 23437 | RSS: Main: 169013248 03:20:16 INFO - PROCESS | 23437 | 03:20:20 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50507/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:20 INFO - PROCESS | 23437 | RSS: Main: 166490112 03:20:20 INFO - PROCESS | 23437 | 03:20:23 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50507/tests/kraken/driver.html?testName=json-parse-financial) 03:20:24 INFO - PROCESS | 23437 | RSS: Main: 168083456 03:20:24 INFO - PROCESS | 23437 | 03:20:25 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50507/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:26 INFO - PROCESS | 23437 | RSS: Main: 168050688 03:20:26 INFO - PROCESS | 23437 | 03:20:28 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50507/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:29 INFO - PROCESS | 23437 | RSS: Main: 168599552 03:20:29 INFO - PROCESS | 23437 | 03:20:31 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50507/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:32 INFO - PROCESS | 23437 | RSS: Main: 168652800 03:20:32 INFO - PROCESS | 23437 | 03:20:34 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:35 INFO - PROCESS | 23437 | RSS: Main: 169676800 03:20:35 INFO - PROCESS | 23437 | 03:20:38 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:38 INFO - PROCESS | 23437 | RSS: Main: 168951808 03:20:38 INFO - PROCESS | 23437 | 03:20:40 INFO - PROCESS | 23437 | Cycle 1(1): loaded http://localhost:50507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50507/tests/kraken/driver.html?testName=ai-astar) 03:20:40 INFO - PROCESS | 23437 | RSS: Main: 169840640 03:20:40 INFO - PROCESS | 23437 | 03:20:40 INFO - PROCESS | 23437 | __start_tp_report 03:20:40 INFO - PROCESS | 23437 | _x_x_mozilla_page_load 03:20:40 INFO - PROCESS | 23437 | _x_x_mozilla_page_load_details 03:20:40 INFO - PROCESS | 23437 | |i|pagename|runs| 03:20:40 INFO - PROCESS | 23437 | |0;ai-astar;114;109;112;113;114;114;112;115;114;113 03:20:40 INFO - PROCESS | 23437 | |1;audio-beat-detection;160;130;153;181;137;160;159;133;198;132 03:20:40 INFO - PROCESS | 23437 | |2;audio-dft;163;164;167;182;162;164;163;164;163;161 03:20:40 INFO - PROCESS | 23437 | |3;audio-fft;75;75;77;151;77;77;77;78;164;76 03:20:40 INFO - PROCESS | 23437 | |4;audio-oscillator;87;88;132;87;86;85;132;86;85;148 03:20:40 INFO - PROCESS | 23437 | |5;imaging-gaussian-blur;118;117;118;118;117;117;118;117;118;118 03:20:40 INFO - PROCESS | 23437 | |6;imaging-darkroom;147;154;148;147;147;147;148;147;149;147 03:20:40 INFO - PROCESS | 23437 | |7;imaging-desaturate;95;95;95;95;96;97;96;95;95;95 03:20:40 INFO - PROCESS | 23437 | |8;json-parse-financial;63;63;64;63;65;63;64;63;65;64 03:20:40 INFO - PROCESS | 23437 | |9;json-stringify-tinderbox;65;65;67;66;65;66;66;65;66;67 03:20:40 INFO - PROCESS | 23437 | |10;stanford-crypto-aes;89;83;86;83;84;89;85;86;111;85 03:20:40 INFO - PROCESS | 23437 | |11;stanford-crypto-ccm;134;130;138;142;137;140;135;145;145;134 03:20:40 INFO - PROCESS | 23437 | |12;stanford-crypto-pbkdf2;164;170;168;169;170;170;169;169;169;169 03:20:40 INFO - PROCESS | 23437 | |13;stanford-crypto-sha256-iterative;68;68;66;69;67;68;66;69;68;66 03:20:40 INFO - PROCESS | 23437 | __end_tp_report 03:20:41 INFO - PROCESS | 23437 | __start_cc_report 03:20:41 INFO - PROCESS | 23437 | _x_x_mozilla_cycle_collect,960 03:20:41 INFO - PROCESS | 23437 | __end_cc_report 03:20:41 INFO - PROCESS | 23437 | __startTimestamp1465294840992__endTimestamp 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | ------- Summary: start ------- 03:20:41 INFO - PROCESS | 23437 | Number of tests: 14 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:1.70 (1.5%) stddev-sans-first:1.76 03:20:41 INFO - PROCESS | 23437 | Values: 114.0 109.0 112.0 113.0 114.0 114.0 112.0 115.0 114.0 113.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:159.50 stddev:22.49 (14.1%) stddev-sans-first:23.76 03:20:41 INFO - PROCESS | 23437 | Values: 160.0 130.0 153.0 181.0 137.0 160.0 159.0 133.0 198.0 132.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.00 stddev:6.07 (3.7%) stddev-sans-first:6.39 03:20:41 INFO - PROCESS | 23437 | Values: 163.0 164.0 167.0 182.0 162.0 164.0 163.0 164.0 163.0 161.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#3] audio-fft Cycles:10 Average:92.70 Median:77.00 stddev:34.30 (44.5%) stddev-sans-first:35.78 03:20:41 INFO - PROCESS | 23437 | Values: 75.0 75.0 77.0 151.0 77.0 77.0 77.0 78.0 164.0 76.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:86.00 stddev:25.06 (29.1%) stddev-sans-first:26.01 03:20:41 INFO - PROCESS | 23437 | Values: 87.0 88.0 132.0 87.0 86.0 85.0 132.0 86.0 85.0 148.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:20:41 INFO - PROCESS | 23437 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:147.50 stddev:2.18 (1.5%) stddev-sans-first:2.28 03:20:41 INFO - PROCESS | 23437 | Values: 147.0 154.0 148.0 147.0 147.0 147.0 148.0 147.0 149.0 147.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:20:41 INFO - PROCESS | 23437 | Values: 95.0 95.0 95.0 95.0 96.0 97.0 96.0 95.0 95.0 95.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 03:20:41 INFO - PROCESS | 23437 | Values: 63.0 63.0 64.0 63.0 65.0 63.0 64.0 63.0 65.0 64.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 03:20:41 INFO - PROCESS | 23437 | Values: 65.0 65.0 67.0 66.0 65.0 66.0 66.0 65.0 66.0 67.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:85.50 stddev:8.32 (9.7%) stddev-sans-first:8.82 03:20:41 INFO - PROCESS | 23437 | Values: 89.0 83.0 86.0 83.0 84.0 89.0 85.0 86.0 111.0 85.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:139.00 stddev:4.99 (3.6%) stddev-sans-first:5.08 03:20:41 INFO - PROCESS | 23437 | Values: 134.0 130.0 138.0 142.0 137.0 140.0 135.0 145.0 145.0 134.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.00 stddev:1.77 (1.0%) stddev-sans-first:0.67 03:20:41 INFO - PROCESS | 23437 | Values: 164.0 170.0 168.0 169.0 170.0 170.0 169.0 169.0 169.0 169.0 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - PROCESS | 23437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 03:20:41 INFO - PROCESS | 23437 | Values: 68.0 68.0 66.0 69.0 67.0 68.0 66.0 69.0 68.0 66.0 03:20:41 INFO - PROCESS | 23437 | -------- Summary: end -------- 03:20:41 INFO - PROCESS | 23437 | 03:20:41 INFO - TEST-INFO | 23437: exit 0 03:20:42 INFO - TEST-OK | kraken | took 63730ms 03:20:42 INFO - SUITE-END | took 1178s 03:20:42 INFO - Completed test suite (00:19:39) 03:20:42 INFO - javascript benchmark 03:20:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6253.940384029842, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.252373073674, 2696.245051385613, 2697.3661189620434, 2700.068476375651, 2714.904978325758, 4607.009492959013, 4632.5135860734645, 4641.814327426903, 4712.976435117819, 4739.052189562093, 4569.657275704319, 4673.696209746364, 4682.601978831794, 4691.249400095985, 4726.574608285254, 4261.595148460891, 4354.738715677054, 4399.714018588797, 4416.359627853959, 4418.756968366754, 618.6397906045939, 4224.366345048236, 4252.957470425303, 4295.828166873322, 4305.138972205556, 4282.828686852522, 4331.393604895317, 4339.566043395666, 4356.4336636237085, 4403.779811009436, 4324.2648749712625, 4357.1721372939355, 4359.215341238576, 4364.061726728737, 4399.406080179199, 4289.742615443083, 4302.591253830881, 4310.633596144332, 4336.7831608419765, 4356.978215108936, 4628.560286772751, 4635.605973492224, 4639.884002899921, 4648.209804333272, 4675.298705194214, 4843.66094373394, 5008.023435430093, 5015.699058056528, 5018.2974383586325, 5024.221245706921, 5048.596112311043, 5079.974600127012, 5103.157978933472, 5105.004524117761, 5157.277981082651, 4693.225617773063, 4756.215224487955, 4769.046190761862, 4771.379720636295, 4802.567768900815, 5039.697618142924, 5102.3877134743325, 5149.2276158576515, 5202.3497062867145, 5255.5795536357, 4933.629977751683, 4963.230699241623, 4971.577415919615, 4979.477154898684, 5006.74966251686, 5038.571721403721, 5041.546260836542, 5044.54599086084, 5067.442581316052, 5099.821506247264, 4832.34763306949, 4970.478099799469, 5005.799768009311, 5039.77321020555, 5040.79836806531, 4978.601711863114, 4995.100881841304, 5023.673461225008, 5027.472115427828, 5034.144195486703, 4222.514410842731, 4262.829486820492, 4265.50946641134, 4270.594293542109, 4301.78491075445, 3620.855165793339, 3657.305112028759, 3680.3375392429084, 3694.2796154750104, 3711.480392745018, 4374.62815660666, 4400.295952647561, 4407.382966384709, 4433.512313645497, 4504.2793153095345, 5070.0, 5081.390233171969, 5086.491350864884, 5086.720230387365, 5101.234814777813, 4260.914781704349, 4354.521002689701, 4419.64642828573, 4421.690481666253, 4431.689781715249, 4496.123255965121, 4508.368828364031, 4514.187446259705, 4516.187086324493, 4551.954480455153, 4689.976550117364, 4739.289106634033, 4769.332293478985, 4774.904501910012, 4782.0, 5024.924626130538, 5072.315237442898, 5078.568321692697, 5089.109405854035, 5142.614303927146, 4757.738324392191, 4781.4501332345835, 4781.737004464788, 4803.0153818467825, 4835.443923948791, 4862.440819305825, 4936.481669424802, 4942.0, 4998.100341938486, 5005.249212618136, 4980.078685443204, 5007.824726134713, 5012.348394708811, 5016.924746128884, 5049.0, 4850.684705494132, 4890.559849613552, 4907.116718990616, 4907.55831975124, 4944.703317800943, 4721.834735784369, 4882.902341953212, 4885.828995985124, 4910.3125562422, 4938.308636790924, 4819.927701084416, 4842.83050093245, 4847.733374664427, 4885.096257192431, 4924.482929292372, 4977.402711674477, 4985.850424487271, 4987.0524600325825, 4989.725565093955, 5021.397432308147, 4755.334253204624, 4816.325714399917, 4832.057748739103, 4834.7824347903725, 4908.950910490992], "value": 4601.614019028777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.2555165808393, 586.5747333183442, 598.4195330529386, 611.1260896917406, 628.3276893723718, 34745.30509389811, 38073.428898566475, 38487.42268865962, 38570.4214436783, 38603.613963860385, 40134.598654013455, 40313.59686403135, 40571.797141014256, 40598.0, 40638.0, 7753.108392534874, 7904.486208396436, 7923.366130709558, 7926.841463170733, 7942.563159026251, 7764.3788496920115, 7815.413843961725, 7818.960905195466, 7841.451098423113, 7865.095514015904, 7776.261255180777, 7782.18287079857, 7803.0, 7848.254415830487, 7857.6856925722905, 7773.416993725465, 7791.337736292366, 7812.257835505618, 7843.686252549891, 7856.450048496607, 7729.420293478011, 7814.3357814585825, 7819.726309579194, 7824.0, 7827.295543401121, 37562.248755024746, 37738.0, 37770.622293776985, 37802.43296350557, 38067.80966095152, 2619.6725409323835, 3000.2799328161304, 3055.847207639609, 3210.82340471274, 3212.052444528846, 27785.583216251773, 28204.858975705196, 28326.575101373495, 28476.85761571179, 29441.411171776446, 3392.6268110507826, 3412.0787387405508, 3419.2135808764124, 3432.3993301172445, 3471.7222622190166, 218200.0, 219756.0, 220140.0, 220246.0, 220253.0, 32006.519902201486, 32365.0, 32572.511412328833, 32781.344373112406, 32945.505817412755, 33634.49548256778, 33839.154021149174, 33895.32209355848, 33967.66032339645, 34023.489647655304, 12620.0, 12775.361231938366, 12783.296918669377, 12802.359882005863, 12813.615591532269, 10243.282970192015, 10267.897321026843, 10278.280520363653, 10313.896861031444, 10324.483775811179, 7878.72424465141, 7906.288434040964, 7957.761267161879, 7977.48146370484, 8004.439689221815, 3099.6745341739243, 3139.293658926769, 3180.3639272145665, 3183.6179658441133, 3195.0734287056957, 861.8534849075672, 949.5774380400655, 1011.5801942193907, 1043.436544266103, 1060.7242117049623, 28636.570451443244, 28656.426871462452, 29268.0, 29346.0, 29600.851995740315, 956.4404823178379, 996.7657600463886, 1019.4698756646502, 1059.5761695321933, 1112.9721756955978, 14724.779128313085, 15482.148481833383, 15543.378264869505, 15994.920025399799, 16235.188240587924, 384421.0, 386138.0, 386975.0, 388180.0, 388818.0, 50936.49063509318, 51056.234156487684, 51128.48871511312, 51246.23130653043, 51273.74363128235, 1188.0198835960196, 1231.3289257354584, 1247.7005518675635, 1249.668837758013, 1262.7158889249845, 28458.288542786595, 29794.0, 29825.105246842628, 29941.850290748407, 29949.401011980073, 43880.56119438765, 44814.0, 44815.0, 45003.09993800171, 45026.0, 347193.0, 351700.0, 354157.0, 355687.0, 356321.0, 25035.74964250407, 25411.745882540938, 25543.744562554137, 25553.87223063947, 25747.6137857936, 41372.0, 41601.79199103985, 41810.163796724504, 42304.78847605742, 42806.57193428151, 36313.45529817002, 36638.8168059158, 36746.816265918496, 37197.44203836891, 37529.249415011, 35544.45287058982, 35993.64006359903, 36291.45562816507, 36394.8180259097, 36520.63479365173, 30800.845995769876, 35269.470957936166, 35456.64543354533, 35560.64439355573, 36173.0, 31236.843815780776, 32381.676183237865, 32491.675083248865, 32824.50763238601, 32996.67003330032, 25562.488750225264, 25732.742672573033, 25805.741942580335, 25807.483850323264, 25959.610605841306], "value": 16377.362219830962, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.87509371719904, 364.2914531236744, 367.992640147197, 385.7550455460782, 386.67712460095817, 14799.63000924976, 15680.76478852818, 16629.91685041576, 16734.66530669386, 16833.663326733473, 15489.922550387233, 16534.586635334123, 16727.83272167278, 16763.161841907888, 16782.160891955413, 4856.854294371175, 5034.295198672189, 5048.091343558176, 5054.671446355994, 5063.594912406998, 4936.654434189591, 4987.526185012436, 4987.576056035241, 5012.473690262506, 5023.045621331935, 4571.200039993005, 4832.87917802056, 4847.5394837490385, 4886.53577910098, 4909.3126962225315, 4745.976270118645, 4827.710337379751, 4865.14859899518, 5066.41736200338, 5076.720780357079, 4871.4154301483695, 4909.263610458424, 4913.115639184945, 4924.704517728947, 4959.404871415417, 11213.383263920481, 11248.325100493996, 11277.887221127765, 11372.37451940143, 11432.37121958292, 1828.9725654115198, 1879.248300679739, 1886.500077479469, 1993.043339197179, 2075.647139986206, 8367.581620918929, 8449.662013519452, 8755.912440875638, 8841.557922103933, 8846.734597962008, 1699.4646686293777, 1734.7051001329678, 1750.1249375312343, 1750.7986581543157, 1818.6544556534348, 51029.23456148161, 58490.41509584892, 64142.67928660327, 66564.0, 69267.65366173137, 9266.258699304039, 9323.533823308808, 9703.951480242695, 9842.114209721016, 9963.950180249052, 13504.392302346418, 13512.0, 13566.59300220995, 13623.795643065361, 13629.0, 6571.737130514822, 6655.567388119756, 6694.933050669431, 6778.4577233822165, 6790.524663273523, 6275.435210830956, 6284.900142475049, 6285.842853928689, 6296.779612713533, 6326.240851097898, 3936.527616686016, 3992.7005474589523, 4198.832046718158, 4202.621764041251, 4368.672349573794, 1784.2773676660972, 1792.1308165539704, 1824.9270029198683, 1827.2873579304082, 1831.560425497871, 875.1991927386371, 916.9037251088673, 919.7884486568126, 951.5052172870207, 962.4898803634085, 16119.919400402923, 16549.420770272984, 16814.83185168157, 16841.747373789403, 17150.228239728993, 866.2896424931496, 874.1171416868881, 887.7425546591545, 904.3217586809892, 909.8953620333747, 9245.768855778659, 9413.717588472357, 9458.148766611039, 9524.714258572254, 9557.139857412867, 284445.0, 286603.0, 288259.0, 398648.0, 402717.0, 76734.61632691801, 83028.0, 84884.0, 85232.57383713042, 86166.56916715502, 898.5237823953315, 937.690562114487, 952.9475878826731, 955.2024059909915, 959.0792838874759, 15144.939854210099, 15434.45979390716, 15591.29839157218, 15691.529254122395, 15936.840631593535, 36028.27943441169, 37334.25331493409, 37627.0, 37740.2451950965, 38199.42700859545, 52160.47839521556, 52167.47832521626, 52312.7384363091, 52379.59532630367, 52415.0, 7096.148462184571, 7244.130704315516, 7372.96313518429, 7474.327310542078, 7502.512336698097, 9973.900260997587, 10714.089302409071, 11157.497912594115, 11632.709182270512, 11708.590199342982, 9620.230381569318, 9725.951370243103, 9911.306208565331, 10023.849642255518, 10196.38821670702, 9665.323427360017, 10166.949165254126, 10173.491325433552, 10298.0, 10352.948235258775, 7157.427405807627, 7221.133463984355, 7258.3104605062435, 7525.58609276495, 9969.900300997188, 10238.590456381959, 10884.401357925073, 11042.779144417227, 11457.484413201259, 11517.884821152016, 7151.463640227108, 7288.489805713762, 7370.889436658347, 7641.0, 11224.719382015515], "value": 7819.726506327958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.9865301346986, 1413.688988422547, 1489.2107183192904, 1678.91605419729, 1693.7036018696724, 6822.7612033578835, 7316.780496585097, 7397.408207343413, 7776.844463110734, 7795.6102194890245, 7133.322334378226, 7333.779986600397, 7491.475596708233, 7561.962190189055, 7585.81035474112, 2124.3945475539476, 2171.6308227601344, 2181.1166477576608, 2182.138055468089, 2182.5416662500893, 2140.2509121807398, 2164.863446690484, 2196.8132708719777, 2206.172685243034, 2207.23850271656, 2156.6010288096672, 2173.1959175105235, 2183.5851188274255, 2189.0805861538192, 2205.757366689671, 2069.079259729421, 2069.4102180878376, 2072.0572139676487, 2076.3459510254297, 2086.8747875127387, 2067.3281183615236, 2114.661654135331, 2116.428564287634, 2117.2060477321006, 2127.2235633993637, 7539.698412063511, 7555.357794587467, 7613.885791713129, 7618.542887426772, 7623.199564045751, 4249.553796851348, 4344.304911214191, 4354.368616550614, 4381.671374646914, 4402.449693788277, 2757.379589592346, 2849.0, 2926.166042677848, 2927.9121626351243, 2938.5885975963383, 855.5978690015683, 896.332232486795, 897.6274845938927, 904.4076130134772, 913.8537833946536, 10065.849012264822, 10382.013708697737, 10408.219383546264, 10426.582936682524, 10444.007819257235, 4104.0970986382945, 4134.937975930303, 4221.02916329246, 4291.356296555542, 4294.677899157576, 9010.909890901139, 9020.323475739346, 9027.14242146995, 9065.365424420228, 9072.228860546928, 4354.891127721832, 4411.7573533455325, 4431.645468362523, 4431.800568974404, 4443.466783985942, 3524.8942531724088, 3709.2581483703366, 3828.1003964068423, 3935.685145188378, 3968.1666849961252, 3571.321448924696, 3611.7832930024283, 3665.083729067733, 3713.8885833425043, 3789.5831458539537, 1155.8092914668985, 1192.8508936382952, 1205.3732059329275, 1207.4083698987433, 1219.0552321950381, 821.7288294862681, 829.9917000829914, 884.1777147253116, 887.1704955866286, 916.6287653500343, 5341.4925582069645, 5430.13117901134, 5431.945680543223, 5494.560435165177, 5530.059889818741, 834.7412302186342, 898.5776684958059, 915.2952226785338, 928.8978212396631, 948.7485816258697, 3718.5537735471917, 3796.37359835624, 3831.1571454280015, 3839.7504162229366, 3865.9613403866165, 9160.312976526788, 9240.07599240084, 9380.108889655472, 9431.858522122173, 9454.621815127319, 9323.533823308808, 9330.346875718635, 9342.06579342074, 9357.578908949114, 9449.38578992377, 6973.302669732986, 7117.89323160153, 7196.532225405332, 7220.747273845495, 7287.781366558906, 5158.871028224175, 5197.8440646780655, 5266.368035835724, 5321.574274058144, 5323.600729945347, 8186.345092392475, 8201.753947381589, 8435.620397082022, 8470.49177049379, 8474.703385381483, 8463.0, 8491.74524764258, 8524.531150786766, 8681.045085040767, 8685.174908383693, 5549.0, 5984.910226346521, 6075.30134034574, 6162.0, 6376.553641245254, 7475.0, 7515.6242187891485, 7516.3986881048295, 7517.323440890346, 7547.358474529727, 6617.536772426077, 6631.834204144935, 6656.400923916871, 6665.100211471389, 6926.203486598904, 6470.482361410982, 6486.967565162144, 6627.635480048643, 6687.431568316748, 6762.053312536151, 6257.937420625735, 6308.936910631019, 6309.779157729457, 6320.241571011508, 6323.430891219628, 4682.157211701926, 4713.622910167247, 4787.808487660454, 4795.760211989456, 4828.855134345975, 4683.625309975126, 4692.061587682409, 4765.8093676252565, 4855.6601037927, 4866.051120031701], "value": 4087.5834569682675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.1948462501185, 291.84240510124533, 297.48238065765577, 299.0862913798345, 299.12655047261984, 4955.677880937741, 4977.328060711812, 4993.375828021492, 5002.774875130619, 5021.17150670139, 4898.681585696936, 4921.926171107436, 4933.815884187796, 4942.87642808929, 4971.552560269575, 3850.345441274983, 3873.4383514390397, 3890.4942357493487, 3912.56961734209, 3916.530016398022, 3498.195415054526, 3834.9424758628643, 3935.1736135411597, 3937.1731936293268, 3941.664958478518, 3721.3301605710963, 3804.980975095121, 3806.4861243732157, 3817.980910095446, 3819.178876541543, 3787.696984241282, 3815.1415931415486, 3818.217265460574, 3822.636849499293, 3856.421536769479, 3377.847996840148, 3380.8140552269615, 3394.389009978203, 3402.2855200407944, 3403.4894765785084, 4573.268277075686, 4639.930401043987, 4640.79116439761, 4665.370175026396, 4767.666263361566, 4363.410939523155, 4372.322290045048, 4380.663897511257, 4391.824327026947, 4420.734755914623, 4906.675197696602, 5152.681293417977, 5158.819441319536, 5212.50481204285, 5222.556082732972, 3593.7484376093685, 3677.9080522987138, 3680.576733675608, 3684.0237337105686, 3688.4282936144673, 5394.271773310631, 5396.568274538066, 5413.242146099549, 5413.648112872651, 5440.401555828896, 3742.1018955450495, 3754.5119134512884, 3759.605241449663, 3774.245150969817, 3778.2065766189407, 3524.9295014099575, 3738.158914244273, 3743.1952130292116, 3743.494628225209, 3815.5612104608326, 4283.121959998193, 4313.309870420718, 4325.675574331937, 4329.415528903621, 4339.500957389878, 5192.844214673566, 5201.581264711927, 5221.686698798084, 5254.737263136828, 5256.185291279858, 1267.3219827392302, 1279.5137847618032, 1282.3203702037936, 1292.38611659461, 1313.40240190713, 806.6329819931917, 813.2233716800441, 821.9054808696957, 823.3125340340763, 826.8801023851628, 4078.7960601969785, 4126.958730412717, 4141.420201171838, 4188.392683060939, 4192.937105943413, 4789.443430884976, 4803.543663351976, 4818.036392721469, 4824.059308434892, 4846.151923413388, 4146.66826653867, 4189.350650649154, 4232.217039847638, 4265.87202383929, 4267.935980960288, 2410.722766881831, 2530.4559519703353, 2555.5783295756364, 2568.871556422209, 2621.84268943864, 4539.591436770706, 4549.977250113729, 4551.314724312605, 4556.589906908394, 4567.077070674771, 4847.230760772292, 4874.268859671078, 4881.95118048822, 4892.059020389361, 4925.975370123127, 4349.478062632505, 4547.954520454819, 4555.97027976392, 4560.6351491879905, 4580.8167673293365, 4778.880527986828, 4807.927881081857, 5161.716105614228, 5209.791608335624, 5378.247045413724, 5202.907389448258, 5261.947380526146, 5266.578673706018, 5275.7362131894015, 5301.0, 5058.822941197041, 5081.72050537224, 5096.108181068373, 5099.23511473282, 5121.155009423553, 3492.2491664292297, 3674.246779410268, 3702.611225821358, 3709.1098136446517, 3720.311742327678, 5380.9014484350355, 5396.1905714143195, 5424.647397919122, 5425.728713564385, 5471.671699698031, 5263.526282634582, 5272.0, 5292.391374991771, 5292.655977361459, 5295.0, 5012.423571289202, 5222.6083043771105, 5231.0, 5255.423372988012, 5269.947300526946, 5114.74426278692, 5126.359924638739, 5133.640645154804, 5148.510891465305, 5191.22131680251, 5257.8159764408065, 5290.444503327095, 5303.973480132575, 5324.0, 5324.600654950972, 4853.344798452164, 5188.844334669966, 5223.981323641853, 5229.346331708536, 5257.369115705987], "value": 3810.5441938956765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.4560342114335, 652.4128284543913, 697.8011266788963, 701.2601705201013, 768.335389887747, 11229.270097443661, 12081.456334464949, 12275.386230688475, 12280.14039017267, 12313.630591082281, 12856.93571532141, 12870.806937895915, 12928.159669621467, 12936.547220847273, 13002.219866807998, 737.7454778101546, 748.1246941078923, 778.9026371703522, 798.2297083314629, 803.9678412863478, 631.2897989761518, 737.2885165814987, 751.4889874885076, 767.9116901556308, 793.3851265269434, 821.5153059694779, 825.7233826668044, 827.0612854410227, 828.5235989306143, 829.8630725930244, 813.9064007639108, 817.4196320612373, 818.0265484073963, 819.5369616166877, 819.5902048975512, 597.0954004682909, 598.1327075740151, 601.0983524712931, 601.3175046322411, 601.5187849720206, 11938.64184074479, 12037.0, 12038.4582693779, 12039.699007524794, 12047.216930899463, 13657.795133073012, 13668.863311366958, 13685.0, 13839.446422143103, 14078.436862525487, 10446.843297350546, 10452.895471045269, 10555.366677999267, 10604.68185954415, 10893.509792059298, 3352.463605823081, 3409.8465569049454, 3412.5051867479324, 3413.607435144965, 3504.141485336109, 60303.0, 60947.39052609461, 61352.386476135114, 61611.0, 61630.383696163364, 10835.83746243807, 10852.782944341227, 10874.782504349869, 10902.753987994985, 10920.781584368267, 20081.0, 20112.296069637785, 20120.597588048156, 20123.29568465126, 20178.091985860672, 6895.103636527319, 6939.959006149017, 6957.791266261919, 6981.406580440618, 7123.608201548861, 3732.2162345907122, 3846.769193848378, 3853.3641949078087, 3934.8229329680235, 4008.2584721826556, 3197.1367730712577, 3419.7264218862433, 3428.280061187129, 3444.4661077533024, 3452.7755695879687, 601.1974014690437, 601.6239850093691, 605.7213681706464, 606.3905774696402, 610.664134725899, 529.121658047639, 571.8598943258928, 590.5806877117295, 595.2291782142137, 595.6426144313464, 8149.921769948625, 8153.8776918346275, 8365.874511882326, 8395.538245396561, 8431.747047588582, 520.0171675533245, 591.1664552980363, 595.4373117404098, 602.6113157013701, 628.3873223607038, 3902.161035377351, 4084.591540845951, 4110.547839737626, 4129.834806607762, 4189.07840275139, 59631.403685962585, 60974.0, 61316.69341653263, 61654.0, 90239.19521609531, 56880.0, 67661.0, 86582.0, 88620.11379886119, 89166.0, 49913.50086499161, 60941.39058609446, 78024.19758024153, 79022.20977790264, 79238.60380698174, 7852.411069169721, 7943.165967573322, 8178.795530111557, 8495.405321627673, 8845.380823342304, 30914.0, 31100.0, 39067.02332441598, 39811.60188398079, 43890.341644874716, 52351.214731778295, 57996.680132794216, 59811.700941495015, 59885.70057149686, 59939.0, 10937.070349020423, 11044.558217671525, 11111.222214444912, 11465.885341146815, 11512.251703639236, 12582.370881456074, 12974.156679816158, 13050.34748262602, 13093.083484156017, 13147.474101035852, 11716.414179291172, 11843.407829608657, 12181.33002684861, 12210.572629958264, 12444.440000200193, 11399.886001139883, 11633.941830290794, 11789.351585662871, 11858.584949526725, 11958.46186921608, 10557.683269501927, 11031.503582338653, 11603.419829008348, 11779.941100294443, 11951.521939122686, 9853.408795472295, 9970.202383809134, 10055.798884022424, 10153.136983356497, 10600.946995264974, 10089.747756306151, 10343.482825858526, 10450.686479405325, 10466.0, 10530.31552949056], "value": 6517.431343868492, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 112.0, 113.0, 114.0, 114.0, 112.0, 115.0, 114.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 153.0, 181.0, 137.0, 160.0, 159.0, 133.0, 198.0, 132.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 167.0, 182.0, 162.0, 164.0, 163.0, 164.0, 163.0, 161.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 151.0, 77.0, 77.0, 77.0, 78.0, 164.0, 76.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 132.0, 87.0, 86.0, 85.0, 132.0, 86.0, 85.0, 148.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 154.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 149.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 63.0, 64.0, 63.0, 65.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 86.0, 83.0, 84.0, 89.0, 85.0, 86.0, 111.0, 85.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 130.0, 138.0, 142.0, 137.0, 140.0, 135.0, 145.0, 145.0, 134.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 168.0, 169.0, 170.0, 170.0, 169.0, 169.0, 169.0, 169.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 69.0, 67.0, 68.0, 66.0, 69.0, 68.0, 66.0], "value": 67.5, "unit": "score"}]}]} 03:20:42 INFO - Return code: 0 03:20:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:42 ERROR - # TBPL SUCCESS # 03:20:42 INFO - Running post-action listener: _resource_record_post_action 03:20:42 INFO - ##### 03:20:42 INFO - ##### Finished run-tests step (success) 03:20:42 INFO - ##### 03:20:42 INFO - Running post-run listener: _resource_record_post_run 03:20:42 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 8192; Write bytes: 525201408; Read time: 244; Write time: 558348 03:20:42 INFO - TinderboxPrint: CPU usage
13.5% 03:20:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 244 03:20:42 INFO - TinderboxPrint: I/O write bytes / time
525,201,408 / 558,348 03:20:42 INFO - TinderboxPrint: CPU idle
8,253.7 (86.5%) 03:20:42 INFO - TinderboxPrint: CPU user
1,234.7 (12.9%) 03:20:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:20:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244609024; Read time: 0; Write time: 304424 03:20:42 INFO - run-tests - Wall time: 1180s; CPU: 14.0%; Read bytes: 8192; Write bytes: 280592384; Read time: 244; Write time: 253924 03:20:42 INFO - Running post-run listener: _upload_blobber_files 03:20:42 INFO - Blob upload gear active. 03:20:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:42 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 03:20:42 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:20:42 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:20:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:20:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:44 INFO - (blobuploader) - INFO - Done attempting. 03:20:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:20:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:45 INFO - (blobuploader) - INFO - Done attempting. 03:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:50 INFO - (blobuploader) - INFO - Done attempting. 03:20:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:50 INFO - Return code: 0 03:20:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1e8e81b842a5fd6266de4dbf41acc3c83e0859d62f7c1ed0ad87cb8c5423027f44fd60694e6971335e69a6b06293e225071d1810161a31194a08a41f07e8839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/593e52cb240272ee674265f05df0c4d9513e8cb24a4b37dffdbf9f18e1e84a0cf1e69c47fa43671bc9d84c08713f57d57910c7f4bb52cf21e8549a3aee03727c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/430512da1b112f5792f07c274a66e5a139041e8820076bf5971fa09f315b13397cb5f40a6c94e27fb2c8d9a63a690ededb2d83a6aa212643cf087b3a1fb91607"} 03:20:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:50 INFO - Contents: 03:20:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1e8e81b842a5fd6266de4dbf41acc3c83e0859d62f7c1ed0ad87cb8c5423027f44fd60694e6971335e69a6b06293e225071d1810161a31194a08a41f07e8839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/593e52cb240272ee674265f05df0c4d9513e8cb24a4b37dffdbf9f18e1e84a0cf1e69c47fa43671bc9d84c08713f57d57910c7f4bb52cf21e8549a3aee03727c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/430512da1b112f5792f07c274a66e5a139041e8820076bf5971fa09f315b13397cb5f40a6c94e27fb2c8d9a63a690ededb2d83a6aa212643cf087b3a1fb91607"} 03:20:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:50 INFO - Copying logs to upload dir... 03:20:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.366810 ========= master_lag: 16.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-07 03:21:06.277463) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 03:21:06.287912) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958 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-Non-PGO/sha512/b1e8e81b842a5fd6266de4dbf41acc3c83e0859d62f7c1ed0ad87cb8c5423027f44fd60694e6971335e69a6b06293e225071d1810161a31194a08a41f07e8839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/593e52cb240272ee674265f05df0c4d9513e8cb24a4b37dffdbf9f18e1e84a0cf1e69c47fa43671bc9d84c08713f57d57910c7f4bb52cf21e8549a3aee03727c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/430512da1b112f5792f07c274a66e5a139041e8820076bf5971fa09f315b13397cb5f40a6c94e27fb2c8d9a63a690ededb2d83a6aa212643cf087b3a1fb91607"} build_url:https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/bDiZD77oRhqEelakNvpExw/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-Non-PGO/sha512/b1e8e81b842a5fd6266de4dbf41acc3c83e0859d62f7c1ed0ad87cb8c5423027f44fd60694e6971335e69a6b06293e225071d1810161a31194a08a41f07e8839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/593e52cb240272ee674265f05df0c4d9513e8cb24a4b37dffdbf9f18e1e84a0cf1e69c47fa43671bc9d84c08713f57d57910c7f4bb52cf21e8549a3aee03727c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/430512da1b112f5792f07c274a66e5a139041e8820076bf5971fa09f315b13397cb5f40a6c94e27fb2c8d9a63a690ededb2d83a6aa212643cf087b3a1fb91607"}' ========= master_lag: 0.90 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 03:21:07.199078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-06-07 03:21:07.199588) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465293609.29512-688672958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 6.93 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-06-07 03:21:14.132533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 03:21:14.132847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 03:21:14.261103) ========= ========= Total master_lag: 24.06 =========