builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1465210751.24 results: success (0) buildid: 20160605223836 builduid: e4dc0f65509847ae99b079f63afb3b63 revision: c2a7b4cefc6ed2ccc63dfc8f33349418760ad009 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:11.237033) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:11.237504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:11.237794) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:11.256134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:11.256715) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 03:59:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.2M=0s 2016-06-06 03:59:12 (67.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.332911 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:11.603464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:11.603798) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018426 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:11.653517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 03:59:11.653889) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c2a7b4cefc6ed2ccc63dfc8f33349418760ad009 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c2a7b4cefc6ed2ccc63dfc8f33349418760ad009 --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=337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 03:59:12,245 truncating revision to first 12 chars 2016-06-06 03:59:12,245 Setting DEBUG logging. 2016-06-06 03:59:12,246 attempt 1/10 2016-06-06 03:59:12,246 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c2a7b4cefc6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 03:59:13,345 unpacking tar archive at: mozilla-inbound-c2a7b4cefc6e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.444833 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 03:59:13.112468) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:13.112919) ========= script_repo_revision: c2a7b4cefc6ed2ccc63dfc8f33349418760ad009 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:13.113436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:13.113796) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 03:59:13.124409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-06 03:59:13.124844) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:13 INFO - MultiFileLogger online at 20160606 03:59:13 in /builds/slave/test 03:59:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:59:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:13 INFO - {'append_to_log': False, 03:59:13 INFO - 'base_work_dir': '/builds/slave/test', 03:59:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:59:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:13 INFO - 'branch': 'Mozilla-Inbound', 03:59:13 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:13 INFO - 'config_files': ('talos/linux_config.py',), 03:59:13 INFO - 'default_actions': ('clobber', 03:59:13 INFO - 'read-buildbot-config', 03:59:13 INFO - 'download-and-extract', 03:59:13 INFO - 'populate-webroot', 03:59:13 INFO - 'create-virtualenv', 03:59:13 INFO - 'install', 03:59:13 INFO - 'run-tests'), 03:59:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:13 INFO - 'download_minidump_stackwalk': True, 03:59:13 INFO - 'download_symbols': 'ondemand', 03:59:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:13 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:13 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:13 INFO - 'installer_path': 'installer.exe', 03:59:13 INFO - 'log_level': 'info', 03:59:13 INFO - 'log_name': 'talos', 03:59:13 INFO - 'log_to_console': True, 03:59:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:13 INFO - 'opt_config_files': (), 03:59:13 INFO - 'pip_index': False, 03:59:13 INFO - 'sps_profile': False, 03:59:13 INFO - 'sps_profile_interval': 0, 03:59:13 INFO - 'suite': 'dromaeojs-e10s', 03:59:13 INFO - 'system_bits': '32', 03:59:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:13 INFO - 'title': 'talos-linux64-ix-060', 03:59:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:13 INFO - 'use_talos_json': True, 03:59:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:13 INFO - 'work_dir': 'build'} 03:59:13 INFO - ##### 03:59:13 INFO - ##### Running clobber step. 03:59:13 INFO - ##### 03:59:13 INFO - Running pre-action listener: _resource_record_pre_action 03:59:13 INFO - Running main action method: clobber 03:59:13 INFO - rmtree: /builds/slave/test/build 03:59:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:14 INFO - Running post-action listener: _resource_record_post_action 03:59:14 INFO - ##### 03:59:14 INFO - ##### Finished clobber step (success) 03:59:14 INFO - ##### 03:59:14 INFO - ##### 03:59:14 INFO - ##### Running read-buildbot-config step. 03:59:14 INFO - ##### 03:59:14 INFO - Running pre-action listener: _resource_record_pre_action 03:59:14 INFO - Running main action method: read_buildbot_config 03:59:14 INFO - Using buildbot properties: 03:59:14 INFO - { 03:59:14 INFO - "project": "", 03:59:14 INFO - "product": "firefox", 03:59:14 INFO - "script_repo_revision": "production", 03:59:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:59:14 INFO - "repository": "", 03:59:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:59:14 INFO - "buildid": "20160605223836", 03:59:14 INFO - "pgo_build": "True", 03:59:14 INFO - "basedir": "/builds/slave/test", 03:59:14 INFO - "buildnumber": 665, 03:59:14 INFO - "slavename": "talos-linux64-ix-060", 03:59:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:59:14 INFO - "platform": "ubuntu64_hw", 03:59:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:59:14 INFO - "branch": "mozilla-inbound", 03:59:14 INFO - "repo_path": "integration/mozilla-inbound", 03:59:14 INFO - "revision": "c2a7b4cefc6ed2ccc63dfc8f33349418760ad009", 03:59:14 INFO - "stage_platform": "linux64-pgo", 03:59:14 INFO - "builduid": "e4dc0f65509847ae99b079f63afb3b63", 03:59:14 INFO - "slavebuilddir": "test" 03:59:14 INFO - } 03:59:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:59:14 INFO - Running post-action listener: _resource_record_post_action 03:59:14 INFO - ##### 03:59:14 INFO - ##### Finished read-buildbot-config step (success) 03:59:14 INFO - ##### 03:59:14 INFO - ##### 03:59:14 INFO - ##### Running download-and-extract step. 03:59:14 INFO - ##### 03:59:14 INFO - Running pre-action listener: _resource_record_pre_action 03:59:14 INFO - Running main action method: download_and_extract 03:59:14 INFO - mkdir: /builds/slave/test/build/tests 03:59: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:59:14 INFO - https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:59:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:59:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:59:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:59:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:59:18 INFO - Downloaded 1361 bytes. 03:59:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:59:18 INFO - Using the following test package requirements: 03:59:18 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:18 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:59:18 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:59:18 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:18 INFO - u'jsshell-linux-x86_64.zip'], 03:59:18 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:59:18 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:18 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:59:18 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:59:18 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:59:18 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:59:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:59: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:59:18 INFO - https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:24 INFO - Downloaded 24443746 bytes. 03:59:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:59:25 INFO - Return code: 0 03:59:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:25 INFO - https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:59:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:59:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:29 INFO - Downloaded 24443746 bytes. 03:59:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:59:31 INFO - Return code: 0 03:59: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:59:31 INFO - https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:59:32 INFO - Downloaded 10833369 bytes. 03:59:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:59:32 INFO - Return code: 0 03:59:32 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:59:32 INFO - https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:59:34 INFO - Downloaded 59112026 bytes. 03:59:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:59:34 INFO - mkdir: /builds/slave/test/properties 03:59:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:34 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:34 INFO - Contents: 03:59:34 INFO - build_url:https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:59:34 INFO - Running post-action listener: _resource_record_post_action 03:59:34 INFO - Running post-action listener: set_extra_try_arguments 03:59:34 INFO - ##### 03:59:34 INFO - ##### Finished download-and-extract step (success) 03:59:34 INFO - ##### 03:59:34 INFO - ##### 03:59:34 INFO - ##### Running populate-webroot step. 03:59:34 INFO - ##### 03:59:34 INFO - Running pre-action listener: _resource_record_pre_action 03:59:34 INFO - Running main action method: populate_webroot 03:59:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:59:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:59:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:59:34 INFO - '--tppagecycles', 03:59:34 INFO - '7'], 03:59:34 INFO - 'tests': ['tsvgm']}}, 03:59:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:59:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:59:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:59:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:59:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:34 INFO - 'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:34 INFO - 'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['damp', 'tps']}, 03:59:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:34 INFO - 'tests': ['damp', 'tps']}, 03:59:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['dromaeo_dom']}, 03:59:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['a11yr', 03:59:34 INFO - 'ts_paint', 03:59:34 INFO - 'tpaint', 03:59:34 INFO - 'sessionrestore', 03:59:34 INFO - 'sessionrestore_no_auto_restore', 03:59:34 INFO - 'tabpaint']}, 03:59:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:59:34 INFO - 'ts_paint', 03:59:34 INFO - 'tpaint', 03:59:34 INFO - 'sessionrestore', 03:59:34 INFO - 'sessionrestore_no_auto_restore', 03:59:34 INFO - 'tabpaint']}, 03:59:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:59:34 INFO - 'ts_paint', 03:59:34 INFO - 'tpaint', 03:59:34 INFO - 'sessionrestore', 03:59:34 INFO - 'sessionrestore_no_auto_restore', 03:59:34 INFO - 'tabpaint']}, 03:59:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:59:34 INFO - 'ts_paint', 03:59:34 INFO - 'tpaint', 03:59:34 INFO - 'sessionrestore', 03:59:34 INFO - 'sessionrestore_no_auto_restore', 03:59:34 INFO - 'tabpaint']}, 03:59:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['a11yr', 03:59:34 INFO - 'ts_paint', 03:59:34 INFO - 'tpaint', 03:59:34 INFO - 'sessionrestore', 03:59:34 INFO - 'sessionrestore_no_auto_restore', 03:59:34 INFO - 'tabpaint']}, 03:59:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['a11yr', 03:59:34 INFO - 'ts_paint', 03:59:34 INFO - 'tpaint', 03:59:34 INFO - 'sessionrestore', 03:59:34 INFO - 'sessionrestore_no_auto_restore', 03:59:34 INFO - 'tabpaint']}, 03:59:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['tsvgx', 03:59:34 INFO - 'tsvgr_opacity', 03:59:34 INFO - 'tart', 03:59:34 INFO - 'tscrollx', 03:59:34 INFO - 'cart']}, 03:59:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:59:34 INFO - 'tsvgr_opacity', 03:59:34 INFO - 'tart', 03:59:34 INFO - 'tscrollx', 03:59:34 INFO - 'cart']}, 03:59:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:34 INFO - 'talos_options': ['--disable-e10s'], 03:59:34 INFO - 'tests': ['tp5o']}, 03:59:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:34 INFO - 'tests': ['tp5o']}, 03:59:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:34 INFO - 'talos_options': ['--disable-e10s', 03:59:34 INFO - '--xperf_path', 03:59:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:34 INFO - 'tests': ['tp5n']}, 03:59:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:34 INFO - 'talos_options': ['--xperf_path', 03:59:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:34 INFO - 'tests': ['tp5n']}}, 03:59:34 INFO - 'talos.zip': {'path': '', 03:59:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:59:34 INFO - Running post-action listener: _resource_record_post_action 03:59:34 INFO - ##### 03:59:34 INFO - ##### Finished populate-webroot step (success) 03:59:34 INFO - ##### 03:59:34 INFO - ##### 03:59:34 INFO - ##### Running create-virtualenv step. 03:59:34 INFO - ##### 03:59:34 INFO - Running pre-action listener: _resource_record_pre_action 03:59:34 INFO - Running main action method: create_virtualenv 03:59:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:59:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:34 INFO - Using real prefix '/usr' 03:59:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:37 INFO - Installing pip.................done. 03:59:37 INFO - Return code: 0 03:59:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59:37 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:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:37 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:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:37 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 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:37 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:59:37 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:59:37 INFO - Using env: {'DISPLAY': ':0', 03:59:37 INFO - 'HOME': '/home/cltbld', 03:59:37 INFO - 'LANG': 'en_US.UTF-8', 03:59:37 INFO - 'LANGUAGE': 'en_US:en', 03:59:37 INFO - 'LOGNAME': 'cltbld', 03:59:37 INFO - 'MAIL': '/var/mail/cltbld', 03:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:37 INFO - 'MOZ_NO_REMOTE': '1', 03:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:37 INFO - 'NO_EM_RESTART': '1', 03:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:37 INFO - 'PWD': '/builds/slave/test', 03:59:37 INFO - 'SHELL': '/bin/bash', 03:59:37 INFO - 'SHLVL': '1', 03:59:37 INFO - 'TERM': 'linux', 03:59:37 INFO - 'TMOUT': '86400', 03:59:37 INFO - 'USER': 'cltbld', 03:59:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:37 INFO - '_': '/tools/buildbot/bin/python'} 03:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:37 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:59:37 INFO - Cleaning up... 03:59:37 INFO - Return code: 0 03:59:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:59:37 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:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:37 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:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:37 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 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:37 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:59:37 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:59:37 INFO - Using env: {'DISPLAY': ':0', 03:59:37 INFO - 'HOME': '/home/cltbld', 03:59:37 INFO - 'LANG': 'en_US.UTF-8', 03:59:37 INFO - 'LANGUAGE': 'en_US:en', 03:59:37 INFO - 'LOGNAME': 'cltbld', 03:59:37 INFO - 'MAIL': '/var/mail/cltbld', 03:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:37 INFO - 'MOZ_NO_REMOTE': '1', 03:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:37 INFO - 'NO_EM_RESTART': '1', 03:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:37 INFO - 'PWD': '/builds/slave/test', 03:59:37 INFO - 'SHELL': '/bin/bash', 03:59:37 INFO - 'SHLVL': '1', 03:59:37 INFO - 'TERM': 'linux', 03:59:37 INFO - 'TMOUT': '86400', 03:59:37 INFO - 'USER': 'cltbld', 03:59:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:37 INFO - '_': '/tools/buildbot/bin/python'} 03:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:37 INFO - Downloading/unpacking psutil>=3.1.1 03:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:39 INFO - Installing collected packages: psutil 03:59:39 INFO - Running setup.py install for psutil 03:59:39 INFO - building 'psutil._psutil_linux' extension 03:59:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:59:40 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:59:40 INFO - building 'psutil._psutil_posix' extension 03:59:40 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:59:40 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:59:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:40 INFO - Successfully installed psutil 03:59:40 INFO - Cleaning up... 03:59:40 INFO - Return code: 0 03:59:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:59:40 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:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:40 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:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:40 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 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:40 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:59:40 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:59:40 INFO - Using env: {'DISPLAY': ':0', 03:59:40 INFO - 'HOME': '/home/cltbld', 03:59:40 INFO - 'LANG': 'en_US.UTF-8', 03:59:40 INFO - 'LANGUAGE': 'en_US:en', 03:59:40 INFO - 'LOGNAME': 'cltbld', 03:59:40 INFO - 'MAIL': '/var/mail/cltbld', 03:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:40 INFO - 'MOZ_NO_REMOTE': '1', 03:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:40 INFO - 'NO_EM_RESTART': '1', 03:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:40 INFO - 'PWD': '/builds/slave/test', 03:59:40 INFO - 'SHELL': '/bin/bash', 03:59:40 INFO - 'SHLVL': '1', 03:59:40 INFO - 'TERM': 'linux', 03:59:40 INFO - 'TMOUT': '86400', 03:59:40 INFO - 'USER': 'cltbld', 03:59:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:40 INFO - '_': '/tools/buildbot/bin/python'} 03:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:59:40 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:59:40 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:59:40 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:59:40 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:59:40 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:59:40 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:59:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:59:42 INFO - Installing collected packages: mozsystemmonitor 03:59:42 INFO - Running setup.py install for mozsystemmonitor 03:59:42 INFO - Successfully installed mozsystemmonitor 03:59:42 INFO - Cleaning up... 03:59:42 INFO - Return code: 0 03:59:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:59: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:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:59:42 INFO - Using env: {'DISPLAY': ':0', 03:59:42 INFO - 'HOME': '/home/cltbld', 03:59:42 INFO - 'LANG': 'en_US.UTF-8', 03:59:42 INFO - 'LANGUAGE': 'en_US:en', 03:59:42 INFO - 'LOGNAME': 'cltbld', 03:59:42 INFO - 'MAIL': '/var/mail/cltbld', 03:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:42 INFO - 'MOZ_NO_REMOTE': '1', 03:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:42 INFO - 'NO_EM_RESTART': '1', 03:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:42 INFO - 'PWD': '/builds/slave/test', 03:59:42 INFO - 'SHELL': '/bin/bash', 03:59:42 INFO - 'SHLVL': '1', 03:59:42 INFO - 'TERM': 'linux', 03:59:42 INFO - 'TMOUT': '86400', 03:59:42 INFO - 'USER': 'cltbld', 03:59:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:42 INFO - '_': '/tools/buildbot/bin/python'} 03:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:42 INFO - Downloading/unpacking jsonschema==2.5.1 03:59: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:59: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:59: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:59: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:59: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:59: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:59:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:59: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:59: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:59: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:59: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:59: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:59: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:59:45 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:45 INFO - warning: no files found matching '*.txt' 03:59:45 INFO - no previously-included directories found matching 'build' 03:59:45 INFO - no previously-included directories found matching 'dist' 03:59:45 INFO - no previously-included directories found matching '.git*' 03:59:45 INFO - Installing collected packages: jsonschema, functools32 03:59:45 INFO - Running setup.py install for functools32 03:59:45 INFO - warning: no files found matching '*.txt' 03:59:45 INFO - no previously-included directories found matching 'build' 03:59:45 INFO - no previously-included directories found matching 'dist' 03:59:45 INFO - no previously-included directories found matching '.git*' 03:59:45 INFO - Successfully installed jsonschema functools32 03:59:45 INFO - Cleaning up... 03:59:45 INFO - Return code: 0 03:59:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:59:45 INFO - Using env: {'DISPLAY': ':0', 03:59:45 INFO - 'HOME': '/home/cltbld', 03:59:45 INFO - 'LANG': 'en_US.UTF-8', 03:59:45 INFO - 'LANGUAGE': 'en_US:en', 03:59:45 INFO - 'LOGNAME': 'cltbld', 03:59:45 INFO - 'MAIL': '/var/mail/cltbld', 03:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:45 INFO - 'MOZ_NO_REMOTE': '1', 03:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:45 INFO - 'NO_EM_RESTART': '1', 03:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:45 INFO - 'PWD': '/builds/slave/test', 03:59:45 INFO - 'SHELL': '/bin/bash', 03:59:45 INFO - 'SHLVL': '1', 03:59:45 INFO - 'TERM': 'linux', 03:59:45 INFO - 'TMOUT': '86400', 03:59:45 INFO - 'USER': 'cltbld', 03:59:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:45 INFO - '_': '/tools/buildbot/bin/python'} 03:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:59: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:59: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:59: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:59: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:59: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:59: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:59:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - Downloading docopt-0.6.1.tar.gz 03:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:48 INFO - Running setup.py install for blobuploader 03:59:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:48 INFO - Running setup.py install for requests 03:59:48 INFO - Running setup.py install for docopt 03:59:48 INFO - Successfully installed blobuploader requests docopt 03:59:48 INFO - Cleaning up... 03:59:48 INFO - Return code: 0 03:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:48 INFO - Using env: {'DISPLAY': ':0', 03:59:48 INFO - 'HOME': '/home/cltbld', 03:59:48 INFO - 'LANG': 'en_US.UTF-8', 03:59:48 INFO - 'LANGUAGE': 'en_US:en', 03:59:48 INFO - 'LOGNAME': 'cltbld', 03:59:48 INFO - 'MAIL': '/var/mail/cltbld', 03:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:48 INFO - 'MOZ_NO_REMOTE': '1', 03:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:48 INFO - 'NO_EM_RESTART': '1', 03:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:48 INFO - 'PWD': '/builds/slave/test', 03:59:48 INFO - 'SHELL': '/bin/bash', 03:59:48 INFO - 'SHLVL': '1', 03:59:48 INFO - 'TERM': 'linux', 03:59:48 INFO - 'TMOUT': '86400', 03:59:48 INFO - 'USER': 'cltbld', 03:59:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:48 INFO - '_': '/tools/buildbot/bin/python'} 03:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:49 INFO - Running setup.py (path:/tmp/pip-RRRmGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:49 INFO - Running setup.py (path:/tmp/pip-P84WWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:49 INFO - Running setup.py (path:/tmp/pip-95FrzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:49 INFO - Running setup.py (path:/tmp/pip-2X8nRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:49 INFO - Running setup.py (path:/tmp/pip-17naWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:49 INFO - Running setup.py (path:/tmp/pip-tparK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:49 INFO - Running setup.py (path:/tmp/pip-_5OK5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:49 INFO - Running setup.py (path:/tmp/pip-GlG4Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:49 INFO - Running setup.py (path:/tmp/pip-DwOHw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:49 INFO - Running setup.py (path:/tmp/pip-ICGBdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:49 INFO - Running setup.py (path:/tmp/pip-vVq9O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:49 INFO - Running setup.py (path:/tmp/pip-ths8KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:49 INFO - Running setup.py (path:/tmp/pip-iNKlHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:50 INFO - Running setup.py (path:/tmp/pip-Wg9qyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:50 INFO - Running setup.py (path:/tmp/pip-a83eZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:50 INFO - Running setup.py (path:/tmp/pip-VZZIas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:50 INFO - Running setup.py (path:/tmp/pip-mZ4FD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:50 INFO - Running setup.py install for manifestparser 03:59:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozcrash 03:59:50 INFO - Running setup.py install for mozdebug 03:59:50 INFO - Running setup.py install for mozdevice 03:59:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozfile 03:59:50 INFO - Running setup.py install for mozhttpd 03:59:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Running setup.py install for mozinfo 03:59:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozInstall 03:59:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozleak 03:59:51 INFO - Running setup.py install for mozlog 03:59:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for moznetwork 03:59:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozprocess 03:59:51 INFO - Running setup.py install for mozprofile 03:59:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozrunner 03:59:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:51 INFO - Running setup.py install for mozscreenshot 03:59:51 INFO - Running setup.py install for moztest 03:59:51 INFO - Running setup.py install for mozversion 03:59:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:52 INFO - Cleaning up... 03:59:52 INFO - Return code: 0 03:59:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:52 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:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:52 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:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:52 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 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:52 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:59:52 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:59:52 INFO - Using env: {'DISPLAY': ':0', 03:59:52 INFO - 'HOME': '/home/cltbld', 03:59:52 INFO - 'LANG': 'en_US.UTF-8', 03:59:52 INFO - 'LANGUAGE': 'en_US:en', 03:59:52 INFO - 'LOGNAME': 'cltbld', 03:59:52 INFO - 'MAIL': '/var/mail/cltbld', 03:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:52 INFO - 'MOZ_NO_REMOTE': '1', 03:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:52 INFO - 'NO_EM_RESTART': '1', 03:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:52 INFO - 'PWD': '/builds/slave/test', 03:59:52 INFO - 'SHELL': '/bin/bash', 03:59:52 INFO - 'SHLVL': '1', 03:59:52 INFO - 'TERM': 'linux', 03:59:52 INFO - 'TMOUT': '86400', 03:59:52 INFO - 'USER': 'cltbld', 03:59:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:52 INFO - '_': '/tools/buildbot/bin/python'} 03:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:52 INFO - Running setup.py (path:/tmp/pip-uhRlAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:52 INFO - Running setup.py (path:/tmp/pip-q9g0gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:52 INFO - Running setup.py (path:/tmp/pip-Rck1kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:52 INFO - Running setup.py (path:/tmp/pip-xwi20t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:52 INFO - Running setup.py (path:/tmp/pip-iyK8Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:52 INFO - Running setup.py (path:/tmp/pip-6LIFvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:52 INFO - Running setup.py (path:/tmp/pip-atO7mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:52 INFO - Running setup.py (path:/tmp/pip-q8hxbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:52 INFO - Running setup.py (path:/tmp/pip-bWXsI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:52 INFO - Running setup.py (path:/tmp/pip-Bf4Ze4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:53 INFO - Running setup.py (path:/tmp/pip-etX7_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:53 INFO - Running setup.py (path:/tmp/pip-PzxJ5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:53 INFO - Running setup.py (path:/tmp/pip-Z0X3me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:53 INFO - Running setup.py (path:/tmp/pip-k4v33U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:53 INFO - Running setup.py (path:/tmp/pip-RQizFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:53 INFO - Running setup.py (path:/tmp/pip-ZH_Xu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:53 INFO - Running setup.py (path:/tmp/pip-DSWmuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:55 INFO - Downloading blessings-1.6.tar.gz 03:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:55 INFO - Installing collected packages: blessings 03:59:55 INFO - Running setup.py install for blessings 03:59:55 INFO - Successfully installed blessings 03:59:55 INFO - Cleaning up... 03:59:55 INFO - Return code: 0 03:59:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:55 INFO - Reading from file tmpfile_stdout 03:59:55 INFO - Current package versions: 03:59:55 INFO - argparse == 1.2.1 03:59:55 INFO - blessings == 1.6 03:59:55 INFO - blobuploader == 1.2.4 03:59:55 INFO - docopt == 0.6.1 03:59:55 INFO - functools32 == 3.2.3-2 03:59:55 INFO - jsonschema == 2.5.1 03:59:55 INFO - manifestparser == 1.1 03:59:55 INFO - mozInstall == 1.12 03:59:55 INFO - mozcrash == 0.17 03:59:55 INFO - mozdebug == 0.1 03:59:55 INFO - mozdevice == 0.48 03:59:55 INFO - mozfile == 1.2 03:59:55 INFO - mozhttpd == 0.7 03:59:55 INFO - mozinfo == 0.9 03:59:55 INFO - mozleak == 0.1 03:59:55 INFO - mozlog == 3.2 03:59:55 INFO - moznetwork == 0.27 03:59:55 INFO - mozprocess == 0.22 03:59:55 INFO - mozprofile == 0.28 03:59:55 INFO - mozrunner == 6.11 03:59:55 INFO - mozscreenshot == 0.1 03:59:55 INFO - mozsystemmonitor == 0.3 03:59:55 INFO - moztest == 0.7 03:59:55 INFO - mozversion == 1.4 03:59:55 INFO - psutil == 3.1.1 03:59:55 INFO - requests == 1.2.3 03:59:55 INFO - wsgiref == 0.1.2 03:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:55 INFO - Using env: {'DISPLAY': ':0', 03:59:55 INFO - 'HOME': '/home/cltbld', 03:59:55 INFO - 'LANG': 'en_US.UTF-8', 03:59:55 INFO - 'LANGUAGE': 'en_US:en', 03:59:55 INFO - 'LOGNAME': 'cltbld', 03:59:55 INFO - 'MAIL': '/var/mail/cltbld', 03:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:55 INFO - 'MOZ_NO_REMOTE': '1', 03:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:55 INFO - 'NO_EM_RESTART': '1', 03:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:55 INFO - 'PWD': '/builds/slave/test', 03:59:55 INFO - 'SHELL': '/bin/bash', 03:59:55 INFO - 'SHLVL': '1', 03:59:55 INFO - 'TERM': 'linux', 03:59:55 INFO - 'TMOUT': '86400', 03:59:55 INFO - 'USER': 'cltbld', 03:59:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:55 INFO - '_': '/tools/buildbot/bin/python'} 03:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:56 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:59:56 INFO - Cleaning up... 03:59:56 INFO - Return code: 0 03:59:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:59:56 INFO - Using env: {'DISPLAY': ':0', 03:59:56 INFO - 'HOME': '/home/cltbld', 03:59:56 INFO - 'LANG': 'en_US.UTF-8', 03:59:56 INFO - 'LANGUAGE': 'en_US:en', 03:59:56 INFO - 'LOGNAME': 'cltbld', 03:59:56 INFO - 'MAIL': '/var/mail/cltbld', 03:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:56 INFO - 'MOZ_NO_REMOTE': '1', 03:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:56 INFO - 'NO_EM_RESTART': '1', 03:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:56 INFO - 'PWD': '/builds/slave/test', 03:59:56 INFO - 'SHELL': '/bin/bash', 03:59:56 INFO - 'SHLVL': '1', 03:59:56 INFO - 'TERM': 'linux', 03:59:56 INFO - 'TMOUT': '86400', 03:59:56 INFO - 'USER': 'cltbld', 03:59:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:56 INFO - '_': '/tools/buildbot/bin/python'} 03:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:59:56 INFO - Cleaning up... 03:59:56 INFO - Return code: 0 03:59:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97896e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', '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:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:59:56 INFO - Using env: {'DISPLAY': ':0', 03:59:56 INFO - 'HOME': '/home/cltbld', 03:59:56 INFO - 'LANG': 'en_US.UTF-8', 03:59:56 INFO - 'LANGUAGE': 'en_US:en', 03:59:56 INFO - 'LOGNAME': 'cltbld', 03:59:56 INFO - 'MAIL': '/var/mail/cltbld', 03:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:56 INFO - 'MOZ_NO_REMOTE': '1', 03:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:56 INFO - 'NO_EM_RESTART': '1', 03:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:56 INFO - 'PWD': '/builds/slave/test', 03:59:56 INFO - 'SHELL': '/bin/bash', 03:59:56 INFO - 'SHLVL': '1', 03:59:56 INFO - 'TERM': 'linux', 03:59:56 INFO - 'TMOUT': '86400', 03:59:56 INFO - 'USER': 'cltbld', 03:59:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 03:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:56 INFO - '_': '/tools/buildbot/bin/python'} 03:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:56 INFO - Downloading/unpacking flake8 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:59:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:59:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:59:59 INFO - no previously-included directories found matching 'docs/_build' 03:59:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:59:59 INFO - Running setup.py install for pep8 03:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:59:59 INFO - no previously-included directories found matching 'docs/_build' 03:59:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:59:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:59:59 INFO - Cleaning up... 03:59:59 INFO - Return code: 0 03:59:59 INFO - Running post-action listener: _resource_record_post_action 03:59:59 INFO - Running post-action listener: _start_resource_monitoring 03:59:59 INFO - Starting resource monitoring. 03:59:59 INFO - ##### 03:59:59 INFO - ##### Finished create-virtualenv step (success) 03:59:59 INFO - ##### 03:59:59 INFO - ##### 03:59:59 INFO - ##### Running install step. 03:59:59 INFO - ##### 03:59:59 INFO - Running pre-action listener: _resource_record_pre_action 03:59:59 INFO - Running main action method: install 03:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:59 INFO - Reading from file tmpfile_stdout 03:59:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:59:59 INFO - Reading from file tmpfile_stdout 03:59:59 INFO - Output received: 03:59:59 INFO - Usage: mozinstall [options] installer 03:59:59 INFO - Options: 03:59:59 INFO - -h, --help show this help message and exit 03:59:59 INFO - -d DEST, --destination=DEST 03:59:59 INFO - Directory to install application into. [default: 03:59:59 INFO - "/builds/slave/test"] 03:59:59 INFO - --app=APP Application being installed. [default: firefox] 03:59:59 INFO - mkdir: /builds/slave/test/build/application 03:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:00:16 INFO - Reading from file tmpfile_stdout 04:00:16 INFO - Output received: 04:00:16 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:16 INFO - Running post-action listener: _resource_record_post_action 04:00:16 INFO - ##### 04:00:16 INFO - ##### Finished install step (success) 04:00:16 INFO - ##### 04:00:16 INFO - ##### 04:00:16 INFO - ##### Running run-tests step. 04:00:16 INFO - ##### 04:00:16 INFO - Running pre-action listener: _resource_record_pre_action 04:00:16 INFO - Running main action method: run_tests 04:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:16 INFO - Python 2.7.3 04:00:16 INFO - Return code: 0 04:00:16 INFO - grabbing minidump binary from tooltool 04:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20161c0>, '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 0x20170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2017550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:00:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:00:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:00:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:16 INFO - Return code: 0 04:00:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:00:17 INFO - Return code: 0 04:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 04:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 04:00:17 INFO - Using env: {'DISPLAY': ':0', 04:00:17 INFO - 'HOME': '/home/cltbld', 04:00:17 INFO - 'LANG': 'en_US.UTF-8', 04:00:17 INFO - 'LANGUAGE': 'en_US:en', 04:00:17 INFO - 'LOGNAME': 'cltbld', 04:00:17 INFO - 'MAIL': '/var/mail/cltbld', 04:00:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:17 INFO - 'MOZ_NO_REMOTE': '1', 04:00:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:17 INFO - 'NO_EM_RESTART': '1', 04:00:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:17 INFO - 'PWD': '/builds/slave/test', 04:00:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:17 INFO - 'SHELL': '/bin/bash', 04:00:17 INFO - 'SHLVL': '1', 04:00:17 INFO - 'TERM': 'linux', 04:00:17 INFO - 'TMOUT': '86400', 04:00:17 INFO - 'USER': 'cltbld', 04:00:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566', 04:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:17 INFO - '_': '/tools/buildbot/bin/python'} 04:00:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 04:00:17 INFO - mozversion application_buildid: 20160605223836 04:00:17 INFO - mozversion application_changeset: c2a7b4cefc6ed2ccc63dfc8f33349418760ad009 04:00:17 INFO - mozversion application_display_name: Nightly 04:00:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:17 INFO - mozversion application_name: Firefox 04:00:17 INFO - mozversion application_remotingname: firefox 04:00:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:00:17 INFO - mozversion application_vendor: Mozilla 04:00:17 INFO - mozversion application_version: 49.0a1 04:00:17 INFO - mozversion platform_buildid: 20160605223836 04:00:17 INFO - mozversion platform_changeset: c2a7b4cefc6ed2ccc63dfc8f33349418760ad009 04:00:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:00:17 INFO - mozversion platform_version: 49.0a1 04:00:17 INFO - using testdate: 1465210817 04:00:17 INFO - actual date: 1465210817 04:00:17 INFO - starting webserver on 'localhost:37181' 04:00:17 INFO - SUITE-START | Running 2 tests 04:00:17 INFO - TEST-START | dromaeo_css 04:00:17 INFO - operating with platform_type : linux_ 04:00:17 INFO - Initialising browser for dromaeo_css test... 04:00:17 INFO - TEST-INFO | started process 481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Jm24v/profile http://localhost:37181/getInfo.html) 04:00:22 INFO - PROCESS | 481 | __metrics Screen width/height:1600/1200 04:00:22 INFO - PROCESS | 481 | colorDepth:24 04:00:22 INFO - PROCESS | 481 | Browser inner width/height: 1024/697 04:00:22 INFO - PROCESS | 481 | __metrics 04:00:22 ERROR - PROCESS | 481 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 04:00:23 INFO - TEST-INFO | 481: exit 0 04:00:23 INFO - Browser initialized. 04:00:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:23 INFO - TEST-INFO | started process 602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Jm24v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:35 INFO - PROCESS | 602 | RSS: Main: 167501824 04:00:35 INFO - PROCESS | 602 | 04:01:25 INFO - PROCESS | 602 | 1465210885317 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] 04:03:32 INFO - PROCESS | 602 | Cycle 1(1): loaded http://localhost:37181/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37181/tests/dromaeo/cssquery-ext.html) 04:03:33 INFO - PROCESS | 602 | RSS: Main: 170971136 04:03:33 INFO - PROCESS | 602 | 04:06:36 INFO - PROCESS | 602 | Cycle 1(1): loaded http://localhost:37181/tests/dromaeo/cssquery-ext.html (next: http://localhost:37181/tests/dromaeo/cssquery-jquery.html) 04:06:36 INFO - PROCESS | 602 | RSS: Main: 170070016 04:06:36 INFO - PROCESS | 602 | 04:09:38 INFO - PROCESS | 602 | Cycle 1(1): loaded http://localhost:37181/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37181/tests/dromaeo/cssquery-mootools.html) 04:09:39 INFO - PROCESS | 602 | RSS: Main: 171577344 04:09:39 INFO - PROCESS | 602 | 04:12:40 INFO - PROCESS | 602 | Cycle 1(1): loaded http://localhost:37181/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37181/tests/dromaeo/cssquery-prototype.html) 04:12:41 INFO - PROCESS | 602 | RSS: Main: 169148416 04:12:41 INFO - PROCESS | 602 | 04:15:43 INFO - PROCESS | 602 | Cycle 1(1): loaded http://localhost:37181/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37181/tests/dromaeo/cssquery-yui.html) 04:15:44 INFO - PROCESS | 602 | RSS: Main: 170684416 04:15:44 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | Cycle 1(1): loaded http://localhost:37181/tests/dromaeo/cssquery-yui.html (next: http://localhost:37181/tests/dromaeo/cssquery-dojo.html) 04:18:47 INFO - PROCESS | 602 | RSS: Main: 172195840 04:18:47 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | __start_tp_report 04:18:47 INFO - PROCESS | 602 | _x_x_mozilla_page_load 04:18:47 INFO - PROCESS | 602 | _x_x_mozilla_page_load_details 04:18:47 INFO - PROCESS | 602 | |i|pagename|runs| 04:18:47 INFO - PROCESS | 602 | |0;dojo.html;3077.1845460952845;3137.748980081594;3164.3038531523057;3167.572377729007;3191.7287030602397;5362.785488580452;5392.811251606189;5411.458854114591;5455.427180146087;5461.290032295801;5343.091674415349;5394.32570928634;5421.268128802621;5470.316210473691;5554.50009499146;4801.975990120053;4910.091633047879;4982.676126051813;5025.045241404122;5096.719680417576;823.7084347694511;4975.502449755032;5039.521245481692;5048.217526283432;5065.341505604266;4960.826371077013;4977.950220497785;4988.900221995558;5002.974985125069;5009.298698182258;4798.760061996886;4971.27916452116;5001.799928002875;5006.974965125151;5059.696418214919;4912.852614421573;4913.336699545552;4917.336159618441;4924.556789888928;4932.901341973176;5324.54741346986;5405.594580406446;5410.648307860016;5439.755211015514;5454.427285135083;5644.068728659766;5745.023346031185;5819.301683797929;5829.5919285650025;5871.148683440877;5788.652680839121;5852.326982397036;5856.853578660525;5860.355360910296;5868.941310586925;5390.8921821563745;5418.566514678856;5433.293671822677;5439.728013599304;5448.346198456171;5702.315722113373;5881.5882888198275;5933.614315069507;5953.523718102541;5957.49361304294;5706.3152421709665;5718.399568045378;5731.140328950607;5734.569907256889;5736.397678243808;5838.357780644125;5845.707714614252;5846.064629659234;5846.093855452412;5847.473727364472;5751.913721294184;5778.479936805707;5824.796132135355;5833.7374818133285;5837.066069428871;5723.084306510938;5725.08398656213;5733.369329373765;5776.364599894008;5866.2373891393845;4354.608085272277;4376.715513491677;4392.670549708785;4408.426904502394;4416.315471101984;3834.0798208430333;3874.670652994471;3888.533375994842;3928.64642182205;3973.165635216579;5535.059039963216;5537.473939975695;5538.030844602178;5550.72246387679;5573.5819813514145;5818.796342128006;5859.853503662443;5890.646561206341;5897.469227769521;5920.881582368328;5389.703566303812;5531.557475401958;5543.695096769717;5578.86052848682;5588.357338905997;5062.797488100508;5067.4932506749765;5068.417132029864;5071.974640126776;5094.1849304111165;6163.106349579286;6165.10605962133;6169.321374648785;6180.3201647818705;6192.81421557354;5734.397888221677;5833.591648584558;5859.882802344015;5910.143029260819;5926.762929482772;6076.270847498152;6104.877902441837;6114.541409394402;6118.571699980958;6122.877542449215;5636.746346414339;5782.5373970081455;5794.391588883106;5802.071668533014;5825.621334613236;5781.82654520365;5819.156222347651;5843.474087332161;5918.053111502311;5925.407459254213;5741.799037033684;5754.165645981226;5769.682667453162;5783.16144159103;5796.159556864315;5512.4211957743855;5681.971590142023;5739.2252045973255;5741.0527263002805;5748.022836117786;5479.315085614298;5526.751296191762;5552.167174923632;5588.524975377139;5700.857478563069;5786.9131963019745;5795.5073818724195;5843.29880414353;5851.21008663825;5869.941300586939;5513.448655134454;5690.8008219713765;5698.0598201296325;5698.943010569841;5701.4298570142655 04:18:47 INFO - PROCESS | 602 | |1;ext.html;571.3058633759981;604.996975015125;617.5245061302797;621.9378062193779;636.2492259134223;43298.35052474211;44817.77591112048;44860.3270950936;44971.32543011857;48139.759301203536;45116.32325515112;46077;46153.307700384525;46203.76898115513;46322;8743.213110820041;8928.642854285821;8937.150970657776;8944.8658270126;8972;8853.247473964688;8877.51173685447;8883.244924181452;8913.509756963364;8929.598168082419;8952.552372381388;8993.910060899372;9013.188813006827;9017.864732029026;9023.684171054014;8878.955605221965;8914.153155450222;8934.10658934108;8945.15021072997;8968.910310896905;8791.384603077788;8879.733607991771;8885.111488851127;8904.109589041109;8909.1536304051;42087.579124208976;42408.1518369634;42511.57488425138;42527;42658.14683706308;3565.358235517606;3637.163452405935;3737.8131093445218;4013.97993010036;4168.083021735213;32358.514622280683;32717;32890;33168.50247246293;33215.501767473506;4456.910861782779;4496.55034496551;4497.482789479219;4532.235450325235;4541.341505481687;354995;355487;355843;356443;358352.9999999974;59561.404385956455;59914.101288480706;60080;60174;60258.39741602528;64332.67833660802;64501.677491612245;64728.67635661886;64913.508649135656;65252.34747652463;15789.921050394674;16818.663626727397;17155.142242887807;17180.484585462455;17629;12721.236725796482;12877.742445151045;12912.806307905388;12913.806292905614;12918.935405323102;19762.209511619374;19768;19902.50243743918;19987;20078.799212007983;7130.108736407949;7479.813004674817;7524.087474513222;7550.735724249735;7571;989.9752506187403;1008.0322890025511;1048.9929667519266;1085.571199376242;1198.5804968261039;32908.83545582257;33180.1704957378;33196.3360732784;33455.498167527505;33852;1057.2282233969245;1123.8145705958589;1163.8777928317575;1177.7879981603223;1184.0882520459197;16171;17093.658126837392;17177.227024783915;17188.22652980619;17251.137443127795;572160;576286;585997;586930;591180;59901;60030.69984650049;60345.69827150924;60438.39561604416;60466.69766651138;1338.8928885689122;1357.097530142464;1360.5170164591427;1376.4975783838827;1390.0686540018212;30268.697313026587;31933.36133277368;32244.838775806908;32289.677103228667;32475.350492989535;51266;51508.484915150366;51560;51582.22626660678;51620.48379516157;442589;454423;456066;456100;456234;27898;27972.860135700004;28007.29981750391;28186.71813281841;28285.717142829133;48595.75702121467;48615.756921215165;48836.511634883194;49719.50280497149;50078.49921500738;41074.58925410708;41238.79380603078;41739;42323;42929.57070429256;41209.38185927273;41729.1654166921;41806.79096604497;42020.369694454;42121.78939105285;36667.63332366642;41290.38064429096;41292.587074128875;41971.16057678768;42579;34592.82703586466;36790.26419471649;38468.23063538658;38581.614183857804;38895.611043890334;26706.963608887985;28775;28995;29067.273318167216;29270.853645731637 04:18:47 INFO - PROCESS | 602 | |2;jquery.html;389.23515292450327;389.9785511796854;391.21951706345845;400.7595442734359;417.3197687768936;17954.730679039807;19219;19646.410607681773;19694.409167724974;20048.29830955917;18261.543461413472;18767.343142989997;18947.90526047371;19088.618227635438;19151.329703460382;5645.717714114298;5657.179708942201;5795.507381872525;5839.678817665027;5849.649021058729;5735.340435849889;5740.167675687023;5760.798372056979;5763.308402991647;5787.594868359217;5593.300837395325;5709.628874123189;5770.076787713967;5774.595778295521;5792.623479473842;5713.942860571424;5747.482726554588;5756.165356023395;5768.36547979724;5775.855603609902;5081.212412076134;5130.30740849988;5202.141646628302;5210.140326846104;5210.374755029421;22622.208222712125;22675.54648907029;22920.885395572914;23449.179278725333;23531.411714707097;2069.461939895638;2196.560687862418;2463.187148241076;2500.3374105861963;2685.798565107605;9979.201663866874;10048.145907597864;11959.521619135225;14367.640808979859;14562.417503299856;1827.552249698819;1888.9433317000512;1916.7220752990738;1969.842412606988;2042.9795702043086;72076.27923720748;75436;76941.6152919243;78350.6082469584;83898;10844.837327440095;11109.777804443866;11275.774484510264;11416.143789215675;11428.542858285742;15758.212089395485;15849.366025359088;15867.206639667971;15870.7619385707;15875.682486350439;8289.461185022954;8337.499750015018;8437.662493500191;8494.362922780816;8523.616437260338;7944.364450843918;8072.677092916335;8093.797655058671;8130.837383252302;8220.671173153007;4646.4191976003;4664.883377915511;4779.880502987384;4829.27560865873;4865.9756701216265;1740.321274702867;1954.3941378172813;1967.79338169493;1969.9559233605926;2007.4780557055271;926.559884055082;1015.3349556040805;1016.9542370593341;1043.994780026095;1150.913681473893;19182.904085479484;19666.31167909145;19794.60410791776;19990.20039198416;20158.29445969384;980.4264505264357;984.1093810101869;985.6254623243121;1022.2690776095128;1031.417249254169;8975.057618949917;11124.332540047622;11216.495257713423;11233.66299011031;11260.887391126147;475611;495337;499867;500160;501363;92591;93565;96402.51798740962;96633;97063;1010.722051435861;1019.1591936652292;1036.1555332404216;1042.744527590745;1046.7801761630144;17135.15402666114;17415.738763918296;17555.473335799947;17625.73561396606;17931.73102403439;38467;42133;42743.572564273956;43362;44179.558204417546;50196.498035020646;61074.08388874259;61164.694176528836;61516.38483615286;61830;8376.53929033909;8667.869981950402;8786.780330491789;8949.821003580022;11401.600943966921;12480.319880044983;13540.390682419511;14004.36980335867;14116.647083822987;14242.07426517273;12199.634010979686;12420.937895310466;12525.248485090924;12814.423350949417;12870.420831062438;12151;12229.571964981184;12252.264864108181;12522.624321270376;12864.871351286742;12259.816102758288;12739;12792.232466052066;12912.354382281037;13183.274919879499;13043.804342934674;13074.542391016268;13170.143940644211;13236.47054117863;13302.800457993331;12588.685282867635;12715.745685086062;12903.741925161632;12939;12985.935070324587 04:18:47 INFO - PROCESS | 602 | |3;mootools.html;1486.4128669175673;1505.7214415333165;1642.3676884399504;1714.1172296267416;1797.9460616181518;7279.454040946937;8102.230288122626;8161.428699991003;8736.694215702451;8746.693865714702;8182.754517364474;8487.193716596914;8490.6179221935;8536.061033286334;8550.74347769568;2330.0446816805156;2361.244401791427;2361.6929799126087;2366.6331718583647;2368.834181607288;2288.8054515366216;2322.883855807203;2324.34918222897;2334.4163959010248;2337.123578658003;2332.125452955142;2346.3078391874437;2349.4126468382906;2380.857188549497;2384.95230095398;2286.3369622809364;2293.6330187169974;2298.839081264312;2303.6429353450158;2318.953620927572;2268.6483595042796;2276.5560715660454;2277.7152855893014;2288.3592594073684;2289.828262880274;8456.704015359495;8470.49177049379;8507.276881465083;8532.57337133141;8541.658333666646;4957.454679985235;5039.496050394968;5101.642884998052;5109.080365534202;5114.232865070232;3269.4441944869427;3388.288459423524;3513.7013353864954;3522.5068490411363;3579.069441945113;1099.961501347449;1160.3560024186572;1160.6576060062218;1226.2519862883635;1228.01145078212;11427.771444571063;11609.593664221711;11619.419029048513;11645.068394528502;11696.590619328368;4405.515393306734;4545.795439205243;4571.885702857388;4602.447706275201;4632.258838585877;9905.653302134391;9923.206143508502;9927.40435573868;9927.80144397108;9945.80108397828;5179.171332586768;5183.559397451183;5187.273781670569;5187.974060129675;5207.0366982108435;4076.775777332216;4619.23782575878;4695.22528782747;4762.9761851191215;4767.642426818003;3887.067103895045;3919.1573811630637;3990.20195960809;4043.6158564936873;4050.7569545827346;1269.5937300064077;1324.6356253059364;1332.80007998799;1340.986590134086;1347.8113064171023;928.1043792740038;967.3470407474927;979.4221409368507;988.9950550247347;994.2443742755413;5688.516476099495;5711.628744131618;5755.740991655385;5838.095095260242;5908.350081491032;445.86401147650275;446.9262571675702;449.07490569427085;454.63856234293814;455.19885002396023;4105.712600118023;4146.170765846843;4146.502419709594;4171.478565179353;4174.540800511942;9706.320557561045;9840.163586095263;10018.64934727281;10029.849552256723;10035.498225088717;9823.36148150368;9939.751506212402;9949.900500995042;9951.701448956543;9956.402615843073;7455.179930207672;7620.618969051525;7661.233876612294;7701;7711.807204819925;5896.882062358814;5929.555283353852;6084.969575152096;6135.1717518136265;6161.9691901542;9284;9508.619655213713;9598.232141428809;9799.412035277906;9858.654947076819;9384.624615015597;9713.805723885342;9905.108540231413;9922.40465572068;9935.20518358544;7574.772756817304;7653.961730191313;7699.076110866507;7722.3049925506975;7769.223077692185;8205.60504714188;8214;8249.83500329978;8252.669893204205;8253;7087.705011644106;7365.116186057493;7465.104187497535;7598.240175982358;7683.500572462772;7268.96365518169;7296.379807716404;7301.561906285639;7488.026556547832;7529.698812047457;6690.13028306317;6723.092382528296;6724.93275067243;6727.697253623696;6734.057231987427;4883.780229889735;4982.601391888713;5111.744412779421;5113.411957624772;5188.948110518846;5208.114620514598;5288.68267903927;5327.840164795062;5412.431694672003;5421 04:18:47 INFO - PROCESS | 602 | |4;prototype.html;328.32856807828006;332.4706350786383;337.91721028348053;340.21410541648777;342.1924258749353;5576.749046292916;5606.177992152547;5657.519110875575;5661.915071273924;5674.773009079642;5461.344638643359;5476.548714590636;5504.4770746779095;5504.972475137629;5529.474699903502;4081.9183616327655;4192.538820729717;4352.281873490871;4354.08564201518;4366.781660916958;4354.629856462205;4364.847230346939;4365.170617582649;4380.58384453478;4386.539413361599;4355.956440435587;4372.519022907478;4372.71577347473;4376.277914144178;4386.912261754763;4323.373110898933;4328.545502722201;4340.674449416307;4343.761093139876;4359.912801743947;3818.6563209311294;3839.7504162229366;3850.6919446444217;3857.035741064734;3867.284552357795;5406.729663516809;5412.783488660488;5457.699826509541;5476.288082549243;5489.533389661844;4748.59916324685;4912.6806757561;4913.182122614656;4929.767558110472;4985.052839960432;5756.568257380672;5759;5777.942220577783;5788.147792706336;5797.971010144965;4210.7473551587;4213.115245798355;4223.303154979425;4228.619424251801;4246.9594949237635;5719.571032172562;6067.6359418434595;6084.60450070744;6104.938950610526;6105.114758360013;4189.581041895847;4204.66362690984;4210.389493523422;4234.7670878102;4245.087306229176;4276.337167739005;4296.119295544406;4305.526392096866;4305.612494875476;4306.20335237982;4747.976260118678;4873.537013983666;4907.386576677915;4909.950900491021;4963.975180124076;5873.942690315699;5876.7658791653375;5890.057590785454;5912.763489460373;5929.703514824328;1479.201231335067;1481.9629509262354;1493.7087267982856;1501.873594803897;1503.5263891874024;953.9792422108416;965.6716716316486;1004.7488127968008;1009.6869970309227;1015.5836107196014;5629.634073785191;5640.097584386561;5645.322561292671;5672.262605861211;5689.468186656898;6056.909146362808;6063.090536419484;6070.180525629072;6091.908621370683;6093.512518998469;5381.704006279692;5522.144067669517;5588.972055139699;5612.410696876769;5613.691246981373;3170.4134735074085;3170.4927211646027;3180.8886688965777;3189.4418476766473;3192.6488086310487;6047.6069055512135;6160.398296442868;6167.660778657217;6209.6895155242055;6210.31686514483;6025.969870150621;6052.66710330936;6059.606125601822;6106.908396374058;6151.815445536641;5986.940130598726;6033.9742243818655;6079.939200608026;6087.452129308295;6134.846628834315;5998.4601385875485;6001.489873360813;6006.729697163725;6010.879782404415;6018.59256297467;5946.494547963472;5946.851328716817;5969.76120955157;6016.939830601813;6027.60820546663;5931.716289228591;6167.84580385476;6225.626462412089;6251.937480625135;6271.717772700148;4211.473565804275;4224.028473451185;4231.597998190167;4270.50889147752;4288.571142885687;5799.594028417971;5895.764169433174;5932.822015339547;6015.72929218195;6041.697915104315;5842.3349345436345;5846.386129456346;5861.736221870111;5900.350961394157;5914.704264786829;5527.364353099445;5790.305163380422;5863.794767183128;5888.764449421975;5901.852453688693;5682.403347648603;5718.684702518527;5720.570957178145;5734.627249228787;5773.624714393551;5888.941110588839;5896.764129434946;5898.262717160355;5900.911486327623;5958.867815115114;5466.398696143341;5708.771649133988;5724.169995350734;5807.680577568105;5815.651060936358 04:18:47 INFO - PROCESS | 602 | |5;yui.html;729.9817504562385;777.3897490469978;800.2037972217644;814.4298990706505;852.9957350213256;15003.624909377271;16038.117903515302;16110.275037623305;16123.355065797368;16139.75790363144;14689.632759181026;14713.852861471409;14766.040207386512;15070.623234419118;15086.547403577883;658.5818005566451;792.3779832831228;805.963731632078;813.4875028731891;817.7710241132493;790.115071120346;793.9523628582275;796.2753893956501;796.6534557467492;798.2616080125889;841.486693117198;843.7384410832631;846.7375113714737;848.2704873808519;851.1190917400492;831.2020460358063;835.8579041562949;838.5429940682343;838.6561509781021;838.6771093129158;610.362171530747;611.1413464082971;613.3590398034065;615.2770494668746;616.312811215496;15167.317470713844;15219.162946037963;15231.923840380838;15238.771418428732;15253.694926101527;15387.923060384739;15805.841941580553;15881;15957.441489547926;15966.600834979103;12736.61790146297;12803.871961280454;12857.614271571867;13488.325583720774;13540.322983850867;3828.349180639298;3861.131245469775;3899.3760998240427;3934.1934903344745;4021.4973128358956;81277.59361203156;82199;82624.58687706583;82802.58598707028;87345.56327218324;11912.821307680391;12065.517379304905;12087.395630218454;12109.576164834189;12247.32639704807;23362.64956025661;23370;23380.64929026066;23434.64848027281;23492.295231143093;7916.920830791619;8225.83548329042;8241.134680858544;8525.829483410296;8705.608247628872;4616.76916154191;4695.483496815347;4741.980474198064;4757.769059527038;4776.976115119472;3255.9674403255663;3387.7459190560808;3399.9490007649906;3406.148462884279;3421.298633780069;601.4526780629606;615.5752530753765;617.5769597825414;619.6746707978257;620.8851362497952;675.7566078415739;696.1333140240433;698.6576577477;700.2087640965676;717.8313096422337;9080.8637870432;9389.38968967015;9393.62425502986;9415.246780257563;9503.477308747946;621.7357623010203;663.3134705579798;684.3669605614787;703.9260877607879;711.1821405383849;4534.319852022223;4553.2942393929;4561.156186105581;4620.67655264135;4630.050839577879;115974;116255;118779;119060.40469797596;121620;60100;90547;100611.49694251629;100860.49569752104;103203.48398257961;79029;87171.79894655843;87605;87990.56004720063;88957;8421.115782842713;8614.78463038404;8686.218240358397;8697.782555436164;8751.387402881737;44876;51480.48519514907;52836.73581632221;53525;54530.72734636301;66908;66983;76657;78318.6084069576;79073.60463197647;11100.500477478372;11107.38909359993;11322.886771132513;11553.653390398302;11575.421228938689;11812.173147879566;11909.285442873455;12016.879831201577;12191.451384687887;12454.128211025141;11470;11489.368084755084;11552.306861588331;11637.127215459044;11836.230645008047;12015.09886758514;12022.338771367658;12043.638690839289;12190.146689731633;12772.361381930681;12259.019278457881;13362.732745345233;13674.726505470035;13922.791158132433;13947.721045579234;11031.282966607145;11477.540898363972;11527.942360288145;11578.305301681588;12230.327331996825;10467.371957682564;10618.84071738909;10664.36013839141;10836.945815270874;10941.890581094087 04:18:47 INFO - PROCESS | 602 | __end_tp_report 04:18:47 INFO - PROCESS | 602 | __start_cc_report 04:18:47 INFO - PROCESS | 602 | _x_x_mozilla_cycle_collect,358 04:18:47 INFO - PROCESS | 602 | __end_cc_report 04:18:47 INFO - PROCESS | 602 | __startTimestamp1465211927478__endTimestamp 04:18:47 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | ------- Summary: start ------- 04:18:47 INFO - PROCESS | 602 | Number of tests: 6 04:18:47 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | [#0] dojo.html Cycles:165 Average:5397.09 Median:5681.97 stddev:724.46 (12.8%) stddev-sans-first:703.46 04:18:47 INFO - PROCESS | 602 | Values: 3077.2 3137.7 3164.3 3167.6 3191.7 5362.8 5392.8 5411.5 5455.4 5461.3 5343.1 5394.3 5421.3 5470.3 5554.5 4802.0 4910.1 4982.7 5025.0 5096.7 823.7 4975.5 5039.5 5048.2 5065.3 4960.8 4978.0 4988.9 5003.0 5009.3 4798.8 4971.3 5001.8 5007.0 5059.7 4912.9 4913.3 4917.3 4924.6 4932.9 5324.5 5405.6 5410.6 5439.8 5454.4 5644.1 5745.0 5819.3 5829.6 5871.1 5788.7 5852.3 5856.9 5860.4 5868.9 5390.9 5418.6 5433.3 5439.7 5448.3 5702.3 5881.6 5933.6 5953.5 5957.5 5706.3 5718.4 5731.1 5734.6 5736.4 5838.4 5845.7 5846.1 5846.1 5847.5 5751.9 5778.5 5824.8 5833.7 5837.1 5723.1 5725.1 5733.4 5776.4 5866.2 4354.6 4376.7 4392.7 4408.4 4416.3 3834.1 3874.7 3888.5 3928.6 3973.2 5535.1 5537.5 5538.0 5550.7 5573.6 5818.8 5859.9 5890.6 5897.5 5920.9 5389.7 5531.6 5543.7 5578.9 5588.4 5062.8 5067.5 5068.4 5072.0 5094.2 6163.1 6165.1 6169.3 6180.3 6192.8 5734.4 5833.6 5859.9 5910.1 5926.8 6076.3 6104.9 6114.5 6118.6 6122.9 5636.7 5782.5 5794.4 5802.1 5825.6 5781.8 5819.2 5843.5 5918.1 5925.4 5741.8 5754.2 5769.7 5783.2 5796.2 5512.4 5682.0 5739.2 5741.1 5748.0 5479.3 5526.8 5552.2 5588.5 5700.9 5786.9 5795.5 5843.3 5851.2 5869.9 5513.4 5690.8 5698.1 5698.9 5701.4 04:18:47 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | [#1] ext.html Cycles:180 Average:62745.95 Median:42553.00 stddev:125661.07 (295.3%) stddev-sans-first:125926.87 04:18:47 INFO - PROCESS | 602 | Values: 571.3 605.0 617.5 621.9 636.2 43298.4 44817.8 44860.3 44971.3 48139.8 45116.3 46077.0 46153.3 46203.8 46322.0 8743.2 8928.6 8937.2 8944.9 8972.0 8853.2 8877.5 8883.2 8913.5 8929.6 8952.6 8993.9 9013.2 9017.9 9023.7 8879.0 8914.2 8934.1 8945.2 8968.9 8791.4 8879.7 8885.1 8904.1 8909.2 42087.6 42408.2 42511.6 42527.0 42658.1 3565.4 3637.2 3737.8 4014.0 4168.1 32358.5 32717.0 32890.0 33168.5 33215.5 4456.9 4496.6 4497.5 4532.2 4541.3 354995.0 355487.0 355843.0 356443.0 358353.0 59561.4 59914.1 60080.0 60174.0 60258.4 64332.7 64501.7 64728.7 64913.5 65252.3 15789.9 16818.7 17155.1 17180.5 17629.0 12721.2 12877.7 12912.8 12913.8 12918.9 19762.2 19768.0 19902.5 19987.0 20078.8 7130.1 7479.8 7524.1 7550.7 7571.0 990.0 1008.0 1049.0 1085.6 1198.6 32908.8 33180.2 33196.3 33455.5 33852.0 1057.2 1123.8 1163.9 1177.8 1184.1 16171.0 17093.7 17177.2 17188.2 17251.1 572160.0 576286.0 585997.0 586930.0 591180.0 59901.0 60030.7 60345.7 60438.4 60466.7 1338.9 1357.1 1360.5 1376.5 1390.1 30268.7 31933.4 32244.8 32289.7 32475.4 51266.0 51508.5 51560.0 51582.2 51620.5 442589.0 454423.0 456066.0 456100.0 456234.0 27898.0 27972.9 28007.3 28186.7 28285.7 48595.8 48615.8 48836.5 49719.5 50078.5 41074.6 41238.8 41739.0 42323.0 42929.6 41209.4 41729.2 41806.8 42020.4 42121.8 36667.6 41290.4 41292.6 41971.2 42579.0 34592.8 36790.3 38468.2 38581.6 38895.6 26707.0 28775.0 28995.0 29067.3 29270.9 04:18:47 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | [#2] jquery.html Cycles:180 Average:29518.51 Median:2133.01 stddev:81470.96 (3819.5%) stddev-sans-first:81670.14 04:18:47 INFO - PROCESS | 602 | Values: 389.2 390.0 391.2 400.8 417.3 17954.7 19219.0 19646.4 19694.4 20048.3 18261.5 18767.3 18947.9 19088.6 19151.3 5645.7 5657.2 5795.5 5839.7 5849.6 5735.3 5740.2 5760.8 5763.3 5787.6 5593.3 5709.6 5770.1 5774.6 5792.6 5713.9 5747.5 5756.2 5768.4 5775.9 5081.2 5130.3 5202.1 5210.1 5210.4 22622.2 22675.5 22920.9 23449.2 23531.4 2069.5 2196.6 2463.2 2500.3 2685.8 9979.2 10048.1 11959.5 14367.6 14562.4 1827.6 1888.9 1916.7 1969.8 2043.0 72076.3 75436.0 76941.6 78350.6 83898.0 10844.8 11109.8 11275.8 11416.1 11428.5 15758.2 15849.4 15867.2 15870.8 15875.7 8289.5 8337.5 8437.7 8494.4 8523.6 7944.4 8072.7 8093.8 8130.8 8220.7 4646.4 4664.9 4779.9 4829.3 4866.0 1740.3 1954.4 1967.8 1970.0 2007.5 926.6 1015.3 1017.0 1044.0 1150.9 19182.9 19666.3 19794.6 19990.2 20158.3 980.4 984.1 985.6 1022.3 1031.4 8975.1 11124.3 11216.5 11233.7 11260.9 475611.0 495337.0 499867.0 500160.0 501363.0 92591.0 93565.0 96402.5 96633.0 97063.0 1010.7 1019.2 1036.2 1042.7 1046.8 17135.2 17415.7 17555.5 17625.7 17931.7 38467.0 42133.0 42743.6 43362.0 44179.6 50196.5 61074.1 61164.7 61516.4 61830.0 8376.5 8667.9 8786.8 8949.8 11401.6 12480.3 13540.4 14004.4 14116.6 14242.1 12199.6 12420.9 12525.2 12814.4 12870.4 12151.0 12229.6 12252.3 12522.6 12864.9 12259.8 12739.0 12792.2 12912.4 13183.3 13043.8 13074.5 13170.1 13236.5 13302.8 12588.7 12715.7 12903.7 12939.0 12985.9 04:18:47 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | [#3] mootools.html Cycles:180 Average:5593.03 Median:5188.46 stddev:3084.28 (59.4%) stddev-sans-first:3077.49 04:18:47 INFO - PROCESS | 602 | Values: 1486.4 1505.7 1642.4 1714.1 1797.9 7279.5 8102.2 8161.4 8736.7 8746.7 8182.8 8487.2 8490.6 8536.1 8550.7 2330.0 2361.2 2361.7 2366.6 2368.8 2288.8 2322.9 2324.3 2334.4 2337.1 2332.1 2346.3 2349.4 2380.9 2385.0 2286.3 2293.6 2298.8 2303.6 2319.0 2268.6 2276.6 2277.7 2288.4 2289.8 8456.7 8470.5 8507.3 8532.6 8541.7 4957.5 5039.5 5101.6 5109.1 5114.2 3269.4 3388.3 3513.7 3522.5 3579.1 1100.0 1160.4 1160.7 1226.3 1228.0 11427.8 11609.6 11619.4 11645.1 11696.6 4405.5 4545.8 4571.9 4602.4 4632.3 9905.7 9923.2 9927.4 9927.8 9945.8 5179.2 5183.6 5187.3 5188.0 5207.0 4076.8 4619.2 4695.2 4763.0 4767.6 3887.1 3919.2 3990.2 4043.6 4050.8 1269.6 1324.6 1332.8 1341.0 1347.8 928.1 967.3 979.4 989.0 994.2 5688.5 5711.6 5755.7 5838.1 5908.4 445.9 446.9 449.1 454.6 455.2 4105.7 4146.2 4146.5 4171.5 4174.5 9706.3 9840.2 10018.6 10029.8 10035.5 9823.4 9939.8 9949.9 9951.7 9956.4 7455.2 7620.6 7661.2 7701.0 7711.8 5896.9 5929.6 6085.0 6135.2 6162.0 9284.0 9508.6 9598.2 9799.4 9858.7 9384.6 9713.8 9905.1 9922.4 9935.2 7574.8 7654.0 7699.1 7722.3 7769.2 8205.6 8214.0 8249.8 8252.7 8253.0 7087.7 7365.1 7465.1 7598.2 7683.5 7269.0 7296.4 7301.6 7488.0 7529.7 6690.1 6723.1 6724.9 6727.7 6734.1 4883.8 4982.6 5111.7 5113.4 5188.9 5208.1 5288.7 5327.8 5412.4 5421.0 04:18:47 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | [#4] prototype.html Cycles:180 Average:4914.14 Median:5613.05 stddev:1447.25 (25.8%) stddev-sans-first:1409.79 04:18:47 INFO - PROCESS | 602 | Values: 328.3 332.5 337.9 340.2 342.2 5576.7 5606.2 5657.5 5661.9 5674.8 5461.3 5476.5 5504.5 5505.0 5529.5 4081.9 4192.5 4352.3 4354.1 4366.8 4354.6 4364.8 4365.2 4380.6 4386.5 4356.0 4372.5 4372.7 4376.3 4386.9 4323.4 4328.5 4340.7 4343.8 4359.9 3818.7 3839.8 3850.7 3857.0 3867.3 5406.7 5412.8 5457.7 5476.3 5489.5 4748.6 4912.7 4913.2 4929.8 4985.1 5756.6 5759.0 5777.9 5788.1 5798.0 4210.7 4213.1 4223.3 4228.6 4247.0 5719.6 6067.6 6084.6 6104.9 6105.1 4189.6 4204.7 4210.4 4234.8 4245.1 4276.3 4296.1 4305.5 4305.6 4306.2 4748.0 4873.5 4907.4 4910.0 4964.0 5873.9 5876.8 5890.1 5912.8 5929.7 1479.2 1482.0 1493.7 1501.9 1503.5 954.0 965.7 1004.7 1009.7 1015.6 5629.6 5640.1 5645.3 5672.3 5689.5 6056.9 6063.1 6070.2 6091.9 6093.5 5381.7 5522.1 5589.0 5612.4 5613.7 3170.4 3170.5 3180.9 3189.4 3192.6 6047.6 6160.4 6167.7 6209.7 6210.3 6026.0 6052.7 6059.6 6106.9 6151.8 5986.9 6034.0 6079.9 6087.5 6134.8 5998.5 6001.5 6006.7 6010.9 6018.6 5946.5 5946.9 5969.8 6016.9 6027.6 5931.7 6167.8 6225.6 6251.9 6271.7 4211.5 4224.0 4231.6 4270.5 4288.6 5799.6 5895.8 5932.8 6015.7 6041.7 5842.3 5846.4 5861.7 5900.4 5914.7 5527.4 5790.3 5863.8 5888.8 5901.9 5682.4 5718.7 5720.6 5734.6 5773.6 5888.9 5896.8 5898.3 5900.9 5958.9 5466.4 5708.8 5724.2 5807.7 5815.7 04:18:47 INFO - PROCESS | 602 | 04:18:47 INFO - PROCESS | 602 | [#5] yui.html Cycles:180 Average:20740.55 Median:4557.23 stddev:30204.86 (662.8%) stddev-sans-first:30252.22 04:18:47 INFO - PROCESS | 602 | Values: 730.0 777.4 800.2 814.4 853.0 15003.6 16038.1 16110.3 16123.4 16139.8 14689.6 14713.9 14766.0 15070.6 15086.5 658.6 792.4 806.0 813.5 817.8 790.1 794.0 796.3 796.7 798.3 841.5 843.7 846.7 848.3 851.1 831.2 835.9 838.5 838.7 838.7 610.4 611.1 613.4 615.3 616.3 15167.3 15219.2 15231.9 15238.8 15253.7 15387.9 15805.8 15881.0 15957.4 15966.6 12736.6 12803.9 12857.6 13488.3 13540.3 3828.3 3861.1 3899.4 3934.2 4021.5 81277.6 82199.0 82624.6 82802.6 87345.6 11912.8 12065.5 12087.4 12109.6 12247.3 23362.6 23370.0 23380.6 23434.6 23492.3 7916.9 8225.8 8241.1 8525.8 8705.6 4616.8 4695.5 4742.0 4757.8 4777.0 3256.0 3387.7 3399.9 3406.1 3421.3 601.5 615.6 617.6 619.7 620.9 675.8 696.1 698.7 700.2 717.8 9080.9 9389.4 9393.6 9415.2 9503.5 621.7 663.3 684.4 703.9 711.2 4534.3 4553.3 4561.2 4620.7 4630.1 115974.0 116255.0 118779.0 119060.4 121620.0 60100.0 90547.0 100611.5 100860.5 103203.5 79029.0 87171.8 87605.0 87990.6 88957.0 8421.1 8614.8 8686.2 8697.8 8751.4 44876.0 51480.5 52836.7 53525.0 54530.7 66908.0 66983.0 76657.0 78318.6 79073.6 11100.5 11107.4 11322.9 11553.7 11575.4 11812.2 11909.3 12016.9 12191.5 12454.1 11470.0 11489.4 11552.3 11637.1 11836.2 12015.1 12022.3 12043.6 12190.1 12772.4 12259.0 13362.7 13674.7 13922.8 13947.7 11031.3 11477.5 11527.9 11578.3 12230.3 10467.4 10618.8 10664.4 10836.9 10941.9 04:18:47 INFO - PROCESS | 602 | -------- Summary: end -------- 04:18:47 INFO - PROCESS | 602 | 04:18:48 INFO - TEST-INFO | 602: exit 0 04:18:48 INFO - TEST-OK | dromaeo_css | took 1110449ms 04:18:48 INFO - TEST-START | kraken 04:18:48 INFO - operating with platform_type : linux_ 04:18:48 INFO - Initialising browser for kraken test... 04:18:48 INFO - TEST-INFO | started process 839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qefBX/profile http://localhost:37181/getInfo.html) 04:18:52 INFO - PROCESS | 839 | __metrics Screen width/height:1600/1200 04:18:52 INFO - PROCESS | 839 | colorDepth:24 04:18:52 INFO - PROCESS | 839 | Browser inner width/height: 1024/697 04:18:52 INFO - PROCESS | 839 | __metrics 04:18:53 ERROR - PROCESS | 839 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 04:18:54 INFO - TEST-INFO | 839: exit 0 04:18:54 INFO - Browser initialized. 04:18:54 INFO - Running cycle 1/1 for kraken test... 04:18:54 INFO - TEST-INFO | started process 965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qefBX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:06 INFO - PROCESS | 965 | RSS: Main: 167391232 04:19:06 INFO - PROCESS | 965 | 04:19:08 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37181/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:09 INFO - PROCESS | 965 | RSS: Main: 172564480 04:19:09 INFO - PROCESS | 965 | 04:19:12 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37181/tests/kraken/driver.html?testName=audio-dft) 04:19:12 INFO - PROCESS | 965 | RSS: Main: 171974656 04:19:12 INFO - PROCESS | 965 | 04:19:15 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37181/tests/kraken/driver.html?testName=audio-fft) 04:19:16 INFO - PROCESS | 965 | RSS: Main: 166166528 04:19:16 INFO - PROCESS | 965 | 04:19:18 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37181/tests/kraken/driver.html?testName=audio-oscillator) 04:19:19 INFO - PROCESS | 965 | RSS: Main: 167329792 04:19:19 INFO - PROCESS | 965 | 04:19:21 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37181/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:21 INFO - PROCESS | 965 | RSS: Main: 167657472 04:19:21 INFO - PROCESS | 965 | 04:19:24 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37181/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:25 INFO - PROCESS | 965 | RSS: Main: 167931904 04:19:25 INFO - PROCESS | 965 | 04:19:29 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37181/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:29 INFO - PROCESS | 965 | RSS: Main: 168341504 04:19:29 INFO - PROCESS | 965 | 04:19:32 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37181/tests/kraken/driver.html?testName=json-parse-financial) 04:19:33 INFO - PROCESS | 965 | RSS: Main: 168529920 04:19:33 INFO - PROCESS | 965 | 04:19:34 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37181/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:35 INFO - PROCESS | 965 | RSS: Main: 168685568 04:19:35 INFO - PROCESS | 965 | 04:19:37 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37181/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:37 INFO - PROCESS | 965 | RSS: Main: 168824832 04:19:37 INFO - PROCESS | 965 | 04:19:39 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37181/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:40 INFO - PROCESS | 965 | RSS: Main: 169156608 04:19:40 INFO - PROCESS | 965 | 04:19:43 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:43 INFO - PROCESS | 965 | RSS: Main: 168898560 04:19:43 INFO - PROCESS | 965 | 04:19:46 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:47 INFO - PROCESS | 965 | RSS: Main: 168837120 04:19:47 INFO - PROCESS | 965 | 04:19:48 INFO - PROCESS | 965 | Cycle 1(1): loaded http://localhost:37181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37181/tests/kraken/driver.html?testName=ai-astar) 04:19:49 INFO - PROCESS | 965 | RSS: Main: 169512960 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | __start_tp_report 04:19:49 INFO - PROCESS | 965 | _x_x_mozilla_page_load 04:19:49 INFO - PROCESS | 965 | _x_x_mozilla_page_load_details 04:19:49 INFO - PROCESS | 965 | |i|pagename|runs| 04:19:49 INFO - PROCESS | 965 | |0;ai-astar;114;108;112;111;112;110;111;111;110;112 04:19:49 INFO - PROCESS | 965 | |1;audio-beat-detection;166;129;152;179;126;154;151;133;186;128 04:19:49 INFO - PROCESS | 965 | |2;audio-dft;164;164;161;161;162;165;169;163;162;163 04:19:49 INFO - PROCESS | 965 | |3;audio-fft;76;77;74;155;75;76;77;76;174;75 04:19:49 INFO - PROCESS | 965 | |4;audio-oscillator;86;86;157;86;86;85;151;85;86;143 04:19:49 INFO - PROCESS | 965 | |5;imaging-gaussian-blur;117;117;117;117;118;117;119;118;118;118 04:19:49 INFO - PROCESS | 965 | |6;imaging-darkroom;146;148;147;147;147;148;148;149;147;147 04:19:49 INFO - PROCESS | 965 | |7;imaging-desaturate;95;97;96;96;96;98;96;96;96;95 04:19:49 INFO - PROCESS | 965 | |8;json-parse-financial;57;57;54;53;55;57;54;55;54;55 04:19:49 INFO - PROCESS | 965 | |9;json-stringify-tinderbox;62;62;64;63;64;63;62;64;62;62 04:19:49 INFO - PROCESS | 965 | |10;stanford-crypto-aes;88;79;80;80;80;84;82;92;105;82 04:19:49 INFO - PROCESS | 965 | |11;stanford-crypto-ccm;121;122;132;122;120;142;124;124;125;132 04:19:49 INFO - PROCESS | 965 | |12;stanford-crypto-pbkdf2;161;159;160;159;158;165;166;159;163;165 04:19:49 INFO - PROCESS | 965 | |13;stanford-crypto-sha256-iterative;64;69;65;66;63;64;64;63;63;66 04:19:49 INFO - PROCESS | 965 | __end_tp_report 04:19:49 INFO - PROCESS | 965 | __start_cc_report 04:19:49 INFO - PROCESS | 965 | _x_x_mozilla_cycle_collect,893 04:19:49 INFO - PROCESS | 965 | __end_cc_report 04:19:49 INFO - PROCESS | 965 | __startTimestamp1465211989005__endTimestamp 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | ------- Summary: start ------- 04:19:49 INFO - PROCESS | 965 | Number of tests: 14 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:1.60 (1.4%) stddev-sans-first:1.30 04:19:49 INFO - PROCESS | 965 | Values: 114.0 108.0 112.0 111.0 112.0 110.0 111.0 111.0 110.0 112.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:153.00 stddev:21.61 (14.1%) stddev-sans-first:22.17 04:19:49 INFO - PROCESS | 965 | Values: 166.0 129.0 152.0 179.0 126.0 154.0 151.0 133.0 186.0 128.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.37 (1.4%) stddev-sans-first:2.50 04:19:49 INFO - PROCESS | 965 | Values: 164.0 164.0 161.0 161.0 162.0 165.0 169.0 163.0 162.0 163.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:37.70 (49.6%) stddev-sans-first:39.45 04:19:49 INFO - PROCESS | 965 | Values: 76.0 77.0 74.0 155.0 75.0 76.0 77.0 76.0 174.0 75.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:86.00 stddev:31.39 (36.5%) stddev-sans-first:32.53 04:19:49 INFO - PROCESS | 965 | Values: 86.0 86.0 157.0 86.0 86.0 85.0 151.0 85.0 86.0 143.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 04:19:49 INFO - PROCESS | 965 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 119.0 118.0 118.0 118.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 04:19:49 INFO - PROCESS | 965 | Values: 146.0 148.0 147.0 147.0 147.0 148.0 148.0 149.0 147.0 147.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 04:19:49 INFO - PROCESS | 965 | Values: 95.0 97.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 95.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.45 (2.6%) stddev-sans-first:1.36 04:19:49 INFO - PROCESS | 965 | Values: 57.0 57.0 54.0 53.0 55.0 57.0 54.0 55.0 54.0 55.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 04:19:49 INFO - PROCESS | 965 | Values: 62.0 62.0 64.0 63.0 64.0 63.0 62.0 64.0 62.0 62.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:82.00 stddev:8.08 (9.9%) stddev-sans-first:8.51 04:19:49 INFO - PROCESS | 965 | Values: 88.0 79.0 80.0 80.0 80.0 84.0 82.0 92.0 105.0 82.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:124.50 stddev:6.90 (5.5%) stddev-sans-first:7.04 04:19:49 INFO - PROCESS | 965 | Values: 121.0 122.0 132.0 122.0 120.0 142.0 124.0 124.0 125.0 132.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.00 stddev:2.99 (1.8%) stddev-sans-first:3.17 04:19:49 INFO - PROCESS | 965 | Values: 161.0 159.0 160.0 159.0 158.0 165.0 166.0 159.0 163.0 165.0 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - PROCESS | 965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:1.89 (2.9%) stddev-sans-first:1.99 04:19:49 INFO - PROCESS | 965 | Values: 64.0 69.0 65.0 66.0 63.0 64.0 64.0 63.0 63.0 66.0 04:19:49 INFO - PROCESS | 965 | -------- Summary: end -------- 04:19:49 INFO - PROCESS | 965 | 04:19:49 INFO - TEST-INFO | 965: exit 0 04:19:49 INFO - TEST-OK | kraken | took 61810ms 04:19:49 INFO - SUITE-END | took 1172s 04:19:50 INFO - Completed test suite (00:19:32) 04:19:50 INFO - javascript benchmark 04:19:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7331.502878161726, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.1845460952845, 3137.748980081594, 3164.3038531523057, 3167.572377729007, 3191.7287030602397, 5362.785488580452, 5392.811251606189, 5411.458854114591, 5455.427180146087, 5461.290032295801, 5343.091674415349, 5394.32570928634, 5421.268128802621, 5470.316210473691, 5554.50009499146, 4801.975990120053, 4910.091633047879, 4982.676126051813, 5025.045241404122, 5096.719680417576, 823.7084347694511, 4975.502449755032, 5039.521245481692, 5048.217526283432, 5065.341505604266, 4960.826371077013, 4977.950220497785, 4988.900221995558, 5002.974985125069, 5009.298698182258, 4798.760061996886, 4971.27916452116, 5001.799928002875, 5006.974965125151, 5059.696418214919, 4912.852614421573, 4913.336699545552, 4917.336159618441, 4924.556789888928, 4932.901341973176, 5324.54741346986, 5405.594580406446, 5410.648307860016, 5439.755211015514, 5454.427285135083, 5644.068728659766, 5745.023346031185, 5819.301683797929, 5829.5919285650025, 5871.148683440877, 5788.652680839121, 5852.326982397036, 5856.853578660525, 5860.355360910296, 5868.941310586925, 5390.8921821563745, 5418.566514678856, 5433.293671822677, 5439.728013599304, 5448.346198456171, 5702.315722113373, 5881.5882888198275, 5933.614315069507, 5953.523718102541, 5957.49361304294, 5706.3152421709665, 5718.399568045378, 5731.140328950607, 5734.569907256889, 5736.397678243808, 5838.357780644125, 5845.707714614252, 5846.064629659234, 5846.093855452412, 5847.473727364472, 5751.913721294184, 5778.479936805707, 5824.796132135355, 5833.7374818133285, 5837.066069428871, 5723.084306510938, 5725.08398656213, 5733.369329373765, 5776.364599894008, 5866.2373891393845, 4354.608085272277, 4376.715513491677, 4392.670549708785, 4408.426904502394, 4416.315471101984, 3834.0798208430333, 3874.670652994471, 3888.533375994842, 3928.64642182205, 3973.165635216579, 5535.059039963216, 5537.473939975695, 5538.030844602178, 5550.72246387679, 5573.5819813514145, 5818.796342128006, 5859.853503662443, 5890.646561206341, 5897.469227769521, 5920.881582368328, 5389.703566303812, 5531.557475401958, 5543.695096769717, 5578.86052848682, 5588.357338905997, 5062.797488100508, 5067.4932506749765, 5068.417132029864, 5071.974640126776, 5094.1849304111165, 6163.106349579286, 6165.10605962133, 6169.321374648785, 6180.3201647818705, 6192.81421557354, 5734.397888221677, 5833.591648584558, 5859.882802344015, 5910.143029260819, 5926.762929482772, 6076.270847498152, 6104.877902441837, 6114.541409394402, 6118.571699980958, 6122.877542449215, 5636.746346414339, 5782.5373970081455, 5794.391588883106, 5802.071668533014, 5825.621334613236, 5781.82654520365, 5819.156222347651, 5843.474087332161, 5918.053111502311, 5925.407459254213, 5741.799037033684, 5754.165645981226, 5769.682667453162, 5783.16144159103, 5796.159556864315, 5512.4211957743855, 5681.971590142023, 5739.2252045973255, 5741.0527263002805, 5748.022836117786, 5479.315085614298, 5526.751296191762, 5552.167174923632, 5588.524975377139, 5700.857478563069, 5786.9131963019745, 5795.5073818724195, 5843.29880414353, 5851.21008663825, 5869.941300586939, 5513.448655134454, 5690.8008219713765, 5698.0598201296325, 5698.943010569841, 5701.4298570142655], "value": 5349.226980072103, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.3058633759981, 604.996975015125, 617.5245061302797, 621.9378062193779, 636.2492259134223, 43298.35052474211, 44817.77591112048, 44860.3270950936, 44971.32543011857, 48139.759301203536, 45116.32325515112, 46077.0, 46153.307700384525, 46203.76898115513, 46322.0, 8743.213110820041, 8928.642854285821, 8937.150970657776, 8944.8658270126, 8972.0, 8853.247473964688, 8877.51173685447, 8883.244924181452, 8913.509756963364, 8929.598168082419, 8952.552372381388, 8993.910060899372, 9013.188813006827, 9017.864732029026, 9023.684171054014, 8878.955605221965, 8914.153155450222, 8934.10658934108, 8945.15021072997, 8968.910310896905, 8791.384603077788, 8879.733607991771, 8885.111488851127, 8904.109589041109, 8909.1536304051, 42087.579124208976, 42408.1518369634, 42511.57488425138, 42527.0, 42658.14683706308, 3565.358235517606, 3637.163452405935, 3737.8131093445218, 4013.97993010036, 4168.083021735213, 32358.514622280683, 32717.0, 32890.0, 33168.50247246293, 33215.501767473506, 4456.910861782779, 4496.55034496551, 4497.482789479219, 4532.235450325235, 4541.341505481687, 354995.0, 355487.0, 355843.0, 356443.0, 358352.9999999974, 59561.404385956455, 59914.101288480706, 60080.0, 60174.0, 60258.39741602528, 64332.67833660802, 64501.677491612245, 64728.67635661886, 64913.508649135656, 65252.34747652463, 15789.921050394674, 16818.663626727397, 17155.142242887807, 17180.484585462455, 17629.0, 12721.236725796482, 12877.742445151045, 12912.806307905388, 12913.806292905614, 12918.935405323102, 19762.209511619374, 19768.0, 19902.50243743918, 19987.0, 20078.799212007983, 7130.108736407949, 7479.813004674817, 7524.087474513222, 7550.735724249735, 7571.0, 989.9752506187403, 1008.0322890025511, 1048.9929667519266, 1085.571199376242, 1198.5804968261039, 32908.83545582257, 33180.1704957378, 33196.3360732784, 33455.498167527505, 33852.0, 1057.2282233969245, 1123.8145705958589, 1163.8777928317575, 1177.7879981603223, 1184.0882520459197, 16171.0, 17093.658126837392, 17177.227024783915, 17188.22652980619, 17251.137443127795, 572160.0, 576286.0, 585997.0, 586930.0, 591180.0, 59901.0, 60030.69984650049, 60345.69827150924, 60438.39561604416, 60466.69766651138, 1338.8928885689122, 1357.097530142464, 1360.5170164591427, 1376.4975783838827, 1390.0686540018212, 30268.697313026587, 31933.36133277368, 32244.838775806908, 32289.677103228667, 32475.350492989535, 51266.0, 51508.484915150366, 51560.0, 51582.22626660678, 51620.48379516157, 442589.0, 454423.0, 456066.0, 456100.0, 456234.0, 27898.0, 27972.860135700004, 28007.29981750391, 28186.71813281841, 28285.717142829133, 48595.75702121467, 48615.756921215165, 48836.511634883194, 49719.50280497149, 50078.49921500738, 41074.58925410708, 41238.79380603078, 41739.0, 42323.0, 42929.57070429256, 41209.38185927273, 41729.1654166921, 41806.79096604497, 42020.369694454, 42121.78939105285, 36667.63332366642, 41290.38064429096, 41292.587074128875, 41971.16057678768, 42579.0, 34592.82703586466, 36790.26419471649, 38468.23063538658, 38581.614183857804, 38895.611043890334, 26706.963608887985, 28775.0, 28995.0, 29067.273318167216, 29270.853645731637], "value": 20599.97291988743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.23515292450327, 389.9785511796854, 391.21951706345845, 400.7595442734359, 417.3197687768936, 17954.730679039807, 19219.0, 19646.410607681773, 19694.409167724974, 20048.29830955917, 18261.543461413472, 18767.343142989997, 18947.90526047371, 19088.618227635438, 19151.329703460382, 5645.717714114298, 5657.179708942201, 5795.507381872525, 5839.678817665027, 5849.649021058729, 5735.340435849889, 5740.167675687023, 5760.798372056979, 5763.308402991647, 5787.594868359217, 5593.300837395325, 5709.628874123189, 5770.076787713967, 5774.595778295521, 5792.623479473842, 5713.942860571424, 5747.482726554588, 5756.165356023395, 5768.36547979724, 5775.855603609902, 5081.212412076134, 5130.30740849988, 5202.141646628302, 5210.140326846104, 5210.374755029421, 22622.208222712125, 22675.54648907029, 22920.885395572914, 23449.179278725333, 23531.411714707097, 2069.461939895638, 2196.560687862418, 2463.187148241076, 2500.3374105861963, 2685.798565107605, 9979.201663866874, 10048.145907597864, 11959.521619135225, 14367.640808979859, 14562.417503299856, 1827.552249698819, 1888.9433317000512, 1916.7220752990738, 1969.842412606988, 2042.9795702043086, 72076.27923720748, 75436.0, 76941.6152919243, 78350.6082469584, 83898.0, 10844.837327440095, 11109.777804443866, 11275.774484510264, 11416.143789215675, 11428.542858285742, 15758.212089395485, 15849.366025359088, 15867.206639667971, 15870.7619385707, 15875.682486350439, 8289.461185022954, 8337.499750015018, 8437.662493500191, 8494.362922780816, 8523.616437260338, 7944.364450843918, 8072.677092916335, 8093.797655058671, 8130.837383252302, 8220.671173153007, 4646.4191976003, 4664.883377915511, 4779.880502987384, 4829.27560865873, 4865.9756701216265, 1740.321274702867, 1954.3941378172813, 1967.79338169493, 1969.9559233605926, 2007.4780557055271, 926.559884055082, 1015.3349556040805, 1016.9542370593341, 1043.994780026095, 1150.913681473893, 19182.904085479484, 19666.31167909145, 19794.60410791776, 19990.20039198416, 20158.29445969384, 980.4264505264357, 984.1093810101869, 985.6254623243121, 1022.2690776095128, 1031.417249254169, 8975.057618949917, 11124.332540047622, 11216.495257713423, 11233.66299011031, 11260.887391126147, 475611.0, 495337.0, 499867.0, 500160.0, 501363.0, 92591.0, 93565.0, 96402.51798740962, 96633.0, 97063.0, 1010.722051435861, 1019.1591936652292, 1036.1555332404216, 1042.744527590745, 1046.7801761630144, 17135.15402666114, 17415.738763918296, 17555.473335799947, 17625.73561396606, 17931.73102403439, 38467.0, 42133.0, 42743.572564273956, 43362.0, 44179.558204417546, 50196.498035020646, 61074.08388874259, 61164.694176528836, 61516.38483615286, 61830.0, 8376.53929033909, 8667.869981950402, 8786.780330491789, 8949.821003580022, 11401.600943966921, 12480.319880044983, 13540.390682419511, 14004.36980335867, 14116.647083822987, 14242.07426517273, 12199.634010979686, 12420.937895310466, 12525.248485090924, 12814.423350949417, 12870.420831062438, 12151.0, 12229.571964981184, 12252.264864108181, 12522.624321270376, 12864.871351286742, 12259.816102758288, 12739.0, 12792.232466052066, 12912.354382281037, 13183.274919879499, 13043.804342934674, 13074.542391016268, 13170.143940644211, 13236.47054117863, 13302.800457993331, 12588.685282867635, 12715.745685086062, 12903.741925161632, 12939.0, 12985.935070324587], "value": 9535.10697303984, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.4128669175673, 1505.7214415333165, 1642.3676884399504, 1714.1172296267416, 1797.9460616181518, 7279.454040946937, 8102.230288122626, 8161.428699991003, 8736.694215702451, 8746.693865714702, 8182.754517364474, 8487.193716596914, 8490.6179221935, 8536.061033286334, 8550.74347769568, 2330.0446816805156, 2361.244401791427, 2361.6929799126087, 2366.6331718583647, 2368.834181607288, 2288.8054515366216, 2322.883855807203, 2324.34918222897, 2334.4163959010248, 2337.123578658003, 2332.125452955142, 2346.3078391874437, 2349.4126468382906, 2380.857188549497, 2384.95230095398, 2286.3369622809364, 2293.6330187169974, 2298.839081264312, 2303.6429353450158, 2318.953620927572, 2268.6483595042796, 2276.5560715660454, 2277.7152855893014, 2288.3592594073684, 2289.828262880274, 8456.704015359495, 8470.49177049379, 8507.276881465083, 8532.57337133141, 8541.658333666646, 4957.454679985235, 5039.496050394968, 5101.642884998052, 5109.080365534202, 5114.232865070232, 3269.4441944869427, 3388.288459423524, 3513.7013353864954, 3522.5068490411363, 3579.069441945113, 1099.961501347449, 1160.3560024186572, 1160.6576060062218, 1226.2519862883635, 1228.01145078212, 11427.771444571063, 11609.593664221711, 11619.419029048513, 11645.068394528502, 11696.590619328368, 4405.515393306734, 4545.795439205243, 4571.885702857388, 4602.447706275201, 4632.258838585877, 9905.653302134391, 9923.206143508502, 9927.40435573868, 9927.80144397108, 9945.80108397828, 5179.171332586768, 5183.559397451183, 5187.273781670569, 5187.974060129675, 5207.0366982108435, 4076.775777332216, 4619.23782575878, 4695.22528782747, 4762.9761851191215, 4767.642426818003, 3887.067103895045, 3919.1573811630637, 3990.20195960809, 4043.6158564936873, 4050.7569545827346, 1269.5937300064077, 1324.6356253059364, 1332.80007998799, 1340.986590134086, 1347.8113064171023, 928.1043792740038, 967.3470407474927, 979.4221409368507, 988.9950550247347, 994.2443742755413, 5688.516476099495, 5711.628744131618, 5755.740991655385, 5838.095095260242, 5908.350081491032, 445.86401147650275, 446.9262571675702, 449.07490569427085, 454.63856234293814, 455.19885002396023, 4105.712600118023, 4146.170765846843, 4146.502419709594, 4171.478565179353, 4174.540800511942, 9706.320557561045, 9840.163586095263, 10018.64934727281, 10029.849552256723, 10035.498225088717, 9823.36148150368, 9939.751506212402, 9949.900500995042, 9951.701448956543, 9956.402615843073, 7455.179930207672, 7620.618969051525, 7661.233876612294, 7701.0, 7711.807204819925, 5896.882062358814, 5929.555283353852, 6084.969575152096, 6135.1717518136265, 6161.9691901542, 9284.0, 9508.619655213713, 9598.232141428809, 9799.412035277906, 9858.654947076819, 9384.624615015597, 9713.805723885342, 9905.108540231413, 9922.40465572068, 9935.20518358544, 7574.772756817304, 7653.961730191313, 7699.076110866507, 7722.3049925506975, 7769.223077692185, 8205.60504714188, 8214.0, 8249.83500329978, 8252.669893204205, 8253.0, 7087.705011644106, 7365.116186057493, 7465.104187497535, 7598.240175982358, 7683.500572462772, 7268.96365518169, 7296.379807716404, 7301.561906285639, 7488.026556547832, 7529.698812047457, 6690.13028306317, 6723.092382528296, 6724.93275067243, 6727.697253623696, 6734.057231987427, 4883.780229889735, 4982.601391888713, 5111.744412779421, 5113.411957624772, 5188.948110518846, 5208.114620514598, 5288.68267903927, 5327.840164795062, 5412.431694672003, 5421.0], "value": 4465.197515096634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.32856807828006, 332.4706350786383, 337.91721028348053, 340.21410541648777, 342.1924258749353, 5576.749046292916, 5606.177992152547, 5657.519110875575, 5661.915071273924, 5674.773009079642, 5461.344638643359, 5476.548714590636, 5504.4770746779095, 5504.972475137629, 5529.474699903502, 4081.9183616327655, 4192.538820729717, 4352.281873490871, 4354.08564201518, 4366.781660916958, 4354.629856462205, 4364.847230346939, 4365.170617582649, 4380.58384453478, 4386.539413361599, 4355.956440435587, 4372.519022907478, 4372.71577347473, 4376.277914144178, 4386.912261754763, 4323.373110898933, 4328.545502722201, 4340.674449416307, 4343.761093139876, 4359.912801743947, 3818.6563209311294, 3839.7504162229366, 3850.6919446444217, 3857.035741064734, 3867.284552357795, 5406.729663516809, 5412.783488660488, 5457.699826509541, 5476.288082549243, 5489.533389661844, 4748.59916324685, 4912.6806757561, 4913.182122614656, 4929.767558110472, 4985.052839960432, 5756.568257380672, 5759.0, 5777.942220577783, 5788.147792706336, 5797.971010144965, 4210.7473551587, 4213.115245798355, 4223.303154979425, 4228.619424251801, 4246.9594949237635, 5719.571032172562, 6067.6359418434595, 6084.60450070744, 6104.938950610526, 6105.114758360013, 4189.581041895847, 4204.66362690984, 4210.389493523422, 4234.7670878102, 4245.087306229176, 4276.337167739005, 4296.119295544406, 4305.526392096866, 4305.612494875476, 4306.20335237982, 4747.976260118678, 4873.537013983666, 4907.386576677915, 4909.950900491021, 4963.975180124076, 5873.942690315699, 5876.7658791653375, 5890.057590785454, 5912.763489460373, 5929.703514824328, 1479.201231335067, 1481.9629509262354, 1493.7087267982856, 1501.873594803897, 1503.5263891874024, 953.9792422108416, 965.6716716316486, 1004.7488127968008, 1009.6869970309227, 1015.5836107196014, 5629.634073785191, 5640.097584386561, 5645.322561292671, 5672.262605861211, 5689.468186656898, 6056.909146362808, 6063.090536419484, 6070.180525629072, 6091.908621370683, 6093.512518998469, 5381.704006279692, 5522.144067669517, 5588.972055139699, 5612.410696876769, 5613.691246981373, 3170.4134735074085, 3170.4927211646027, 3180.8886688965777, 3189.4418476766473, 3192.6488086310487, 6047.6069055512135, 6160.398296442868, 6167.660778657217, 6209.6895155242055, 6210.31686514483, 6025.969870150621, 6052.66710330936, 6059.606125601822, 6106.908396374058, 6151.815445536641, 5986.940130598726, 6033.9742243818655, 6079.939200608026, 6087.452129308295, 6134.846628834315, 5998.4601385875485, 6001.489873360813, 6006.729697163725, 6010.879782404415, 6018.59256297467, 5946.494547963472, 5946.851328716817, 5969.76120955157, 6016.939830601813, 6027.60820546663, 5931.716289228591, 6167.84580385476, 6225.626462412089, 6251.937480625135, 6271.717772700148, 4211.473565804275, 4224.028473451185, 4231.597998190167, 4270.50889147752, 4288.571142885687, 5799.594028417971, 5895.764169433174, 5932.822015339547, 6015.72929218195, 6041.697915104315, 5842.3349345436345, 5846.386129456346, 5861.736221870111, 5900.350961394157, 5914.704264786829, 5527.364353099445, 5790.305163380422, 5863.794767183128, 5888.764449421975, 5901.852453688693, 5682.403347648603, 5718.684702518527, 5720.570957178145, 5734.627249228787, 5773.624714393551, 5888.941110588839, 5896.764129434946, 5898.262717160355, 5900.911486327623, 5958.867815115114, 5466.398696143341, 5708.771649133988, 5724.169995350734, 5807.680577568105, 5815.651060936358], "value": 4448.583691370653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.9817504562385, 777.3897490469978, 800.2037972217644, 814.4298990706505, 852.9957350213256, 15003.624909377271, 16038.117903515302, 16110.275037623305, 16123.355065797368, 16139.75790363144, 14689.632759181026, 14713.852861471409, 14766.040207386512, 15070.623234419118, 15086.547403577883, 658.5818005566451, 792.3779832831228, 805.963731632078, 813.4875028731891, 817.7710241132493, 790.115071120346, 793.9523628582275, 796.2753893956501, 796.6534557467492, 798.2616080125889, 841.486693117198, 843.7384410832631, 846.7375113714737, 848.2704873808519, 851.1190917400492, 831.2020460358063, 835.8579041562949, 838.5429940682343, 838.6561509781021, 838.6771093129158, 610.362171530747, 611.1413464082971, 613.3590398034065, 615.2770494668746, 616.312811215496, 15167.317470713844, 15219.162946037963, 15231.923840380838, 15238.771418428732, 15253.694926101527, 15387.923060384739, 15805.841941580553, 15881.0, 15957.441489547926, 15966.600834979103, 12736.61790146297, 12803.871961280454, 12857.614271571867, 13488.325583720774, 13540.322983850867, 3828.349180639298, 3861.131245469775, 3899.3760998240427, 3934.1934903344745, 4021.4973128358956, 81277.59361203156, 82199.0, 82624.58687706583, 82802.58598707028, 87345.56327218324, 11912.821307680391, 12065.517379304905, 12087.395630218454, 12109.576164834189, 12247.32639704807, 23362.64956025661, 23370.0, 23380.64929026066, 23434.64848027281, 23492.295231143093, 7916.920830791619, 8225.83548329042, 8241.134680858544, 8525.829483410296, 8705.608247628872, 4616.76916154191, 4695.483496815347, 4741.980474198064, 4757.769059527038, 4776.976115119472, 3255.9674403255663, 3387.7459190560808, 3399.9490007649906, 3406.148462884279, 3421.298633780069, 601.4526780629606, 615.5752530753765, 617.5769597825414, 619.6746707978257, 620.8851362497952, 675.7566078415739, 696.1333140240433, 698.6576577477, 700.2087640965676, 717.8313096422337, 9080.8637870432, 9389.38968967015, 9393.62425502986, 9415.246780257563, 9503.477308747946, 621.7357623010203, 663.3134705579798, 684.3669605614787, 703.9260877607879, 711.1821405383849, 4534.319852022223, 4553.2942393929, 4561.156186105581, 4620.67655264135, 4630.050839577879, 115974.0, 116255.0, 118779.0, 119060.40469797596, 121620.0, 60100.0, 90547.0, 100611.49694251629, 100860.49569752104, 103203.48398257961, 79029.0, 87171.79894655843, 87605.0, 87990.56004720063, 88957.0, 8421.115782842713, 8614.78463038404, 8686.218240358397, 8697.782555436164, 8751.387402881737, 44876.0, 51480.48519514907, 52836.73581632221, 53525.0, 54530.72734636301, 66908.0, 66983.0, 76657.0, 78318.6084069576, 79073.60463197647, 11100.500477478372, 11107.38909359993, 11322.886771132513, 11553.653390398302, 11575.421228938689, 11812.173147879566, 11909.285442873455, 12016.879831201577, 12191.451384687887, 12454.128211025141, 11470.0, 11489.368084755084, 11552.306861588331, 11637.127215459044, 11836.230645008047, 12015.09886758514, 12022.338771367658, 12043.638690839289, 12190.146689731633, 12772.361381930681, 12259.019278457881, 13362.732745345233, 13674.726505470035, 13922.791158132433, 13947.721045579234, 11031.282966607145, 11477.540898363972, 11527.942360288145, 11578.305301681588, 12230.327331996825, 10467.371957682564, 10618.84071738909, 10664.36013839141, 10836.945815270874, 10941.890581094087], "value": 7439.893607316688, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 112.0, 111.0, 112.0, 110.0, 111.0, 111.0, 110.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 129.0, 152.0, 179.0, 126.0, 154.0, 151.0, 133.0, 186.0, 128.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 161.0, 162.0, 165.0, 169.0, 163.0, 162.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 155.0, 75.0, 76.0, 77.0, 76.0, 174.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 157.0, 86.0, 86.0, 85.0, 151.0, 85.0, 86.0, 143.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 149.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 54.0, 53.0, 55.0, 57.0, 54.0, 55.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 63.0, 64.0, 63.0, 62.0, 64.0, 62.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 80.0, 80.0, 80.0, 84.0, 82.0, 92.0, 105.0, 82.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 132.0, 122.0, 120.0, 142.0, 124.0, 124.0, 125.0, 132.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 159.0, 158.0, 165.0, 166.0, 159.0, 163.0, 165.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 65.0, 66.0, 63.0, 64.0, 64.0, 63.0, 63.0, 66.0], "value": 64.7, "unit": "score"}]}]} 04:19:50 INFO - Return code: 0 04:19:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:19:50 ERROR - # TBPL SUCCESS # 04:19:50 INFO - Running post-action listener: _resource_record_post_action 04:19:50 INFO - ##### 04:19:50 INFO - ##### Finished run-tests step (success) 04:19:50 INFO - ##### 04:19:50 INFO - Running post-run listener: _resource_record_post_run 04:19:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 541409280; Read time: 168; Write time: 417296 04:19:50 INFO - TinderboxPrint: CPU usage
13.5% 04:19:50 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 168 04:19:50 INFO - TinderboxPrint: I/O write bytes / time
541,409,280 / 417,296 04:19:50 INFO - TinderboxPrint: CPU idle
8,216.9 (86.5%) 04:19:50 INFO - TinderboxPrint: CPU user
1,222.6 (12.9%) 04:19:50 INFO - TinderboxPrint: Swap in / out
0 / 0 04:19:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 247930880; Read time: 140; Write time: 224044 04:19:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293478400; Read time: 28; Write time: 193252 04:19:50 INFO - Running post-run listener: _upload_blobber_files 04:19:50 INFO - Blob upload gear active. 04:19:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:50 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 04:19:50 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:19:50 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:19:51 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:52 INFO - (blobuploader) - INFO - Done attempting. 04:19:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:19:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:19:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:55 INFO - (blobuploader) - INFO - Done attempting. 04:19:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:19:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:56 INFO - (blobuploader) - INFO - Done attempting. 04:19:56 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:56 INFO - Return code: 0 04:19:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e50a15a272a0908d791b5e81bacc524ba27147a7c28a8dc30250dc1e3ba6107bc813e857e64e57a665c1e0322d5ba858172ce77501b95bda76aa9c59082105e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4b4f3a1511f17ae8184ddedea8c2d10c4d447c1782bf2d51c7ed7586000e43dcd3e88a8deef1800cec93779bd57f777363e037403cece39fb7648917ffa4f1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/119a241d0902982655ab9ce1659b0f86fb906e014096d366e78e467bdd0ab7848422a88b931280f1d7a7e44284d2ea13861d1d1c4abb4f89a651d163b1d40290"} 04:19:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:56 INFO - Contents: 04:19:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e50a15a272a0908d791b5e81bacc524ba27147a7c28a8dc30250dc1e3ba6107bc813e857e64e57a665c1e0322d5ba858172ce77501b95bda76aa9c59082105e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4b4f3a1511f17ae8184ddedea8c2d10c4d447c1782bf2d51c7ed7586000e43dcd3e88a8deef1800cec93779bd57f777363e037403cece39fb7648917ffa4f1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/119a241d0902982655ab9ce1659b0f86fb906e014096d366e78e467bdd0ab7848422a88b931280f1d7a7e44284d2ea13861d1d1c4abb4f89a651d163b1d40290"} 04:19:56 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:56 INFO - Copying logs to upload dir... 04:19:56 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.776324 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-06 04:19:55.914858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 04:19:55.918021) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566 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/Mozilla-Inbound/sha512/e50a15a272a0908d791b5e81bacc524ba27147a7c28a8dc30250dc1e3ba6107bc813e857e64e57a665c1e0322d5ba858172ce77501b95bda76aa9c59082105e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4b4f3a1511f17ae8184ddedea8c2d10c4d447c1782bf2d51c7ed7586000e43dcd3e88a8deef1800cec93779bd57f777363e037403cece39fb7648917ffa4f1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/119a241d0902982655ab9ce1659b0f86fb906e014096d366e78e467bdd0ab7848422a88b931280f1d7a7e44284d2ea13861d1d1c4abb4f89a651d163b1d40290"} build_url:https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/TssBR7oXQ4C765ANEPx8Fg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e50a15a272a0908d791b5e81bacc524ba27147a7c28a8dc30250dc1e3ba6107bc813e857e64e57a665c1e0322d5ba858172ce77501b95bda76aa9c59082105e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4b4f3a1511f17ae8184ddedea8c2d10c4d447c1782bf2d51c7ed7586000e43dcd3e88a8deef1800cec93779bd57f777363e037403cece39fb7648917ffa4f1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/119a241d0902982655ab9ce1659b0f86fb906e014096d366e78e467bdd0ab7848422a88b931280f1d7a7e44284d2ea13861d1d1c4abb4f89a651d163b1d40290"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 04:19:55.943708) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:19:55.944091) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465210482.205662-1720005566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:19:56.028722) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 04:19:56.029034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 04:19:56.029413) ========= ========= Total master_lag: 0.17 =========