builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0025 starttime: 1484710022.91 results: success (0) buildid: 20170117173626 builduid: 6f319a72767e40139317a068231db72d revision: 80eac484366ad881c6a10bf81e8d9b8f7a676c75 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:02.909253) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:02.909750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:02.910250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:02.940138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:02.940802) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-17 19:27:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2017-01-17 19:27:03 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126832 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.094529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.095258) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026290 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.147004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.147826) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 80eac484366ad881c6a10bf81e8d9b8f7a676c75 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 80eac484366ad881c6a10bf81e8d9b8f7a676c75 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-17 19:27:03,244 truncating revision to first 12 chars 2017-01-17 19:27:03,245 Setting DEBUG logging. 2017-01-17 19:27:03,245 attempt 1/10 2017-01-17 19:27:03,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/80eac484366a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 19:27:03,568 unpacking tar archive at: mozilla-central-80eac484366a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581368 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.755475) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.755876) ========= script_repo_revision: 80eac484366ad881c6a10bf81e8d9b8f7a676c75 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.756390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.756730) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 19:27:03.778146) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-17 19:27:03.778879) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:27:03 INFO - MultiFileLogger online at 20170117 19:27:03 in /builds/slave/test 19:27:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:27:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:27:03 INFO - {'append_to_log': False, 19:27:03 INFO - 'base_work_dir': '/builds/slave/test', 19:27:03 INFO - 'blob_upload_branch': 'Firefox', 19:27:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:27:03 INFO - 'branch': 'Firefox', 19:27:03 INFO - 'buildbot_json_path': 'buildprops.json', 19:27:03 INFO - 'config_files': ('talos/mac_config.py',), 19:27:03 INFO - 'default_actions': ('clobber', 19:27:03 INFO - 'read-buildbot-config', 19:27:03 INFO - 'download-and-extract', 19:27:03 INFO - 'populate-webroot', 19:27:03 INFO - 'create-virtualenv', 19:27:03 INFO - 'install', 19:27:03 INFO - 'run-tests'), 19:27:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:27:03 INFO - 'download_minidump_stackwalk': True, 19:27:03 INFO - 'download_symbols': 'ondemand', 19:27:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:27:03 INFO - 'tooltool.py': '/tools/tooltool.py', 19:27:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:27:03 INFO - '/tools/misc-python/virtualenv.py')}, 19:27:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:27:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:27:03 INFO - 'installer_path': 'installer.exe', 19:27:03 INFO - 'log_level': 'info', 19:27:03 INFO - 'log_name': 'talos', 19:27:03 INFO - 'log_to_console': True, 19:27:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:27:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:27:03 INFO - 'opt_config_files': (), 19:27:03 INFO - 'pip_index': False, 19:27:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:27:03 INFO - 'cmd': ('bash', 19:27:03 INFO - '-c', 19:27:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:27:03 INFO - 'enabled': True, 19:27:03 INFO - 'halt_on_failure': False, 19:27:03 INFO - 'name': 'check_screen_resolution'},), 19:27:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:27:03 INFO - 'cmd': ('bash', 19:27:03 INFO - '-c', 19:27:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:27:03 INFO - 'enabled': True, 19:27:03 INFO - 'halt_on_failure': False, 19:27:03 INFO - 'name': 'check_screen_resolution'},), 19:27:03 INFO - 'run_cmd_checks_enabled': True, 19:27:03 INFO - 'sps_profile': False, 19:27:03 INFO - 'sps_profile_interval': 0, 19:27:03 INFO - 'suite': 'dromaeojs', 19:27:03 INFO - 'system_bits': '32', 19:27:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:27:03 INFO - 'title': 't-yosemite-r7-0025', 19:27:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:27:03 INFO - 'use_talos_json': True, 19:27:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:27:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:27:03 INFO - 'work_dir': 'build'} 19:27:03 INFO - [mozharness: 2017-01-18 03:27:03.986690Z] Running clobber step. 19:27:03 INFO - Running pre-action listener: _resource_record_pre_action 19:27:03 INFO - Running main action method: clobber 19:27:03 INFO - rmtree: /builds/slave/test/build 19:27:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:27:06 INFO - Running post-action listener: _resource_record_post_action 19:27:06 INFO - [mozharness: 2017-01-18 03:27:06.445541Z] Finished clobber step (success) 19:27:06 INFO - [mozharness: 2017-01-18 03:27:06.445665Z] Running read-buildbot-config step. 19:27:06 INFO - Running pre-action listener: _resource_record_pre_action 19:27:06 INFO - Running main action method: read_buildbot_config 19:27:06 INFO - Using buildbot properties: 19:27:06 INFO - { 19:27:06 INFO - "project": "", 19:27:06 INFO - "product": "firefox", 19:27:06 INFO - "script_repo_revision": "production", 19:27:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:27:06 INFO - "repository": "", 19:27:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:27:06 INFO - "buildid": "20170117173626", 19:27:06 INFO - "pgo_build": "False", 19:27:06 INFO - "basedir": "/builds/slave/test", 19:27:06 INFO - "buildnumber": 17, 19:27:06 INFO - "slavename": "t-yosemite-r7-0025", 19:27:06 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:27:06 INFO - "platform": "yosemite_r7", 19:27:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:27:06 INFO - "branch": "mozilla-central", 19:27:06 INFO - "repo_path": "mozilla-central", 19:27:06 INFO - "revision": "80eac484366ad881c6a10bf81e8d9b8f7a676c75", 19:27:06 INFO - "stage_platform": "macosx64", 19:27:06 INFO - "builduid": "6f319a72767e40139317a068231db72d", 19:27:06 INFO - "slavebuilddir": "test" 19:27:06 INFO - } 19:27:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:27:06 INFO - Running post-action listener: _resource_record_post_action 19:27:06 INFO - [mozharness: 2017-01-18 03:27:06.449142Z] Finished read-buildbot-config step (success) 19:27:06 INFO - [mozharness: 2017-01-18 03:27:06.449283Z] Running download-and-extract step. 19:27:06 INFO - Running pre-action listener: _resource_record_pre_action 19:27:06 INFO - Running main action method: download_and_extract 19:27:06 INFO - mkdir: /builds/slave/test/build/tests 19:27:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:06 INFO - trying https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:27:06 INFO - Downloading https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 19:27:07 INFO - Downloaded 1199 bytes. 19:27:07 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:27:07 INFO - Using the following test package requirements: 19:27:07 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:27:07 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:07 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:27:07 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:07 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:27:07 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:07 INFO - u'jsshell-mac.zip'], 19:27:07 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:07 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:27:07 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:27:07 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:07 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:27:07 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:07 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:27:07 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:07 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:27:07 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:07 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:27:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:27:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:27:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:27:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:27:08 INFO - Expected file size: 16326930 19:27:08 INFO - Obtained file size: 16326930 19:27:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:27:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:27:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:27:14 INFO - Fetch https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:27:15 INFO - Expected file size: 16326930 19:27:15 INFO - Obtained file size: 16326930 19:27:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:27:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:27:22 INFO - Fetch https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:27:23 INFO - Expected file size: 14403463 19:27:23 INFO - Obtained file size: 14403463 19:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:23 INFO - trying https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:27:23 INFO - Downloading https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:27:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 19:27:25 INFO - Downloaded 70133232 bytes. 19:27:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:27:25 INFO - mkdir: /builds/slave/test/properties 19:27:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:25 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:25 INFO - Contents: 19:27:25 INFO - build_url:https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:27:26 INFO - Running post-action listener: _resource_record_post_action 19:27:26 INFO - Running post-action listener: set_extra_try_arguments 19:27:26 INFO - [mozharness: 2017-01-18 03:27:26.218784Z] Finished download-and-extract step (success) 19:27:26 INFO - [mozharness: 2017-01-18 03:27:26.218934Z] Running populate-webroot step. 19:27:26 INFO - Running pre-action listener: _resource_record_pre_action 19:27:26 INFO - Running main action method: populate_webroot 19:27:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:26 INFO - '--tppagecycles', 19:27:26 INFO - '7'], 19:27:26 INFO - 'tests': ['tsvgm']}}, 19:27:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:27:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:27:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:27:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:27:26 INFO - 'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:27:26 INFO - 'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['damp', 'tps']}, 19:27:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:27:26 INFO - 'tests': ['damp', 'tps']}, 19:27:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['dromaeo_dom']}, 19:27:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['basic_compositor_video']}, 19:27:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:27:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['a11yr', 19:27:26 INFO - 'ts_paint', 19:27:26 INFO - 'tpaint', 19:27:26 INFO - 'sessionrestore', 19:27:26 INFO - 'sessionrestore_no_auto_restore', 19:27:26 INFO - 'tabpaint']}, 19:27:26 INFO - 'other-e10s': {'tests': ['a11yr', 19:27:26 INFO - 'ts_paint', 19:27:26 INFO - 'tpaint', 19:27:26 INFO - 'sessionrestore', 19:27:26 INFO - 'sessionrestore_no_auto_restore', 19:27:26 INFO - 'tabpaint']}, 19:27:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:27:26 INFO - 'ts_paint', 19:27:26 INFO - 'tpaint', 19:27:26 INFO - 'sessionrestore', 19:27:26 INFO - 'sessionrestore_no_auto_restore', 19:27:26 INFO - 'tabpaint']}, 19:27:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:27:26 INFO - 'ts_paint', 19:27:26 INFO - 'tpaint', 19:27:26 INFO - 'sessionrestore', 19:27:26 INFO - 'sessionrestore_no_auto_restore', 19:27:26 INFO - 'tabpaint']}, 19:27:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['a11yr', 19:27:26 INFO - 'ts_paint', 19:27:26 INFO - 'tpaint', 19:27:26 INFO - 'sessionrestore', 19:27:26 INFO - 'sessionrestore_no_auto_restore', 19:27:26 INFO - 'tabpaint']}, 19:27:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['a11yr', 19:27:26 INFO - 'ts_paint', 19:27:26 INFO - 'tpaint', 19:27:26 INFO - 'sessionrestore', 19:27:26 INFO - 'sessionrestore_no_auto_restore', 19:27:26 INFO - 'tabpaint']}, 19:27:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['tsvgx', 19:27:26 INFO - 'tsvgr_opacity', 19:27:26 INFO - 'tart', 19:27:26 INFO - 'tscrollx', 19:27:26 INFO - 'cart', 19:27:26 INFO - 'tsvg_static']}, 19:27:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:27:26 INFO - 'tsvgr_opacity', 19:27:26 INFO - 'tart', 19:27:26 INFO - 'tscrollx', 19:27:26 INFO - 'cart', 19:27:26 INFO - 'tsvg_static']}, 19:27:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:27:26 INFO - 'talos_options': ['--disable-e10s'], 19:27:26 INFO - 'tests': ['tp5o']}, 19:27:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:27:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:27:26 INFO - 'talos_options': ['--disable-e10s', 19:27:26 INFO - '--xperf_path', 19:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:26 INFO - 'tests': ['tp5n']}, 19:27:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:27:26 INFO - 'talos_options': ['--xperf_path', 19:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:26 INFO - 'tests': ['tp5n']}}, 19:27:26 INFO - 'talos.zip': {'path': '', 19:27:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:26 INFO - Running post-action listener: _resource_record_post_action 19:27:26 INFO - [mozharness: 2017-01-18 03:27:26.237337Z] Finished populate-webroot step (success) 19:27:26 INFO - [mozharness: 2017-01-18 03:27:26.237465Z] Running create-virtualenv step. 19:27:26 INFO - Running pre-action listener: _resource_record_pre_action 19:27:26 INFO - Running main action method: create_virtualenv 19:27:26 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:26 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 19:27:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:26 INFO - Using real prefix '/tools/python27' 19:27:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:27 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:30 INFO - Installing pip.................done. 19:27:30 INFO - Return code: 0 19:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:27:30 INFO - Reading from file tmpfile_stdout 19:27:30 INFO - Output received: 19:27:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:27:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:30 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 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:30 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 19:27:30 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 19:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:30 INFO - 'HOME': '/Users/cltbld', 19:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:30 INFO - 'LOGNAME': 'cltbld', 19:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:30 INFO - 'MOZ_NO_REMOTE': '1', 19:27:30 INFO - 'NO_EM_RESTART': '1', 19:27:30 INFO - 'PAGER': '/bin/cat', 19:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:30 INFO - 'PWD': '/builds/slave/test', 19:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:30 INFO - 'SHELL': '/bin/bash', 19:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:30 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:30 INFO - 'USER': 'cltbld', 19:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:30 INFO - 'XPC_FLAGS': '0x0', 19:27:30 INFO - 'XPC_SERVICE_NAME': '0', 19:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:30 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 19:27:30 INFO - Cleaning up... 19:27:30 INFO - Return code: 0 19:27:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:30 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 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:30 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 19:27:30 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 19:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:30 INFO - 'HOME': '/Users/cltbld', 19:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:30 INFO - 'LOGNAME': 'cltbld', 19:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:30 INFO - 'MOZ_NO_REMOTE': '1', 19:27:30 INFO - 'NO_EM_RESTART': '1', 19:27:30 INFO - 'PAGER': '/bin/cat', 19:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:30 INFO - 'PWD': '/builds/slave/test', 19:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:30 INFO - 'SHELL': '/bin/bash', 19:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:30 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:30 INFO - 'USER': 'cltbld', 19:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:30 INFO - 'XPC_FLAGS': '0x0', 19:27:30 INFO - 'XPC_SERVICE_NAME': '0', 19:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:31 INFO - Downloading/unpacking psutil>=3.1.1 19:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:34 INFO - Installing collected packages: psutil 19:27:34 INFO - Running setup.py install for psutil 19:27:34 INFO - building 'psutil._psutil_osx' extension 19:27:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:27:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:27:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:27:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:27:35 INFO - building 'psutil._psutil_posix' extension 19:27:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:27:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:27:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:27:35 INFO - ^ 19:27:35 INFO - 1 warning generated. 19:27:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:27:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:35 INFO - Successfully installed psutil 19:27:35 INFO - Cleaning up... 19:27:35 INFO - Return code: 0 19:27:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:27:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:35 INFO - 'HOME': '/Users/cltbld', 19:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:35 INFO - 'LOGNAME': 'cltbld', 19:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:35 INFO - 'MOZ_NO_REMOTE': '1', 19:27:35 INFO - 'NO_EM_RESTART': '1', 19:27:35 INFO - 'PAGER': '/bin/cat', 19:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:35 INFO - 'PWD': '/builds/slave/test', 19:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:35 INFO - 'SHELL': '/bin/bash', 19:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:35 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:35 INFO - 'USER': 'cltbld', 19:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:35 INFO - 'XPC_FLAGS': '0x0', 19:27:35 INFO - 'XPC_SERVICE_NAME': '0', 19:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:27:38 INFO - Installing collected packages: mozsystemmonitor 19:27:38 INFO - Running setup.py install for mozsystemmonitor 19:27:38 INFO - Successfully installed mozsystemmonitor 19:27:38 INFO - Cleaning up... 19:27:39 INFO - Return code: 0 19:27:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:39 INFO - 'HOME': '/Users/cltbld', 19:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:39 INFO - 'LOGNAME': 'cltbld', 19:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:39 INFO - 'MOZ_NO_REMOTE': '1', 19:27:39 INFO - 'NO_EM_RESTART': '1', 19:27:39 INFO - 'PAGER': '/bin/cat', 19:27:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:39 INFO - 'PWD': '/builds/slave/test', 19:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:39 INFO - 'SHELL': '/bin/bash', 19:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:39 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:39 INFO - 'USER': 'cltbld', 19:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:39 INFO - 'XPC_FLAGS': '0x0', 19:27:39 INFO - 'XPC_SERVICE_NAME': '0', 19:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:39 INFO - Downloading/unpacking jsonschema==2.5.1 19:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:42 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:42 INFO - warning: no files found matching '*.txt' 19:27:42 INFO - no previously-included directories found matching 'build' 19:27:42 INFO - no previously-included directories found matching 'dist' 19:27:42 INFO - no previously-included directories found matching '.git*' 19:27:42 INFO - Installing collected packages: jsonschema, functools32 19:27:42 INFO - Running setup.py install for functools32 19:27:42 INFO - warning: no files found matching '*.txt' 19:27:42 INFO - no previously-included directories found matching 'build' 19:27:42 INFO - no previously-included directories found matching 'dist' 19:27:42 INFO - no previously-included directories found matching '.git*' 19:27:42 INFO - Successfully installed jsonschema functools32 19:27:42 INFO - Cleaning up... 19:27:42 INFO - Return code: 0 19:27:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:27: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 functools32==3.2.3-2 19:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:42 INFO - 'HOME': '/Users/cltbld', 19:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:42 INFO - 'LOGNAME': 'cltbld', 19:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:42 INFO - 'MOZ_NO_REMOTE': '1', 19:27:42 INFO - 'NO_EM_RESTART': '1', 19:27:42 INFO - 'PAGER': '/bin/cat', 19:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:42 INFO - 'PWD': '/builds/slave/test', 19:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:42 INFO - 'SHELL': '/bin/bash', 19:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:42 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:42 INFO - 'USER': 'cltbld', 19:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:42 INFO - 'XPC_FLAGS': '0x0', 19:27:42 INFO - 'XPC_SERVICE_NAME': '0', 19:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:27:43 INFO - Cleaning up... 19:27:43 INFO - Return code: 0 19:27:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:43 INFO - 'HOME': '/Users/cltbld', 19:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:43 INFO - 'LOGNAME': 'cltbld', 19:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:43 INFO - 'MOZ_NO_REMOTE': '1', 19:27:43 INFO - 'NO_EM_RESTART': '1', 19:27:43 INFO - 'PAGER': '/bin/cat', 19:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:43 INFO - 'PWD': '/builds/slave/test', 19:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:43 INFO - 'SHELL': '/bin/bash', 19:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:43 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:43 INFO - 'USER': 'cltbld', 19:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:43 INFO - 'XPC_FLAGS': '0x0', 19:27:43 INFO - 'XPC_SERVICE_NAME': '0', 19:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:47 INFO - Downloading docopt-0.6.1.tar.gz 19:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:47 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:47 INFO - Running setup.py install for blobuploader 19:27:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:47 INFO - Running setup.py install for requests 19:27:48 INFO - Running setup.py install for docopt 19:27:48 INFO - Successfully installed blobuploader requests docopt 19:27:48 INFO - Cleaning up... 19:27:48 INFO - Return code: 0 19:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27: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 19:27: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 19:27:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:48 INFO - 'HOME': '/Users/cltbld', 19:27:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:48 INFO - 'LOGNAME': 'cltbld', 19:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:48 INFO - 'MOZ_NO_REMOTE': '1', 19:27:48 INFO - 'NO_EM_RESTART': '1', 19:27:48 INFO - 'PAGER': '/bin/cat', 19:27:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:48 INFO - 'PWD': '/builds/slave/test', 19:27:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:48 INFO - 'SHELL': '/bin/bash', 19:27:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:48 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:48 INFO - 'USER': 'cltbld', 19:27:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:48 INFO - 'XPC_FLAGS': '0x0', 19:27:48 INFO - 'XPC_SERVICE_NAME': '0', 19:27:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-4BmePk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-owdqCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-wW4rGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-q_Vizi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-OTLiur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-JwcJab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-8RjRJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-PXqBai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-YfluUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-U3kWiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-6I3pA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-UGNDQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-OQ7C4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-nZRDZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-CFSJtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:50 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-akfubZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:50 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-vtyPis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:50 INFO - Running setup.py install for manifestparser 19:27:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:50 INFO - Running setup.py install for mozcrash 19:27:50 INFO - Running setup.py install for mozdebug 19:27:50 INFO - Running setup.py install for mozdevice 19:27:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:50 INFO - Running setup.py install for mozfile 19:27:51 INFO - Running setup.py install for mozhttpd 19:27:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for mozinfo 19:27:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for mozInstall 19:27:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for mozleak 19:27:51 INFO - Running setup.py install for mozlog 19:27:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for moznetwork 19:27:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for mozprocess 19:27:52 INFO - Running setup.py install for mozprofile 19:27:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Running setup.py install for mozrunner 19:27:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Running setup.py install for mozscreenshot 19:27:52 INFO - Running setup.py install for moztest 19:27:52 INFO - Running setup.py install for mozversion 19:27:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:52 INFO - Cleaning up... 19:27:52 INFO - Return code: 0 19:27:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27: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 19:27: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 19:27:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:52 INFO - 'HOME': '/Users/cltbld', 19:27:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:52 INFO - 'LOGNAME': 'cltbld', 19:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:52 INFO - 'MOZ_NO_REMOTE': '1', 19:27:52 INFO - 'NO_EM_RESTART': '1', 19:27:52 INFO - 'PAGER': '/bin/cat', 19:27:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:52 INFO - 'PWD': '/builds/slave/test', 19:27:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:52 INFO - 'SHELL': '/bin/bash', 19:27:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:52 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:52 INFO - 'USER': 'cltbld', 19:27:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:52 INFO - 'XPC_FLAGS': '0x0', 19:27:52 INFO - 'XPC_SERVICE_NAME': '0', 19:27:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-mIb_OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:53 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)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-gQc5mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-SMQYM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:53 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)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-IPYLqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-6TolV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:53 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)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9x7PwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:53 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)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-UsiyHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:53 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)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-EPr9aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:53 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)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-F87O6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:54 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-_4bM_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-fcLYK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:54 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zmRpYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-tCI_8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:54 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-OcfAm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-8otVk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:54 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ntAO5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-w6qgbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:54 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)) 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:27:54 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)) 19:27:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:27:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:27:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27:54 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 19:27:54 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 19:27:54 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 19:27:54 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 19:27:54 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 19:27:54 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 19:27:57 INFO - Downloading blessings-1.6.tar.gz 19:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:27:57 INFO - Installing collected packages: blessings 19:27:57 INFO - Running setup.py install for blessings 19:27:57 INFO - Successfully installed blessings 19:27:57 INFO - Cleaning up... 19:27:57 INFO - Return code: 0 19:27:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:58 INFO - Reading from file tmpfile_stdout 19:27:58 INFO - Current package versions: 19:27:58 INFO - blessings == 1.6 19:27:58 INFO - blobuploader == 1.2.4 19:27:58 INFO - docopt == 0.6.1 19:27:58 INFO - functools32 == 3.2.3-2 19:27:58 INFO - jsonschema == 2.5.1 19:27:58 INFO - manifestparser == 1.1 19:27:58 INFO - mozInstall == 1.12 19:27:58 INFO - mozcrash == 1.0 19:27:58 INFO - mozdebug == 0.1 19:27:58 INFO - mozdevice == 0.49 19:27:58 INFO - mozfile == 1.2 19:27:58 INFO - mozhttpd == 0.7 19:27:58 INFO - mozinfo == 0.9 19:27:58 INFO - mozleak == 0.1 19:27:58 INFO - mozlog == 3.4 19:27:58 INFO - moznetwork == 0.27 19:27:58 INFO - mozprocess == 0.24 19:27:58 INFO - mozprofile == 0.28 19:27:58 INFO - mozrunner == 6.13 19:27:58 INFO - mozscreenshot == 0.1 19:27:58 INFO - mozsystemmonitor == 0.3 19:27:58 INFO - moztest == 0.8 19:27:58 INFO - mozversion == 1.4 19:27:58 INFO - psutil == 3.1.1 19:27:58 INFO - requests == 1.2.3 19:27:58 INFO - wsgiref == 0.1.2 19:27:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 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 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:58 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 19:27:58 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 19:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:58 INFO - 'HOME': '/Users/cltbld', 19:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:58 INFO - 'LOGNAME': 'cltbld', 19:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:58 INFO - 'MOZ_NO_REMOTE': '1', 19:27:58 INFO - 'NO_EM_RESTART': '1', 19:27:58 INFO - 'PAGER': '/bin/cat', 19:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:58 INFO - 'PWD': '/builds/slave/test', 19:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:58 INFO - 'SHELL': '/bin/bash', 19:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:58 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:58 INFO - 'USER': 'cltbld', 19:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:58 INFO - 'XPC_FLAGS': '0x0', 19:27:58 INFO - 'XPC_SERVICE_NAME': '0', 19:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 INFO - Cleaning up... 19:27:58 INFO - Return code: 0 19:27:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:27:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 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 0x10b2eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb452496bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:58 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 19:27:58 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 19:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:58 INFO - 'HOME': '/Users/cltbld', 19:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:58 INFO - 'LOGNAME': 'cltbld', 19:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:58 INFO - 'MOZ_NO_REMOTE': '1', 19:27:58 INFO - 'NO_EM_RESTART': '1', 19:27:58 INFO - 'PAGER': '/bin/cat', 19:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:58 INFO - 'PWD': '/builds/slave/test', 19:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:58 INFO - 'SHELL': '/bin/bash', 19:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:27:58 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:58 INFO - 'USER': 'cltbld', 19:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:58 INFO - 'XPC_FLAGS': '0x0', 19:27:58 INFO - 'XPC_SERVICE_NAME': '0', 19:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:27:58 INFO - Cleaning up... 19:27:58 INFO - Return code: 0 19:27:58 INFO - Running post-action listener: _resource_record_post_action 19:27:58 INFO - Running post-action listener: _start_resource_monitoring 19:27:58 INFO - Starting resource monitoring. 19:27:58 INFO - [mozharness: 2017-01-18 03:27:58.684114Z] Finished create-virtualenv step (success) 19:27:58 INFO - [mozharness: 2017-01-18 03:27:58.685067Z] Running install step. 19:27:58 INFO - Running pre-action listener: _resource_record_pre_action 19:27:58 INFO - Running main action method: install 19:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:58 INFO - Reading from file tmpfile_stdout 19:27:58 INFO - Detecting whether we're running mozinstall >=1.0... 19:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:27:59 INFO - Reading from file tmpfile_stdout 19:27:59 INFO - Output received: 19:27:59 INFO - Usage: mozinstall [options] installer 19:27:59 INFO - Options: 19:27:59 INFO - -h, --help show this help message and exit 19:27:59 INFO - -d DEST, --destination=DEST 19:27:59 INFO - Directory to install application into. [default: 19:27:59 INFO - "/builds/slave/test"] 19:27:59 INFO - --app=APP Application being installed. [default: firefox] 19:27:59 INFO - mkdir: /builds/slave/test/build/application 19:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:28:21 INFO - Reading from file tmpfile_stdout 19:28:21 INFO - Output received: 19:28:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:28:21 INFO - Running post-action listener: _resource_record_post_action 19:28:21 INFO - [mozharness: 2017-01-18 03:28:21.049559Z] Finished install step (success) 19:28:21 INFO - [mozharness: 2017-01-18 03:28:21.049688Z] Running run-tests step. 19:28:21 INFO - Running pre-action listener: _resource_record_pre_action 19:28:21 INFO - Running main action method: run_tests 19:28:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:28:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:28:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:28:21 INFO - 2017-01-17 19:28:21.064 screenresolution[1624:7252] starting screenresolution argv=screenresolution get 19:28:21 INFO - 2017-01-17 19:28:21.066 screenresolution[1624:7252] Display 0: 1600x1200x32@60 19:28:21 INFO - 2017-01-17 19:28:21.072 screenresolution[1625:7254] starting screenresolution argv=screenresolution list 19:28:21 INFO - Available Modes on Display 0 19:28:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:28:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:28:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:28:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:28:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:28:21 INFO - Intel Iris: 19:28:21 INFO - Chipset Model: Intel Iris 19:28:21 INFO - Type: GPU 19:28:21 INFO - Bus: Built-In 19:28:21 INFO - VRAM (Dynamic, Max): 1536 MB 19:28:21 INFO - Vendor: Intel (0x8086) 19:28:21 INFO - Device ID: 0x0a2e 19:28:21 INFO - Revision ID: 0x0009 19:28:21 INFO - Displays: 19:28:21 INFO - Display: 19:28:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:28:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:28:21 INFO - Display Serial Number: 1600x1200 60 19:28:21 INFO - Main Display: Yes 19:28:21 INFO - Mirror: Off 19:28:21 INFO - Online: Yes 19:28:21 INFO - Rotation: Supported 19:28:21 INFO - Return code: 0 19:28:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:21 INFO - Python 2.7.3 19:28:21 INFO - Return code: 0 19:28:21 INFO - grabbing minidump binary from tooltool 19:28:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:21 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/macosx64/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 0x10b0ccd30>, '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 0x10aff3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:21 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:28:21 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:28:21 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:28:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:21 INFO - Return code: 0 19:28:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:28:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:28:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render', 19:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:21 INFO - 'HOME': '/Users/cltbld', 19:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:21 INFO - 'LOGNAME': 'cltbld', 19:28:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:21 INFO - 'MOZ_NO_REMOTE': '1', 19:28:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:21 INFO - 'NO_EM_RESTART': '1', 19:28:21 INFO - 'PAGER': '/bin/cat', 19:28:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:21 INFO - 'PWD': '/builds/slave/test', 19:28:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:21 INFO - 'SHELL': '/bin/bash', 19:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners', 19:28:21 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 19:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:21 INFO - 'USER': 'cltbld', 19:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:21 INFO - 'XPC_FLAGS': '0x0', 19:28:21 INFO - 'XPC_SERVICE_NAME': '0', 19:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:28:21 INFO - mozversion application_buildid: 20170117173626 19:28:21 INFO - mozversion application_changeset: 80eac484366ad881c6a10bf81e8d9b8f7a676c75 19:28:21 INFO - mozversion application_display_name: Nightly 19:28:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:21 INFO - mozversion application_name: Firefox 19:28:21 INFO - mozversion application_remotingname: firefox 19:28:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:28:21 INFO - mozversion application_vendor: Mozilla 19:28:21 INFO - mozversion application_version: 53.0a1 19:28:21 INFO - mozversion platform_buildid: 20170117173626 19:28:21 INFO - mozversion platform_changeset: 80eac484366ad881c6a10bf81e8d9b8f7a676c75 19:28:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:28:21 INFO - mozversion platform_version: 53.0a1 19:28:21 INFO - using testdate: 1484710101 19:28:21 INFO - actual date: 1484710101 19:28:21 INFO - starting webserver on 'localhost:49248' 19:28:21 INFO - SUITE-START | Running 2 tests 19:28:21 INFO - TEST-START | dromaeo_css 19:28:21 INFO - operating with platform_type : mac_ 19:28:21 INFO - Initialising browser for dromaeo_css test... 19:28:21 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpFVYsLZ/profile http://localhost:49248/getInfo.html) 19:28:23 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 19:28:23 INFO - PROCESS | 1635 | colorDepth:24 19:28:23 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 19:28:23 INFO - PROCESS | 1635 | __metrics 19:28:24 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:28:24 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:28:24 INFO - TEST-INFO | 1635: exit 0 19:28:24 INFO - Browser initialized. 19:28:24 INFO - Running cycle 1/1 for dromaeo_css test... 19:28:24 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpFVYsLZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:37 INFO - PROCESS | 1637 | RSS: Main: 226975744 19:28:37 INFO - PROCESS | 1637 | 19:31:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 19:31:43 INFO - PROCESS | 1637 | RSS: Main: 346058752 19:31:43 INFO - PROCESS | 1637 | 19:33:26 INFO - PROCESS | 1637 | ************************* 19:33:26 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 19:33:26 INFO - PROCESS | 1637 | 19:33:26 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:33:26 INFO - PROCESS | 1637 | Full stack: 19:33:26 INFO - PROCESS | 1637 | ************************* 19:34:46 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 19:34:47 INFO - PROCESS | 1637 | RSS: Main: 375590912 19:34:47 INFO - PROCESS | 1637 | 19:37:49 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 19:37:50 INFO - PROCESS | 1637 | RSS: Main: 358494208 19:37:50 INFO - PROCESS | 1637 | 19:40:52 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 19:40:53 INFO - PROCESS | 1637 | RSS: Main: 351334400 19:40:53 INFO - PROCESS | 1637 | 19:43:56 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 19:43:57 INFO - PROCESS | 1637 | RSS: Main: 329048064 19:43:57 INFO - PROCESS | 1637 | 19:47:00 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 19:47:01 INFO - PROCESS | 1637 | RSS: Main: 380702720 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - PROCESS | 1637 | __start_tp_report 19:47:01 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 19:47:01 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 19:47:01 INFO - PROCESS | 1637 | |i|pagename|runs| 19:47:01 INFO - PROCESS | 1637 | |0;dojo.html;2945.823250604963;3353.849076791544;3366.444536651452;3380.27324125313;3414.3171365726844;5560.499555040045;5641.802536911209;5678.943210567893;5690.914636280449;5714;5621.0444224481835;5664.2636457260605;5737.225474560943;5740.655560666363;5765.481106700407;4175.540690524055;5136.8972620547565;5168.8449346519665;5178.378594568657;5205.817796377128;5178.818741344035;5257.13257312543;5265.394479634852;5280;5322.2282768998475;5235.1623740201385;5265.9473405266035;5267;5270.947290527103;5297.966896455193;5031.6729412588065;5065.240213967897;5073.898522029539;5099.847004589868;5120.231965205212;3793.3172029034763;4981.750912454399;5047.798088076473;5062;5173.913478169589;5578.804741834017;5702.45826646468;5706.258186435778;5775;5793.623414478087;6162.661053642048;6198.442140207403;6198.690065496752;6230.96884515579;6238.563300568962;6254.437100660963;6266.373362663743;6310.463610593105;6315.905261421082;6340.524460665422;4630.768461576908;5715.2855893013375;5728.341240757366;5748.109043098327;5780.739866706008;5226.660267082628;6219.782307619212;6273.905891411632;6291.276503202099;6302.936970630235;6155.538334624921;6155.630662160195;6158.784442544579;6163.075538669235;6169.136320915076;6117.84705382369;6133.417325354084;6146.78486252979;6187.907181392193;6296.150019747367;4818.518148185153;5025.698458092526;5399.406065332811;5553.8333849984565;6113.449789518876;6175.783847565313;6178.783742569079;6179.0422484514975;6203.16257305267;6211.2857021442205;4956.207006878882;4960.330355401975;4964.081644895706;4984.152694042022;4988.7505624718615;4386.0789234261165;4427.048184640254;4427.623651989553;4435.778211089497;4467.865964021084;5744.339400968858;5784.537237021113;5794.942050579524;5818.970905145447;5843.3864444233595;5689.601727879009;6204.410580994799;6243.594166379171;6261.7182226799905;6266.749330026839;5565.833025009256;5567.721613919369;5639.802606908738;5684.573656975744;5754.971225143848;5439.428859969726;5488.313960754906;5489.204065410493;5495.917561236584;5505.834824955257;6284.5600807943;6285.59143655661;6292.087647291117;6297.653629050263;6334.42990130872;6211.9068213977735;6271.6550589718;6275.309715931336;6275.592086514362;6289.622622642656;6145.095020543467;6180.227471566054;6226.62640241587;6239.625622462667;6263.749450021948;6191.040388739752;6193.783217587363;6195.19462469876;6197.411245931629;6219.720112594853;6059.697015149137;6243.250809902841;6255.124282600348;6260.060990851227;6262.5929314594405;5977.222961015214;6022.638641681513;6027.969860150672;6044.153818465506;6092.573519853568;6103.747828245222;6107.795737660903;6115.605440958429;6139.324674285915;6149.2620885494025;5797.4782269595935;5858.297004359504;5860.267466566679;5905.852353691193;6022.879542409215;5970.283565972111;6019.217501724923;6052.485538729257;6090.299615544269;6125.509959203164;4975.651704380659;5672.2058911751565;5756.683382414008;5939.91090133657;5953.047512397996 19:47:01 INFO - PROCESS | 1637 | |1;ext.html;420.5668161793353;438.38188154701857;448.4192970103715;496.94399401272295;499.0561761937252;21931;32610;41075.58924410755;42680.57319426805;42836.78581607088;42517.57482425175;42852.92867678309;42866.78566607163;42988.57011429885;43033.924151896215;9164.495952722615;9411.388259763093;9415.905840941605;9417.717468475923;9420.199283060949;7214.639268036603;8252.628631711557;8452.492850428964;8567.571621418936;8568.143185681412;9493.81012379752;11128.721781955475;11355.318680879132;11557.364344961066;11562.190646654695;11202.775944481105;11293.491792869341;11296.322220666787;11305.717357066056;11309.547618095266;8257.05043919945;8480.83038339236;11097.83353249702;11178.04986576142;11178.664640060812;40492.19015619671;41185.588144118476;41196.58803411957;43123.13753724939;43165.56834431678;4010.7994600270163;4015.377616469452;4015.437838702584;4031.5363733170766;4158.500979882433;25654.23037308865;30099.088781556497;30282.84858575715;30751.769929202805;31080.378392432023;3077.3691393264326;3241.1248962780155;3264.6408895021527;3365.125067482448;3371.4605663094035;477907;478370;478869;480709;480892;61448;61596;61838.072428913605;62043.759124818156;62190.37809621936;66592.66703666451;66676.66661666661;66911.66544167248;66926;66976;15942.60143496422;16219;16227.513174604781;16231.431899883448;16238.269277882524;12379.93810030944;12457.750844983231;12475.376231188404;12492.312922789333;12524.499020039097;12871;15683.764743528856;15832.445864394691;16094.597635059217;18265.817341826678;5736.913946290809;7264.891026634605;7319.487635865545;7375.668094935741;7479.738209162653;786.7993661616366;816.8856360109589;856.6145234644434;874.54960695242;880.366136381804;25790.871045644653;29979.700202998127;30396.69603303983;30986.690133098382;31163.376732465225;1025.620520407454;1038.5793753529833;1082.1018554599664;1086.1419478611965;1145.4158379226487;15854.048757074383;15921.840781592267;15987.60030999211;16080.597985050234;16372.672546549002;601557;604333;608166;608511;609342.1592056648;61080;61124;61243.081353778834;61429.07856382069;61565.07652385218;1414.6251243420502;1433.104309806371;1458.4530800949644;1459.2849503743303;1469.1846025455548;27630.861845690644;28513;29479.26301842471;29481.82072717153;30297;52113;52490.58811177261;52496.21255681244;52572.474275256754;52775.73612131915;435641;437621;438190;439032;518719;40189.59810401859;40976.79511602542;41036.79481602573;41474.79262603668;41578.376324354555;36474.452883207305;46050;46962.83408825095;47605.28592071191;47847.28229076497;32379;38353.4246986301;38666.42000369941;38775;39477;38418.0395490115;38622;39047.80476097601;39554.2089158221;40320;31867.521987170676;37715.81142094382;37950.62049379471;38494.230115396975;38518;31924.6807531931;32806.507902381;34376;34423.483647744804;34641.59389300749;22327;25087.87456062708;25402.745972540037;25450.109246176296;25621.487570248864 19:47:01 INFO - PROCESS | 1637 | |2;jquery.html;368.60006892521614;388.6579809767404;393.9310620641388;400.13171418022887;423.15791574766223;14545.127292362466;15422;18480.537986550342;20483.897580512115;21125.366239012816;20805.687914681293;21046.473838154056;21236.681449778265;21385.893070534625;21598.676019859715;5770.798022069207;5807;6047.788327408542;6059.878802423949;6073.1497590337385;6028.8191354259225;6074.5747797654185;6075.878482430348;6081.483073938721;6083.513318934497;3581.4985901973746;3996.820143093568;4393.758343291118;4434.179676759793;6626.801195964129;6664.233613134503;6679.93320066798;6683.331666833326;6691.297413771581;6693.799186024427;5165.793368265265;5406.486383793534;5458.153986132156;5503.807366742185;5511.035568775448;13239.205647661074;13324.333783310893;13433.261170635611;13437.395317210749;13670.726585468235;2363.279199844047;2497.8509885452713;2574.5623244048556;2589.6245044468633;2638.287662331179;9742.318037737361;10458.267921245515;10655.360678359246;11814.350210738492;15885.761713574306;1767.2312544043255;1786.937457188992;1815.0833828916445;1823.626156637886;1847.7402434844767;135365;142167;142325.2883735585;144052.27973860168;147301;11827.172097953233;11828.17202795796;11927.642170734893;11940.014996250937;12131.33277669719;15703.764443533357;15714.921425393028;15737.68524629501;15757.212139392985;15763.605909852346;7136.429085673238;8384.287335576544;8680.78298042554;8682.6092825823;8855;8479.576021199038;8482.491050536988;8488.236058754741;8639;8641.827163456695;4680.555347242007;4753.738544380092;4791.281307803788;4841.540053694894;4902.289168070681;1965.6854903215417;2002.5694475687797;2013.2249084102725;2016.294296996069;2016.7882372350691;686.584616307137;859.4456575508761;863.4689665855453;873.2844426361262;890.7751841218325;21853.132872166007;21855.904221676607;21871.861420204466;22033.228836990947;24522.264332070066;1021.1626466297565;1026.5996261458038;1032.5198782566142;1050.448514529878;1057.5241141486363;10839;11127.771606199174;11246.569796212234;11279.605213817476;11302.717432064264;695580;696640;713290;722672;738932;151044;152179;154433.22783386012;156816.21591891968;157108.214458927;1015.137133436573;1026.481626778487;1028.4343611013912;1053.131166787388;1053.7681710023783;18912.810871891106;19056.950887857874;19242.326518571783;19305.710414344077;19313;50458.990820182655;59961;60196;60688.39311607004;61484.69257653683;69401.30598693948;88936.555317223;90460.64309035239;91130;91713;6137.907931380943;7871.134175240604;8140.267375936194;8197.221263979913;8242.546659933761;10350.378977261389;12343.259404435763;12538.435770390537;12865.871341286467;13012.479500819862;10506.737331566772;10605.522751476048;10836.458177091272;10846.783064338511;10915.126789856951;9872.062154095349;10015.899841001788;10464.63373781914;10798.460076996276;11312.94343528277;11280.09759219277;11403.087752979907;11601.477933493183;11605.941970290094;11809;8002.7199048033035;8053.22828977624;8205.261526462647;8376.204260595234;8516.403851730567;7879.543073875845;8264.21489958453;9825.312228144247;10753.601607043796;11011.724706882393 19:47:01 INFO - PROCESS | 1637 | |3;mootools.html;1419.1809187072074;1427.3576890399315;1443.7978682984383;1457.9125252484853;1459.0589070049812;8071.394645401597;8447.746567602966;8451.492910425364;8459;8461.87307190392;7443.404527637789;7698;7703.229677032308;7997;8207.958960205191;2268.7731226877263;2318.3045086474076;2325.5697695926224;2326.5230627721276;2329.184785325131;2327.650852372141;2356.752540983198;2363.267387109993;2367.5146594948083;2369.715634123899;2291.461506545969;2303.8041766449787;2319.3969567912295;2320.2923108451914;2327.441414060622;2299.908003679851;2325.360525855386;2327.4995875886766;2329.988350058256;2331.9506222199907;2263.4228271790753;2309.90760369585;2350.15394457995;2356.304890057437;2361.1853910400882;8322.334213262924;8373;8383;8387.119352467964;8395.874061889077;5021.397432308147;5182.0931337016245;5185.766640501187;5185.896282074375;5190.6107041972;2896.9275768105754;3281.3273278977754;3458.291050334675;3489.581250249986;3493.510908472816;1172.1150531348862;1213.4418167642896;1216.3249396584893;1257.7547378261243;1269.3589737182663;10536.947315263375;10704.78590428195;10720.303180293256;10742.033217010507;10760.300580462244;4360.890977725582;4572.856785803549;4643.535646435329;4660.1145782301255;4666.2067448533835;9351.924528679154;9361.157495825408;9366.110219529133;9367.90632093684;9394.389364691273;5174.663646862942;5179.145441002268;5184.7407629618365;5185.714785686748;5200.6619569727845;4636.744979026186;4646.8141274348645;4683.086798074342;4710.835120770825;4730.692504987165;3160.2099475131217;3455.4644030175364;3541.486484459739;3771.962280377216;3892.1826416452295;1244.6017274472083;1246.1028059796931;1249.831407633847;1258.1947553565726;1261.1172179474404;762.881753328235;781.0861292288037;890.5947793753827;892.9508877011697;937.4000639590668;5386.757595908193;5634.154876768517;5681.57388195887;5842.824715258549;5987.427398706851;946.6982898514542;946.7443790176613;983.7835676151378;988;996.2577879479834;3302.966970330314;3769.792661403594;3798.905027374338;3877.2051729395407;3891.1633998690418;9690.56392462341;9930.950345248371;10000.899991000142;10025.24810639205;10027.147692446079;9351.953240233755;9702.417854928726;9727.756806079904;9924.553395097239;9952.402855828674;7584.62076896153;7745.535267883945;7774.067111946716;7801.570913599693;7808.141104478503;5476.205950137288;5519.8896022080135;5531.9723401382735;5597.524210442158;5869.970650146893;8942.016378198523;8942.329325300498;8984.820303594022;9228.123328283802;9230.215431688383;8881.777955550904;9057.05273366203;9238.491882946502;9263.53682315895;9360.344775865624;6571.901421478778;6828.248892621708;6833.4191593715095;6955.1653801544135;7057.188423331178;7907.090684571348;7919.16848730898;7926.881096783668;7992.040955085427;8009.359251260002;7072.929270707227;7133.82165445868;7168.605726685082;7177;7216.170140433917;6265.966115590876;6548.869022619616;6941.47938904574;7015.754448594274;7070.6111163884425;5797.188393624981;6079.1793107931635;6312.842178945563;6470.838229044123;6477.838054048498;4854.053459575349;4932.580730637936;4965.379327584052;5061.645684802029;5094.032133894548;4974.875628109182;4987.226979818134;5116;5152.716600587004;5229.607779416483 19:47:01 INFO - PROCESS | 1637 | |4;prototype.html;354.19420817639866;355.80252959607407;361.6166863125087;371.2815701617371;372.45435437084666;4293.914121717564;4933.383327084114;5160.690358578488;5243.31836861208;5323;5034.169362055257;5034.572061374778;5106.489351064892;5174.180071860836;5188.325517682696;3383.002014405744;4088.2641124597562;4107.630313271805;4118.423420721087;4118.5057793064725;3521.7710848794873;3591.4433262844173;4086.366613174948;4122.958770412302;4163.646090082331;3949.269385163754;3982.9644292484018;3985.9402108968243;3993.700472464562;3994.840206391741;3923.8430462781453;3929.2337994091163;3954.228925359556;3957.9511429471213;3976.1848820991627;3457.9798959307063;3467.4625433057918;3470.670286322795;3475.565554305712;3477.6174620791694;4224.493060832689;4779.737114458703;4819.469858315582;5011.924821127686;5082.669626474268;3905.7070719696135;4481.686281960264;4506.819727210907;4510.488986189631;4526.75102869342;4739.355431676976;5372.91940620891;5445.863853403657;5502.724863756836;5541.5843811714285;3408.1255309579633;3513.4905438711244;3761.7398171612545;3790.9764363621944;3836.7506112102624;4954.851354459372;5436.10304299794;5626.831195064155;5731.856703582402;5805.303363596396;3373.983130084383;3730.403135498307;3827.73205875586;3833.1758671885677;3877.905930797338;3906.648401643866;3913.0608653923423;3926.2736393767245;3943.6253555912144;3950.111224974415;4245.8513952011535;4480.32795080734;4497.908472560275;4523.841665541756;4546.727196368162;4695.7886895089805;5496.340439147328;5559.8888022239325;5569.832905012856;5569.888602227933;1092.4373947417087;1105.9557617695364;1183.6685727996176;1203.8082298524398;1224.8713885041943;746.8468963862396;846.9872951905726;859.6432480520639;868.700298397052;871.675053918041;4782.1025863920795;4801.639877009238;4818.590704647676;4874.8537543873745;4937.925931111036;5268.578513718893;5402.35171779389;5406.864828379244;5441.5102640762525;5468.781248750085;4094.0727379923496;4353.9129217415475;4486.820527178941;4860.8298709545;5154.659788455028;2336.4158960259933;2465.6685389889617;2706.8240564363255;2817.535106707411;2817.999610138412;5236.397814251333;5492.5605951523785;5531.419200983919;5560.388357280696;5560.749766260528;4896.5103489651465;4996.575291100225;5382.381026181961;5428.327397869157;5574.766635351486;4668.828994517566;4841.757912104381;5256.632035757537;5507.642003269774;5548.140038294152;4550.431196100488;4701.42691554428;4950.8762280943265;5079.492050795039;5490.890182196254;4869.805207791649;5076.543111120017;5253.789848406021;5296.894062118813;5311.946880531145;4741.5495527924795;4844.352920007214;5392.919106213331;5489.780408783604;5524.33707955048;2929.2717296794995;3136.85884135219;3423.537822393945;3457.325821464891;3601.1537288736604;4825.841797968392;4867.415910090812;5269.362960594653;5332.493413125747;5486.807961721321;4664.510226426177;5130.743462826769;5178.61160412963;5198.402183748917;5290.25936368901;4853.733044682576;5126.4617215191865;5181.699189672638;5182.378114626269;5224.7126408047925;4480.372747815243;4866.732329721899;4913.140200464976;5204.479552044765;5225.425203227566;4967.137323503686;5414.431484694208;5451.127819548853;5460.170842767718;5474;4856.834359753563;5144.434112247575;5323.840284791462;5381.67709937405;5407 19:47:01 INFO - PROCESS | 1637 | |5;yui.html;681.7034589953371;694.3542505469912;711.1643818513246;727.3054233207288;824.6289169873554;14720.6319842004;15224.771628425582;15480.612984675388;15627.609309767247;15768.369265229405;13861.4455421783;14228.786568201485;14249.287535623229;14450.638734031629;14457.277136143177;835.5237514616656;861.0012385632667;866.6706651472432;866.757307953774;867.1805144138791;677.6916502991127;698.3296035805607;836.6569706420369;855.4995327733284;858.5535521528801;908.6774195160722;924.0943875002501;924.9260059195249;925.3799954030816;927.2674587076202;914.7164379042518;916.8670542771328;917.1653795046509;917.4586993673698;919.9264058875274;520.8437468759357;537.5699440447665;685.3215316836346;686.0669489494284;686.7115811359241;12449.25304481734;14616.342264598119;15175.772363414557;15562.533124006299;15589.454369097028;12747.42636581356;12855.16441431304;12913.612591622266;12984.740305193938;13109.016823738259;9603.951980240054;11792.705182370424;11889.28664280146;12026.819597706042;12401.503939842396;3734.850605975758;3741.2330472253125;3743.794091324976;3746.925061498782;3808.1812410331636;80904;104979;106172.46913765381;106445;107000.4649976753;9718.70843874685;10855.782884342269;11147.888521114848;11457.484413201426;11491.023263022737;22269.554608907732;23828.16601418942;24108;24160.87919560391;24186.758132418803;7756.3019328260725;7803.609819509115;7848.960755196187;7851.685932562747;7985.800354991055;3561.30554541867;4107.075907920694;4184.4141820145205;4194.967832599948;4287.164003019444;3623.0761155905075;3663.7618554793853;3695;3731.645493678096;3745.8127093645207;640.6828619833212;654.4946622767616;658.3613894522306;672.7779832655212;674.3829396102511;554.9472800083986;655.2661019658013;662.6090606542164;705.4391758551964;719.9352058314777;9980.750481238027;10075.546600402853;10229.539670714836;10386.636467723745;10440.321379110334;654.5712558274338;687.6037011016604;687.8314812870778;690.9343612356818;702.7470110760122;4680.5085466025575;4960.255961605788;4974.552290293891;4980.651354405157;4980.950190498121;105776;107332.46333768437;108009.45995269973;108937.37438379395;113642;67337.32662673408;84121;86243.13756862351;87996.12003880007;89149;82038.76941845877;83252;83284.58357708294;83903.16096839198;85879;8822.5588720565;9484.95257523708;9640.843098827905;9644.276679248944;9687.757806054624;47481.76259118682;47716;47845.521544784104;49176.50823491719;50156.489045766444;66051.00923486055;66538.33461665321;69341.30658693348;69994.65002674954;71331.65012624177;12744.299063551594;12775.1057425983;12965.092443528862;13107.606771796862;13372.438706325025;14288.928555357157;14307.64230894236;14375.938653113277;14478.348474318891;14958.775618365951;13463.528776492776;13551.051426400058;13738.313084345542;14064.507742228972;14078.577642670736;13322.200667959953;13483.393247303698;13511.662208444868;13547.458101675822;13612.93193534026;10879.129669626253;11961.461734221806;12571.74856502883;13132.671683207996;13688.794668079787;11068.778624427627;11191.72020699489;11228.88771112311;11367.090632749525;11702.2978621283;10329.044044640339;10747.623833165802;10802.243842930919;10832.5125369357;10839.945800271264 19:47:01 INFO - PROCESS | 1637 | __end_tp_report 19:47:01 INFO - PROCESS | 1637 | __start_cc_report 19:47:01 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1150 19:47:01 INFO - PROCESS | 1637 | __end_cc_report 19:47:01 INFO - PROCESS | 1637 | __startTimestamp1484711221028__endTimestamp 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - PROCESS | 1637 | ------- Summary: start ------- 19:47:01 INFO - PROCESS | 1637 | Number of tests: 6 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5671.39 Median:5797.48 stddev:675.56 (11.7%) stddev-sans-first:642.90 19:47:01 INFO - PROCESS | 1637 | Values: 2945.8 3353.8 3366.4 3380.3 3414.3 5560.5 5641.8 5678.9 5690.9 5714.0 5621.0 5664.3 5737.2 5740.7 5765.5 4175.5 5136.9 5168.8 5178.4 5205.8 5178.8 5257.1 5265.4 5280.0 5322.2 5235.2 5265.9 5267.0 5270.9 5298.0 5031.7 5065.2 5073.9 5099.8 5120.2 3793.3 4981.8 5047.8 5062.0 5173.9 5578.8 5702.5 5706.3 5775.0 5793.6 6162.7 6198.4 6198.7 6231.0 6238.6 6254.4 6266.4 6310.5 6315.9 6340.5 4630.8 5715.3 5728.3 5748.1 5780.7 5226.7 6219.8 6273.9 6291.3 6302.9 6155.5 6155.6 6158.8 6163.1 6169.1 6117.8 6133.4 6146.8 6187.9 6296.2 4818.5 5025.7 5399.4 5553.8 6113.4 6175.8 6178.8 6179.0 6203.2 6211.3 4956.2 4960.3 4964.1 4984.2 4988.8 4386.1 4427.0 4427.6 4435.8 4467.9 5744.3 5784.5 5794.9 5819.0 5843.4 5689.6 6204.4 6243.6 6261.7 6266.7 5565.8 5567.7 5639.8 5684.6 5755.0 5439.4 5488.3 5489.2 5495.9 5505.8 6284.6 6285.6 6292.1 6297.7 6334.4 6211.9 6271.7 6275.3 6275.6 6289.6 6145.1 6180.2 6226.6 6239.6 6263.7 6191.0 6193.8 6195.2 6197.4 6219.7 6059.7 6243.3 6255.1 6260.1 6262.6 5977.2 6022.6 6028.0 6044.2 6092.6 6103.7 6107.8 6115.6 6139.3 6149.3 5797.5 5858.3 5860.3 5905.9 6022.9 5970.3 6019.2 6052.5 6090.3 6125.5 4975.7 5672.2 5756.7 5939.9 5953.0 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:66050.58 Median:4015.41 stddev:137935.28 (3435.2%) stddev-sans-first:138234.21 19:47:01 INFO - PROCESS | 1637 | Values: 420.6 438.4 448.4 496.9 499.1 21931.0 32610.0 41075.6 42680.6 42836.8 42517.6 42852.9 42866.8 42988.6 43033.9 9164.5 9411.4 9415.9 9417.7 9420.2 7214.6 8252.6 8452.5 8567.6 8568.1 9493.8 11128.7 11355.3 11557.4 11562.2 11202.8 11293.5 11296.3 11305.7 11309.5 8257.1 8480.8 11097.8 11178.0 11178.7 40492.2 41185.6 41196.6 43123.1 43165.6 4010.8 4015.4 4015.4 4031.5 4158.5 25654.2 30099.1 30282.8 30751.8 31080.4 3077.4 3241.1 3264.6 3365.1 3371.5 477907.0 478370.0 478869.0 480709.0 480892.0 61448.0 61596.0 61838.1 62043.8 62190.4 66592.7 66676.7 66911.7 66926.0 66976.0 15942.6 16219.0 16227.5 16231.4 16238.3 12379.9 12457.8 12475.4 12492.3 12524.5 12871.0 15683.8 15832.4 16094.6 18265.8 5736.9 7264.9 7319.5 7375.7 7479.7 786.8 816.9 856.6 874.5 880.4 25790.9 29979.7 30396.7 30986.7 31163.4 1025.6 1038.6 1082.1 1086.1 1145.4 15854.0 15921.8 15987.6 16080.6 16372.7 601557.0 604333.0 608166.0 608511.0 609342.2 61080.0 61124.0 61243.1 61429.1 61565.1 1414.6 1433.1 1458.5 1459.3 1469.2 27630.9 28513.0 29479.3 29481.8 30297.0 52113.0 52490.6 52496.2 52572.5 52775.7 435641.0 437621.0 438190.0 439032.0 518719.0 40189.6 40976.8 41036.8 41474.8 41578.4 36474.5 46050.0 46962.8 47605.3 47847.3 32379.0 38353.4 38666.4 38775.0 39477.0 38418.0 38622.0 39047.8 39554.2 40320.0 31867.5 37715.8 37950.6 38494.2 38518.0 31924.7 32806.5 34376.0 34423.5 34641.6 22327.0 25087.9 25402.7 25450.1 25621.5 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:39727.49 Median:21854.52 stddev:119476.35 (546.7%) stddev-sans-first:119774.96 19:47:01 INFO - PROCESS | 1637 | Values: 368.6 388.7 393.9 400.1 423.2 14545.1 15422.0 18480.5 20483.9 21125.4 20805.7 21046.5 21236.7 21385.9 21598.7 5770.8 5807.0 6047.8 6059.9 6073.1 6028.8 6074.6 6075.9 6081.5 6083.5 3581.5 3996.8 4393.8 4434.2 6626.8 6664.2 6679.9 6683.3 6691.3 6693.8 5165.8 5406.5 5458.2 5503.8 5511.0 13239.2 13324.3 13433.3 13437.4 13670.7 2363.3 2497.9 2574.6 2589.6 2638.3 9742.3 10458.3 10655.4 11814.4 15885.8 1767.2 1786.9 1815.1 1823.6 1847.7 135365.0 142167.0 142325.3 144052.3 147301.0 11827.2 11828.2 11927.6 11940.0 12131.3 15703.8 15714.9 15737.7 15757.2 15763.6 7136.4 8384.3 8680.8 8682.6 8855.0 8479.6 8482.5 8488.2 8639.0 8641.8 4680.6 4753.7 4791.3 4841.5 4902.3 1965.7 2002.6 2013.2 2016.3 2016.8 686.6 859.4 863.5 873.3 890.8 21853.1 21855.9 21871.9 22033.2 24522.3 1021.2 1026.6 1032.5 1050.4 1057.5 10839.0 11127.8 11246.6 11279.6 11302.7 695580.0 696640.0 713290.0 722672.0 738932.0 151044.0 152179.0 154433.2 156816.2 157108.2 1015.1 1026.5 1028.4 1053.1 1053.8 18912.8 19057.0 19242.3 19305.7 19313.0 50459.0 59961.0 60196.0 60688.4 61484.7 69401.3 88936.6 90460.6 91130.0 91713.0 6137.9 7871.1 8140.3 8197.2 8242.5 10350.4 12343.3 12538.4 12865.9 13012.5 10506.7 10605.5 10836.5 10846.8 10915.1 9872.1 10015.9 10464.6 10798.5 11312.9 11280.1 11403.1 11601.5 11605.9 11809.0 8002.7 8053.2 8205.3 8376.2 8516.4 7879.5 8264.2 9825.3 10753.6 11011.7 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5393.93 Median:5195.64 stddev:2916.75 (56.1%) stddev-sans-first:2909.63 19:47:01 INFO - PROCESS | 1637 | Values: 1419.2 1427.4 1443.8 1457.9 1459.1 8071.4 8447.7 8451.5 8459.0 8461.9 7443.4 7698.0 7703.2 7997.0 8208.0 2268.8 2318.3 2325.6 2326.5 2329.2 2327.7 2356.8 2363.3 2367.5 2369.7 2291.5 2303.8 2319.4 2320.3 2327.4 2299.9 2325.4 2327.5 2330.0 2332.0 2263.4 2309.9 2350.2 2356.3 2361.2 8322.3 8373.0 8383.0 8387.1 8395.9 5021.4 5182.1 5185.8 5185.9 5190.6 2896.9 3281.3 3458.3 3489.6 3493.5 1172.1 1213.4 1216.3 1257.8 1269.4 10536.9 10704.8 10720.3 10742.0 10760.3 4360.9 4572.9 4643.5 4660.1 4666.2 9351.9 9361.2 9366.1 9367.9 9394.4 5174.7 5179.1 5184.7 5185.7 5200.7 4636.7 4646.8 4683.1 4710.8 4730.7 3160.2 3455.5 3541.5 3772.0 3892.2 1244.6 1246.1 1249.8 1258.2 1261.1 762.9 781.1 890.6 893.0 937.4 5386.8 5634.2 5681.6 5842.8 5987.4 946.7 946.7 983.8 988.0 996.3 3303.0 3769.8 3798.9 3877.2 3891.2 9690.6 9931.0 10000.9 10025.2 10027.1 9352.0 9702.4 9727.8 9924.6 9952.4 7584.6 7745.5 7774.1 7801.6 7808.1 5476.2 5519.9 5532.0 5597.5 5870.0 8942.0 8942.3 8984.8 9228.1 9230.2 8881.8 9057.1 9238.5 9263.5 9360.3 6571.9 6828.2 6833.4 6955.2 7057.2 7907.1 7919.2 7926.9 7992.0 8009.4 7072.9 7133.8 7168.6 7177.0 7216.2 6266.0 6548.9 6941.5 7015.8 7070.6 5797.2 6079.2 6312.8 6470.8 6477.8 4854.1 4932.6 4965.4 5061.6 5094.0 4974.9 4987.2 5116.0 5152.7 5229.6 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4326.04 Median:4849.04 stddev:1305.60 (26.9%) stddev-sans-first:1274.78 19:47:01 INFO - PROCESS | 1637 | Values: 354.2 355.8 361.6 371.3 372.5 4293.9 4933.4 5160.7 5243.3 5323.0 5034.2 5034.6 5106.5 5174.2 5188.3 3383.0 4088.3 4107.6 4118.4 4118.5 3521.8 3591.4 4086.4 4123.0 4163.6 3949.3 3983.0 3985.9 3993.7 3994.8 3923.8 3929.2 3954.2 3958.0 3976.2 3458.0 3467.5 3470.7 3475.6 3477.6 4224.5 4779.7 4819.5 5011.9 5082.7 3905.7 4481.7 4506.8 4510.5 4526.8 4739.4 5372.9 5445.9 5502.7 5541.6 3408.1 3513.5 3761.7 3791.0 3836.8 4954.9 5436.1 5626.8 5731.9 5805.3 3374.0 3730.4 3827.7 3833.2 3877.9 3906.6 3913.1 3926.3 3943.6 3950.1 4245.9 4480.3 4497.9 4523.8 4546.7 4695.8 5496.3 5559.9 5569.8 5569.9 1092.4 1106.0 1183.7 1203.8 1224.9 746.8 847.0 859.6 868.7 871.7 4782.1 4801.6 4818.6 4874.9 4937.9 5268.6 5402.4 5406.9 5441.5 5468.8 4094.1 4353.9 4486.8 4860.8 5154.7 2336.4 2465.7 2706.8 2817.5 2818.0 5236.4 5492.6 5531.4 5560.4 5560.7 4896.5 4996.6 5382.4 5428.3 5574.8 4668.8 4841.8 5256.6 5507.6 5548.1 4550.4 4701.4 4950.9 5079.5 5490.9 4869.8 5076.5 5253.8 5296.9 5311.9 4741.5 4844.4 5392.9 5489.8 5524.3 2929.3 3136.9 3423.5 3457.3 3601.2 4825.8 4867.4 5269.4 5332.5 5486.8 4664.5 5130.7 5178.6 5198.4 5290.3 4853.7 5126.5 5181.7 5182.4 5224.7 4480.4 4866.7 4913.1 5204.5 5225.4 4967.1 5414.4 5451.1 5460.2 5474.0 4856.8 5144.4 5323.8 5381.7 5407.0 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20472.90 Median:3777.55 stddev:29522.89 (781.5%) stddev-sans-first:29568.30 19:47:01 INFO - PROCESS | 1637 | Values: 681.7 694.4 711.2 727.3 824.6 14720.6 15224.8 15480.6 15627.6 15768.4 13861.4 14228.8 14249.3 14450.6 14457.3 835.5 861.0 866.7 866.8 867.2 677.7 698.3 836.7 855.5 858.6 908.7 924.1 924.9 925.4 927.3 914.7 916.9 917.2 917.5 919.9 520.8 537.6 685.3 686.1 686.7 12449.3 14616.3 15175.8 15562.5 15589.5 12747.4 12855.2 12913.6 12984.7 13109.0 9604.0 11792.7 11889.3 12026.8 12401.5 3734.9 3741.2 3743.8 3746.9 3808.2 80904.0 104979.0 106172.5 106445.0 107000.5 9718.7 10855.8 11147.9 11457.5 11491.0 22269.6 23828.2 24108.0 24160.9 24186.8 7756.3 7803.6 7849.0 7851.7 7985.8 3561.3 4107.1 4184.4 4195.0 4287.2 3623.1 3663.8 3695.0 3731.6 3745.8 640.7 654.5 658.4 672.8 674.4 554.9 655.3 662.6 705.4 719.9 9980.8 10075.5 10229.5 10386.6 10440.3 654.6 687.6 687.8 690.9 702.7 4680.5 4960.3 4974.6 4980.7 4981.0 105776.0 107332.5 108009.5 108937.4 113642.0 67337.3 84121.0 86243.1 87996.1 89149.0 82038.8 83252.0 83284.6 83903.2 85879.0 8822.6 9485.0 9640.8 9644.3 9687.8 47481.8 47716.0 47845.5 49176.5 50156.5 66051.0 66538.3 69341.3 69994.7 71331.7 12744.3 12775.1 12965.1 13107.6 13372.4 14288.9 14307.6 14375.9 14478.3 14958.8 13463.5 13551.1 13738.3 14064.5 14078.6 13322.2 13483.4 13511.7 13547.5 13612.9 10879.1 11961.5 12571.7 13132.7 13688.8 11068.8 11191.7 11228.9 11367.1 11702.3 10329.0 10747.6 10802.2 10832.5 10839.9 19:47:01 INFO - PROCESS | 1637 | -------- Summary: end -------- 19:47:01 INFO - PROCESS | 1637 | 19:47:01 INFO - TEST-INFO | 1637: exit 0 19:47:01 INFO - TEST-OK | dromaeo_css | took 1120036ms 19:47:01 INFO - TEST-START | kraken 19:47:01 INFO - operating with platform_type : mac_ 19:47:01 INFO - Initialising browser for kraken test... 19:47:01 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpMQfFfW/profile http://localhost:49248/getInfo.html) 19:47:04 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 19:47:04 INFO - PROCESS | 1644 | colorDepth:24 19:47:04 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 19:47:04 INFO - PROCESS | 1644 | __metrics 19:47:04 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:47:04 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:05 INFO - TEST-INFO | 1644: exit 0 19:47:05 INFO - Browser initialized. 19:47:05 INFO - Running cycle 1/1 for kraken test... 19:47:05 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpMQfFfW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:17 INFO - PROCESS | 1645 | RSS: Main: 235393024 19:47:17 INFO - PROCESS | 1645 | 19:47:20 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 19:47:20 INFO - PROCESS | 1645 | RSS: Main: 289050624 19:47:20 INFO - PROCESS | 1645 | 19:47:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 19:47:24 INFO - PROCESS | 1645 | RSS: Main: 288899072 19:47:24 INFO - PROCESS | 1645 | 19:47:27 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 19:47:28 INFO - PROCESS | 1645 | RSS: Main: 380420096 19:47:28 INFO - PROCESS | 1645 | 19:47:30 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 19:47:30 INFO - PROCESS | 1645 | RSS: Main: 281706496 19:47:30 INFO - PROCESS | 1645 | 19:47:32 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:47:33 INFO - PROCESS | 1645 | RSS: Main: 285028352 19:47:33 INFO - PROCESS | 1645 | 19:47:35 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 19:47:36 INFO - PROCESS | 1645 | RSS: Main: 326578176 19:47:36 INFO - PROCESS | 1645 | 19:47:39 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 19:47:40 INFO - PROCESS | 1645 | RSS: Main: 330076160 19:47:40 INFO - PROCESS | 1645 | 19:47:42 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 19:47:43 INFO - PROCESS | 1645 | RSS: Main: 325287936 19:47:43 INFO - PROCESS | 1645 | 19:47:45 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:45 INFO - PROCESS | 1645 | RSS: Main: 303407104 19:47:45 INFO - PROCESS | 1645 | 19:47:47 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:48 INFO - PROCESS | 1645 | RSS: Main: 307171328 19:47:48 INFO - PROCESS | 1645 | 19:47:50 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:51 INFO - PROCESS | 1645 | RSS: Main: 307499008 19:47:51 INFO - PROCESS | 1645 | 19:47:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:55 INFO - PROCESS | 1645 | RSS: Main: 325132288 19:47:55 INFO - PROCESS | 1645 | 19:47:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:58 INFO - PROCESS | 1645 | RSS: Main: 319508480 19:47:58 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 19:48:00 INFO - PROCESS | 1645 | RSS: Main: 363765760 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | __start_tp_report 19:48:00 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 19:48:00 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 19:48:00 INFO - PROCESS | 1645 | |i|pagename|runs| 19:48:00 INFO - PROCESS | 1645 | |0;ai-astar;113;113;112;112;137;94;161;169;171;112 19:48:00 INFO - PROCESS | 1645 | |1;audio-beat-detection;142;112;114;145;108;109;110;111;130;108 19:48:00 INFO - PROCESS | 1645 | |2;audio-dft;184;184;182;186;183;182;180;182;181;183 19:48:00 INFO - PROCESS | 1645 | |3;audio-fft;80;59;59;87;62;60;59;58;73;57 19:48:00 INFO - PROCESS | 1645 | |4;audio-oscillator;85;70;85;69;68;68;81;67;67;82 19:48:00 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;85;83;86;83;85;81;85;83;86;83 19:48:00 INFO - PROCESS | 1645 | |6;imaging-darkroom;93;92;92;93;93;92;92;93;93;92 19:48:00 INFO - PROCESS | 1645 | |7;imaging-desaturate;88;86;86;86;87;86;103;139;131;86 19:48:00 INFO - PROCESS | 1645 | |8;json-parse-financial;56;56;54;55;56;56;55;55;56;54 19:48:00 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;64;70;70;78;73;71;69;70;70;70 19:48:00 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;90;87;88;88;86;87;85;96;92;94 19:48:00 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;149;152;137;137;161;153;153;136;192;175 19:48:00 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;174;175;173;174;172;175;175;183;176;172 19:48:00 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;68;67;70;77;86;87;89;69;67;67 19:48:00 INFO - PROCESS | 1645 | __end_tp_report 19:48:00 INFO - PROCESS | 1645 | __start_cc_report 19:48:00 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1952 19:48:00 INFO - PROCESS | 1645 | __end_cc_report 19:48:00 INFO - PROCESS | 1645 | __startTimestamp1484711280659__endTimestamp 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | ------- Summary: start ------- 19:48:00 INFO - PROCESS | 1645 | Number of tests: 14 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:129.40 Median:149.00 stddev:28.00 (18.8%) stddev-sans-first:29.06 19:48:00 INFO - PROCESS | 1645 | Values: 113.0 113.0 112.0 112.0 137.0 94.0 161.0 169.0 171.0 112.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:113.00 stddev:14.48 (12.8%) stddev-sans-first:12.72 19:48:00 INFO - PROCESS | 1645 | Values: 142.0 112.0 114.0 145.0 108.0 109.0 110.0 111.0 130.0 108.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.70 (0.9%) stddev-sans-first:1.74 19:48:00 INFO - PROCESS | 1645 | Values: 184.0 184.0 182.0 186.0 183.0 182.0 180.0 182.0 181.0 183.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:65.40 Median:61.00 stddev:10.68 (17.5%) stddev-sans-first:9.93 19:48:00 INFO - PROCESS | 1645 | Values: 80.0 59.0 59.0 87.0 62.0 60.0 59.0 58.0 73.0 57.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:74.20 Median:75.50 stddev:7.93 (10.5%) stddev-sans-first:7.38 19:48:00 INFO - PROCESS | 1645 | Values: 85.0 70.0 85.0 69.0 68.0 68.0 81.0 67.0 67.0 82.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:84.00 Median:85.00 stddev:1.63 (1.9%) stddev-sans-first:1.69 19:48:00 INFO - PROCESS | 1645 | Values: 85.0 83.0 86.0 83.0 85.0 81.0 85.0 83.0 86.0 83.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:92.50 Median:93.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 19:48:00 INFO - PROCESS | 1645 | Values: 93.0 92.0 92.0 93.0 93.0 92.0 92.0 93.0 93.0 92.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:97.80 Median:86.00 stddev:20.37 (23.7%) stddev-sans-first:21.30 19:48:00 INFO - PROCESS | 1645 | Values: 88.0 86.0 86.0 86.0 87.0 86.0 103.0 139.0 131.0 86.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 19:48:00 INFO - PROCESS | 1645 | Values: 56.0 56.0 54.0 55.0 56.0 56.0 55.0 55.0 56.0 54.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.00 stddev:3.47 (5.0%) stddev-sans-first:2.77 19:48:00 INFO - PROCESS | 1645 | Values: 64.0 70.0 70.0 78.0 73.0 71.0 69.0 70.0 70.0 70.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:89.00 stddev:3.62 (4.1%) stddev-sans-first:3.83 19:48:00 INFO - PROCESS | 1645 | Values: 90.0 87.0 88.0 88.0 86.0 87.0 85.0 96.0 92.0 94.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:153.00 stddev:17.84 (11.7%) stddev-sans-first:18.81 19:48:00 INFO - PROCESS | 1645 | Values: 149.0 152.0 137.0 137.0 161.0 153.0 153.0 136.0 192.0 175.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.00 stddev:3.14 (1.8%) stddev-sans-first:3.32 19:48:00 INFO - PROCESS | 1645 | Values: 174.0 175.0 173.0 174.0 172.0 175.0 175.0 183.0 176.0 172.0 19:48:00 INFO - PROCESS | 1645 | 19:48:00 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:73.50 stddev:9.23 (12.6%) stddev-sans-first:9.46 19:48:00 INFO - PROCESS | 1645 | Values: 68.0 67.0 70.0 77.0 86.0 87.0 89.0 69.0 67.0 67.0 19:48:00 INFO - PROCESS | 1645 | -------- Summary: end -------- 19:48:00 INFO - PROCESS | 1645 | 19:48:01 INFO - TEST-INFO | 1645: exit 0 19:48:01 INFO - TEST-OK | kraken | took 59879ms 19:48:01 INFO - SUITE-END | took 1179s 19:48:01 INFO - Completed test suite (00:19:40) 19:48:01 INFO - javascript benchmark 19:48:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2945.823250604963, 3353.849076791544, 3366.444536651452, 3380.27324125313, 3414.3171365726844, 5560.499555040045, 5641.802536911209, 5678.943210567893, 5690.914636280449, 5714.0, 5621.0444224481835, 5664.2636457260605, 5737.225474560943, 5740.655560666363, 5765.481106700407, 4175.540690524055, 5136.8972620547565, 5168.8449346519665, 5178.378594568657, 5205.817796377128, 5178.818741344035, 5257.13257312543, 5265.394479634852, 5280.0, 5322.2282768998475, 5235.1623740201385, 5265.9473405266035, 5267.0, 5270.947290527103, 5297.966896455193, 5031.6729412588065, 5065.240213967897, 5073.898522029539, 5099.847004589868, 5120.231965205212, 3793.3172029034763, 4981.750912454399, 5047.798088076473, 5062.0, 5173.913478169589, 5578.804741834017, 5702.45826646468, 5706.258186435778, 5775.0, 5793.623414478087, 6162.661053642048, 6198.442140207403, 6198.690065496752, 6230.96884515579, 6238.563300568962, 6254.437100660963, 6266.373362663743, 6310.463610593105, 6315.905261421082, 6340.524460665422, 4630.768461576908, 5715.2855893013375, 5728.341240757366, 5748.109043098327, 5780.739866706008, 5226.660267082628, 6219.782307619212, 6273.905891411632, 6291.276503202099, 6302.936970630235, 6155.538334624921, 6155.630662160195, 6158.784442544579, 6163.075538669235, 6169.136320915076, 6117.84705382369, 6133.417325354084, 6146.78486252979, 6187.907181392193, 6296.150019747367, 4818.518148185153, 5025.698458092526, 5399.406065332811, 5553.8333849984565, 6113.449789518876, 6175.783847565313, 6178.783742569079, 6179.0422484514975, 6203.16257305267, 6211.2857021442205, 4956.207006878882, 4960.330355401975, 4964.081644895706, 4984.152694042022, 4988.7505624718615, 4386.0789234261165, 4427.048184640254, 4427.623651989553, 4435.778211089497, 4467.865964021084, 5744.339400968858, 5784.537237021113, 5794.942050579524, 5818.970905145447, 5843.3864444233595, 5689.601727879009, 6204.410580994799, 6243.594166379171, 6261.7182226799905, 6266.749330026839, 5565.833025009256, 5567.721613919369, 5639.802606908738, 5684.573656975744, 5754.971225143848, 5439.428859969726, 5488.313960754906, 5489.204065410493, 5495.917561236584, 5505.834824955257, 6284.5600807943, 6285.59143655661, 6292.087647291117, 6297.653629050263, 6334.42990130872, 6211.9068213977735, 6271.6550589718, 6275.309715931336, 6275.592086514362, 6289.622622642656, 6145.095020543467, 6180.227471566054, 6226.62640241587, 6239.625622462667, 6263.749450021948, 6191.040388739752, 6193.783217587363, 6195.19462469876, 6197.411245931629, 6219.720112594853, 6059.697015149137, 6243.250809902841, 6255.124282600348, 6260.060990851227, 6262.5929314594405, 5977.222961015214, 6022.638641681513, 6027.969860150672, 6044.153818465506, 6092.573519853568, 6103.747828245222, 6107.795737660903, 6115.605440958429, 6139.324674285915, 6149.2620885494025, 5797.4782269595935, 5858.297004359504, 5860.267466566679, 5905.852353691193, 6022.879542409215, 5970.283565972111, 6019.217501724923, 6052.485538729257, 6090.299615544269, 6125.509959203164, 4975.651704380659, 5672.2058911751565, 5756.683382414008, 5939.91090133657, 5953.047512397996], "value": 5627.971457924944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.5668161793353, 438.38188154701857, 448.4192970103715, 496.94399401272295, 499.0561761937252, 21931.0, 32610.0, 41075.58924410755, 42680.57319426805, 42836.78581607088, 42517.57482425175, 42852.92867678309, 42866.78566607163, 42988.57011429885, 43033.924151896215, 9164.495952722615, 9411.388259763093, 9415.905840941605, 9417.717468475923, 9420.199283060949, 7214.639268036603, 8252.628631711557, 8452.492850428964, 8567.571621418936, 8568.143185681412, 9493.81012379752, 11128.721781955475, 11355.318680879132, 11557.364344961066, 11562.190646654695, 11202.775944481105, 11293.491792869341, 11296.322220666787, 11305.717357066056, 11309.547618095266, 8257.05043919945, 8480.83038339236, 11097.83353249702, 11178.04986576142, 11178.664640060812, 40492.19015619671, 41185.588144118476, 41196.58803411957, 43123.13753724939, 43165.56834431678, 4010.7994600270163, 4015.377616469452, 4015.437838702584, 4031.5363733170766, 4158.500979882433, 25654.23037308865, 30099.088781556497, 30282.84858575715, 30751.769929202805, 31080.378392432023, 3077.3691393264326, 3241.1248962780155, 3264.6408895021527, 3365.125067482448, 3371.4605663094035, 477907.0, 478370.0, 478869.0, 480709.0, 480892.0, 61448.0, 61596.0, 61838.072428913605, 62043.759124818156, 62190.37809621936, 66592.66703666451, 66676.66661666661, 66911.66544167248, 66926.0, 66976.0, 15942.60143496422, 16219.0, 16227.513174604781, 16231.431899883448, 16238.269277882524, 12379.93810030944, 12457.750844983231, 12475.376231188404, 12492.312922789333, 12524.499020039097, 12871.0, 15683.764743528856, 15832.445864394691, 16094.597635059217, 18265.817341826678, 5736.913946290809, 7264.891026634605, 7319.487635865545, 7375.668094935741, 7479.738209162653, 786.7993661616366, 816.8856360109589, 856.6145234644434, 874.54960695242, 880.366136381804, 25790.871045644653, 29979.700202998127, 30396.69603303983, 30986.690133098382, 31163.376732465225, 1025.620520407454, 1038.5793753529833, 1082.1018554599664, 1086.1419478611965, 1145.4158379226487, 15854.048757074383, 15921.840781592267, 15987.60030999211, 16080.597985050234, 16372.672546549002, 601557.0, 604333.0, 608166.0, 608511.0, 609342.1592056648, 61080.0, 61124.0, 61243.081353778834, 61429.07856382069, 61565.07652385218, 1414.6251243420502, 1433.104309806371, 1458.4530800949644, 1459.2849503743303, 1469.1846025455548, 27630.861845690644, 28513.0, 29479.26301842471, 29481.82072717153, 30297.0, 52113.0, 52490.58811177261, 52496.21255681244, 52572.474275256754, 52775.73612131915, 435641.0, 437621.0, 438190.0, 439032.0, 518719.0, 40189.59810401859, 40976.79511602542, 41036.79481602573, 41474.79262603668, 41578.376324354555, 36474.452883207305, 46050.0, 46962.83408825095, 47605.28592071191, 47847.28229076497, 32379.0, 38353.4246986301, 38666.42000369941, 38775.0, 39477.0, 38418.0395490115, 38622.0, 39047.80476097601, 39554.2089158221, 40320.0, 31867.521987170676, 37715.81142094382, 37950.62049379471, 38494.230115396975, 38518.0, 31924.6807531931, 32806.507902381, 34376.0, 34423.483647744804, 34641.59389300749, 22327.0, 25087.87456062708, 25402.745972540037, 25450.109246176296, 25621.487570248864], "value": 19985.63550264369, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.60006892521614, 388.6579809767404, 393.9310620641388, 400.13171418022887, 423.15791574766223, 14545.127292362466, 15422.0, 18480.537986550342, 20483.897580512115, 21125.366239012816, 20805.687914681293, 21046.473838154056, 21236.681449778265, 21385.893070534625, 21598.676019859715, 5770.798022069207, 5807.0, 6047.788327408542, 6059.878802423949, 6073.1497590337385, 6028.8191354259225, 6074.5747797654185, 6075.878482430348, 6081.483073938721, 6083.513318934497, 3581.4985901973746, 3996.820143093568, 4393.758343291118, 4434.179676759793, 6626.801195964129, 6664.233613134503, 6679.93320066798, 6683.331666833326, 6691.297413771581, 6693.799186024427, 5165.793368265265, 5406.486383793534, 5458.153986132156, 5503.807366742185, 5511.035568775448, 13239.205647661074, 13324.333783310893, 13433.261170635611, 13437.395317210749, 13670.726585468235, 2363.279199844047, 2497.8509885452713, 2574.5623244048556, 2589.6245044468633, 2638.287662331179, 9742.318037737361, 10458.267921245515, 10655.360678359246, 11814.350210738492, 15885.761713574306, 1767.2312544043255, 1786.937457188992, 1815.0833828916445, 1823.626156637886, 1847.7402434844767, 135365.0, 142167.0, 142325.2883735585, 144052.27973860168, 147301.0, 11827.172097953233, 11828.17202795796, 11927.642170734893, 11940.014996250937, 12131.33277669719, 15703.764443533357, 15714.921425393028, 15737.68524629501, 15757.212139392985, 15763.605909852346, 7136.429085673238, 8384.287335576544, 8680.78298042554, 8682.6092825823, 8855.0, 8479.576021199038, 8482.491050536988, 8488.236058754741, 8639.0, 8641.827163456695, 4680.555347242007, 4753.738544380092, 4791.281307803788, 4841.540053694894, 4902.289168070681, 1965.6854903215417, 2002.5694475687797, 2013.2249084102725, 2016.294296996069, 2016.7882372350691, 686.584616307137, 859.4456575508761, 863.4689665855453, 873.2844426361262, 890.7751841218325, 21853.132872166007, 21855.904221676607, 21871.861420204466, 22033.228836990947, 24522.264332070066, 1021.1626466297565, 1026.5996261458038, 1032.5198782566142, 1050.448514529878, 1057.5241141486363, 10839.0, 11127.771606199174, 11246.569796212234, 11279.605213817476, 11302.717432064264, 695580.0, 696640.0, 713290.0, 722672.0, 738932.0, 151044.0, 152179.0, 154433.22783386012, 156816.21591891968, 157108.214458927, 1015.137133436573, 1026.481626778487, 1028.4343611013912, 1053.131166787388, 1053.7681710023783, 18912.810871891106, 19056.950887857874, 19242.326518571783, 19305.710414344077, 19313.0, 50458.990820182655, 59961.0, 60196.0, 60688.39311607004, 61484.69257653683, 69401.30598693948, 88936.555317223, 90460.64309035239, 91130.0, 91713.0, 6137.907931380943, 7871.134175240604, 8140.267375936194, 8197.221263979913, 8242.546659933761, 10350.378977261389, 12343.259404435763, 12538.435770390537, 12865.871341286467, 13012.479500819862, 10506.737331566772, 10605.522751476048, 10836.458177091272, 10846.783064338511, 10915.126789856951, 9872.062154095349, 10015.899841001788, 10464.63373781914, 10798.460076996276, 11312.94343528277, 11280.09759219277, 11403.087752979907, 11601.477933493183, 11605.941970290094, 11809.0, 8002.7199048033035, 8053.22828977624, 8205.261526462647, 8376.204260595234, 8516.403851730567, 7879.543073875845, 8264.21489958453, 9825.312228144247, 10753.601607043796, 11011.724706882393], "value": 9650.147018553735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.1809187072074, 1427.3576890399315, 1443.7978682984383, 1457.9125252484853, 1459.0589070049812, 8071.394645401597, 8447.746567602966, 8451.492910425364, 8459.0, 8461.87307190392, 7443.404527637789, 7698.0, 7703.229677032308, 7997.0, 8207.958960205191, 2268.7731226877263, 2318.3045086474076, 2325.5697695926224, 2326.5230627721276, 2329.184785325131, 2327.650852372141, 2356.752540983198, 2363.267387109993, 2367.5146594948083, 2369.715634123899, 2291.461506545969, 2303.8041766449787, 2319.3969567912295, 2320.2923108451914, 2327.441414060622, 2299.908003679851, 2325.360525855386, 2327.4995875886766, 2329.988350058256, 2331.9506222199907, 2263.4228271790753, 2309.90760369585, 2350.15394457995, 2356.304890057437, 2361.1853910400882, 8322.334213262924, 8373.0, 8383.0, 8387.119352467964, 8395.874061889077, 5021.397432308147, 5182.0931337016245, 5185.766640501187, 5185.896282074375, 5190.6107041972, 2896.9275768105754, 3281.3273278977754, 3458.291050334675, 3489.581250249986, 3493.510908472816, 1172.1150531348862, 1213.4418167642896, 1216.3249396584893, 1257.7547378261243, 1269.3589737182663, 10536.947315263375, 10704.78590428195, 10720.303180293256, 10742.033217010507, 10760.300580462244, 4360.890977725582, 4572.856785803549, 4643.535646435329, 4660.1145782301255, 4666.2067448533835, 9351.924528679154, 9361.157495825408, 9366.110219529133, 9367.90632093684, 9394.389364691273, 5174.663646862942, 5179.145441002268, 5184.7407629618365, 5185.714785686748, 5200.6619569727845, 4636.744979026186, 4646.8141274348645, 4683.086798074342, 4710.835120770825, 4730.692504987165, 3160.2099475131217, 3455.4644030175364, 3541.486484459739, 3771.962280377216, 3892.1826416452295, 1244.6017274472083, 1246.1028059796931, 1249.831407633847, 1258.1947553565726, 1261.1172179474404, 762.881753328235, 781.0861292288037, 890.5947793753827, 892.9508877011697, 937.4000639590668, 5386.757595908193, 5634.154876768517, 5681.57388195887, 5842.824715258549, 5987.427398706851, 946.6982898514542, 946.7443790176613, 983.7835676151378, 988.0, 996.2577879479834, 3302.966970330314, 3769.792661403594, 3798.905027374338, 3877.2051729395407, 3891.1633998690418, 9690.56392462341, 9930.950345248371, 10000.899991000142, 10025.24810639205, 10027.147692446079, 9351.953240233755, 9702.417854928726, 9727.756806079904, 9924.553395097239, 9952.402855828674, 7584.62076896153, 7745.535267883945, 7774.067111946716, 7801.570913599693, 7808.141104478503, 5476.205950137288, 5519.8896022080135, 5531.9723401382735, 5597.524210442158, 5869.970650146893, 8942.016378198523, 8942.329325300498, 8984.820303594022, 9228.123328283802, 9230.215431688383, 8881.777955550904, 9057.05273366203, 9238.491882946502, 9263.53682315895, 9360.344775865624, 6571.901421478778, 6828.248892621708, 6833.4191593715095, 6955.1653801544135, 7057.188423331178, 7907.090684571348, 7919.16848730898, 7926.881096783668, 7992.040955085427, 8009.359251260002, 7072.929270707227, 7133.82165445868, 7168.605726685082, 7177.0, 7216.170140433917, 6265.966115590876, 6548.869022619616, 6941.47938904574, 7015.754448594274, 7070.6111163884425, 5797.188393624981, 6079.1793107931635, 6312.842178945563, 6470.838229044123, 6477.838054048498, 4854.053459575349, 4932.580730637936, 4965.379327584052, 5061.645684802029, 5094.032133894548, 4974.875628109182, 4987.226979818134, 5116.0, 5152.716600587004, 5229.607779416483], "value": 4398.479485074381, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.19420817639866, 355.80252959607407, 361.6166863125087, 371.2815701617371, 372.45435437084666, 4293.914121717564, 4933.383327084114, 5160.690358578488, 5243.31836861208, 5323.0, 5034.169362055257, 5034.572061374778, 5106.489351064892, 5174.180071860836, 5188.325517682696, 3383.002014405744, 4088.2641124597562, 4107.630313271805, 4118.423420721087, 4118.5057793064725, 3521.7710848794873, 3591.4433262844173, 4086.366613174948, 4122.958770412302, 4163.646090082331, 3949.269385163754, 3982.9644292484018, 3985.9402108968243, 3993.700472464562, 3994.840206391741, 3923.8430462781453, 3929.2337994091163, 3954.228925359556, 3957.9511429471213, 3976.1848820991627, 3457.9798959307063, 3467.4625433057918, 3470.670286322795, 3475.565554305712, 3477.6174620791694, 4224.493060832689, 4779.737114458703, 4819.469858315582, 5011.924821127686, 5082.669626474268, 3905.7070719696135, 4481.686281960264, 4506.819727210907, 4510.488986189631, 4526.75102869342, 4739.355431676976, 5372.91940620891, 5445.863853403657, 5502.724863756836, 5541.5843811714285, 3408.1255309579633, 3513.4905438711244, 3761.7398171612545, 3790.9764363621944, 3836.7506112102624, 4954.851354459372, 5436.10304299794, 5626.831195064155, 5731.856703582402, 5805.303363596396, 3373.983130084383, 3730.403135498307, 3827.73205875586, 3833.1758671885677, 3877.905930797338, 3906.648401643866, 3913.0608653923423, 3926.2736393767245, 3943.6253555912144, 3950.111224974415, 4245.8513952011535, 4480.32795080734, 4497.908472560275, 4523.841665541756, 4546.727196368162, 4695.7886895089805, 5496.340439147328, 5559.8888022239325, 5569.832905012856, 5569.888602227933, 1092.4373947417087, 1105.9557617695364, 1183.6685727996176, 1203.8082298524398, 1224.8713885041943, 746.8468963862396, 846.9872951905726, 859.6432480520639, 868.700298397052, 871.675053918041, 4782.1025863920795, 4801.639877009238, 4818.590704647676, 4874.8537543873745, 4937.925931111036, 5268.578513718893, 5402.35171779389, 5406.864828379244, 5441.5102640762525, 5468.781248750085, 4094.0727379923496, 4353.9129217415475, 4486.820527178941, 4860.8298709545, 5154.659788455028, 2336.4158960259933, 2465.6685389889617, 2706.8240564363255, 2817.535106707411, 2817.999610138412, 5236.397814251333, 5492.5605951523785, 5531.419200983919, 5560.388357280696, 5560.749766260528, 4896.5103489651465, 4996.575291100225, 5382.381026181961, 5428.327397869157, 5574.766635351486, 4668.828994517566, 4841.757912104381, 5256.632035757537, 5507.642003269774, 5548.140038294152, 4550.431196100488, 4701.42691554428, 4950.8762280943265, 5079.492050795039, 5490.890182196254, 4869.805207791649, 5076.543111120017, 5253.789848406021, 5296.894062118813, 5311.946880531145, 4741.5495527924795, 4844.352920007214, 5392.919106213331, 5489.780408783604, 5524.33707955048, 2929.2717296794995, 3136.85884135219, 3423.537822393945, 3457.325821464891, 3601.1537288736604, 4825.841797968392, 4867.415910090812, 5269.362960594653, 5332.493413125747, 5486.807961721321, 4664.510226426177, 5130.743462826769, 5178.61160412963, 5198.402183748917, 5290.25936368901, 4853.733044682576, 5126.4617215191865, 5181.699189672638, 5182.378114626269, 5224.7126408047925, 4480.372747815243, 4866.732329721899, 4913.140200464976, 5204.479552044765, 5225.425203227566, 4967.137323503686, 5414.431484694208, 5451.127819548853, 5460.170842767718, 5474.0, 4856.834359753563, 5144.434112247575, 5323.840284791462, 5381.67709937405, 5407.0], "value": 3921.2120249960167, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.7034589953371, 694.3542505469912, 711.1643818513246, 727.3054233207288, 824.6289169873554, 14720.6319842004, 15224.771628425582, 15480.612984675388, 15627.609309767247, 15768.369265229405, 13861.4455421783, 14228.786568201485, 14249.287535623229, 14450.638734031629, 14457.277136143177, 835.5237514616656, 861.0012385632667, 866.6706651472432, 866.757307953774, 867.1805144138791, 677.6916502991127, 698.3296035805607, 836.6569706420369, 855.4995327733284, 858.5535521528801, 908.6774195160722, 924.0943875002501, 924.9260059195249, 925.3799954030816, 927.2674587076202, 914.7164379042518, 916.8670542771328, 917.1653795046509, 917.4586993673698, 919.9264058875274, 520.8437468759357, 537.5699440447665, 685.3215316836346, 686.0669489494284, 686.7115811359241, 12449.25304481734, 14616.342264598119, 15175.772363414557, 15562.533124006299, 15589.454369097028, 12747.42636581356, 12855.16441431304, 12913.612591622266, 12984.740305193938, 13109.016823738259, 9603.951980240054, 11792.705182370424, 11889.28664280146, 12026.819597706042, 12401.503939842396, 3734.850605975758, 3741.2330472253125, 3743.794091324976, 3746.925061498782, 3808.1812410331636, 80904.0, 104979.0, 106172.46913765381, 106445.0, 107000.4649976753, 9718.70843874685, 10855.782884342269, 11147.888521114848, 11457.484413201426, 11491.023263022737, 22269.554608907732, 23828.16601418942, 24108.0, 24160.87919560391, 24186.758132418803, 7756.3019328260725, 7803.609819509115, 7848.960755196187, 7851.685932562747, 7985.800354991055, 3561.30554541867, 4107.075907920694, 4184.4141820145205, 4194.967832599948, 4287.164003019444, 3623.0761155905075, 3663.7618554793853, 3695.0, 3731.645493678096, 3745.8127093645207, 640.6828619833212, 654.4946622767616, 658.3613894522306, 672.7779832655212, 674.3829396102511, 554.9472800083986, 655.2661019658013, 662.6090606542164, 705.4391758551964, 719.9352058314777, 9980.750481238027, 10075.546600402853, 10229.539670714836, 10386.636467723745, 10440.321379110334, 654.5712558274338, 687.6037011016604, 687.8314812870778, 690.9343612356818, 702.7470110760122, 4680.5085466025575, 4960.255961605788, 4974.552290293891, 4980.651354405157, 4980.950190498121, 105776.0, 107332.46333768437, 108009.45995269973, 108937.37438379395, 113642.0, 67337.32662673408, 84121.0, 86243.13756862351, 87996.12003880007, 89149.0, 82038.76941845877, 83252.0, 83284.58357708294, 83903.16096839198, 85879.0, 8822.5588720565, 9484.95257523708, 9640.843098827905, 9644.276679248944, 9687.757806054624, 47481.76259118682, 47716.0, 47845.521544784104, 49176.50823491719, 50156.489045766444, 66051.00923486055, 66538.33461665321, 69341.30658693348, 69994.65002674954, 71331.65012624177, 12744.299063551594, 12775.1057425983, 12965.092443528862, 13107.606771796862, 13372.438706325025, 14288.928555357157, 14307.64230894236, 14375.938653113277, 14478.348474318891, 14958.775618365951, 13463.528776492776, 13551.051426400058, 13738.313084345542, 14064.507742228972, 14078.577642670736, 13322.200667959953, 13483.393247303698, 13511.662208444868, 13547.458101675822, 13612.93193534026, 10879.129669626253, 11961.461734221806, 12571.74856502883, 13132.671683207996, 13688.794668079787, 11068.778624427627, 11191.72020699489, 11228.88771112311, 11367.090632749525, 11702.2978621283, 10329.044044640339, 10747.623833165802, 10802.243842930919, 10832.5125369357, 10839.945800271264], "value": 7468.411844327172, "unit": "score"}], "name": "dromaeo_css", "value": 7204.4494103070065, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 112.0, 137.0, 94.0, 161.0, 169.0, 171.0, 112.0], "value": 129.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 114.0, 145.0, 108.0, 109.0, 110.0, 111.0, 130.0, 108.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 182.0, 186.0, 183.0, 182.0, 180.0, 182.0, 181.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 87.0, 62.0, 60.0, 59.0, 58.0, 73.0, 57.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 85.0, 69.0, 68.0, 68.0, 81.0, 67.0, 67.0, 82.0], "value": 74.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 83.0, 85.0, 81.0, 85.0, 83.0, 86.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 93.0, 93.0, 92.0, 92.0, 93.0, 93.0, 92.0], "value": 92.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 86.0, 87.0, 86.0, 103.0, 139.0, 131.0, 86.0], "value": 97.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 70.0, 78.0, 73.0, 71.0, 69.0, 70.0, 70.0, 70.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 88.0, 88.0, 86.0, 87.0, 85.0, 96.0, 92.0, 94.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 137.0, 137.0, 161.0, 153.0, 153.0, 136.0, 192.0, 175.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 173.0, 174.0, 172.0, 175.0, 175.0, 183.0, 176.0, 172.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 70.0, 77.0, 86.0, 87.0, 89.0, 69.0, 67.0, 67.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1464.1000000000001, "alertThreshold": 2.0}]} 19:48:01 INFO - Return code: 0 19:48:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:48:01 ERROR - # TBPL SUCCESS # 19:48:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:48:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:48:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:48:01 INFO - 2017-01-17 19:48:01.994 screenresolution[1649:9511] starting screenresolution argv=screenresolution get 19:48:01 INFO - 2017-01-17 19:48:01.998 screenresolution[1649:9511] Display 0: 1600x1200x32@60 19:48:02 INFO - 2017-01-17 19:48:02.004 screenresolution[1650:9514] starting screenresolution argv=screenresolution list 19:48:02 INFO - Available Modes on Display 0 19:48:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:48:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:48:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:48:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:48:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:48:02 INFO - Intel Iris: 19:48:02 INFO - Chipset Model: Intel Iris 19:48:02 INFO - Type: GPU 19:48:02 INFO - Bus: Built-In 19:48:02 INFO - VRAM (Dynamic, Max): 1536 MB 19:48:02 INFO - Vendor: Intel (0x8086) 19:48:02 INFO - Device ID: 0x0a2e 19:48:02 INFO - Revision ID: 0x0009 19:48:02 INFO - Displays: 19:48:02 INFO - Display: 19:48:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:48:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:48:02 INFO - Display Serial Number: 1600x1200 60 19:48:02 INFO - Main Display: Yes 19:48:02 INFO - Mirror: Off 19:48:02 INFO - Online: Yes 19:48:02 INFO - Rotation: Supported 19:48:02 INFO - Return code: 0 19:48:02 INFO - Running post-action listener: _resource_record_post_action 19:48:02 INFO - [mozharness: 2017-01-18 03:48:02.237951Z] Finished run-tests step (success) 19:48:02 INFO - Running post-run listener: _resource_record_post_run 19:48:02 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 33426432; Write bytes: 554172928; Read time: 313; Write time: 1774 19:48:02 INFO - TinderboxPrint: CPU usage
53.6% 19:48:02 INFO - TinderboxPrint: I/O read bytes / time
33,426,432 / 313 19:48:02 INFO - TinderboxPrint: I/O write bytes / time
554,172,928 / 1,774 19:48:02 INFO - TinderboxPrint: CPU idle
2,231.7 (46.4%) 19:48:02 INFO - TinderboxPrint: CPU system
962.2 (20.0%) 19:48:02 INFO - TinderboxPrint: CPU user
1,619.8 (33.6%) 19:48:02 INFO - TinderboxPrint: Swap in / out
280,604,672 / 0 19:48:02 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247872000; Write bytes: 241825792; Read time: 17914; Write time: 465 19:48:02 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31308800; Write bytes: 296606208; Read time: 288; Write time: 1273 19:48:02 INFO - Running post-run listener: _upload_blobber_files 19:48:02 INFO - Blob upload gear active. 19:48:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:48:02 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 19:48:02 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:48:02 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:48:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:48:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:03 INFO - (blobuploader) - INFO - Done attempting. 19:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:48:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:04 INFO - (blobuploader) - INFO - Done attempting. 19:48:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:48:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:05 INFO - (blobuploader) - INFO - Done attempting. 19:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:48:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:08 INFO - (blobuploader) - INFO - Done attempting. 19:48:08 INFO - (blobuploader) - INFO - Iteration through files over. 19:48:08 INFO - Return code: 0 19:48:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:48:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:48:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c172943eae3a81881bd92d8634f95992378fe6a0991880a9f3f4341efe64cffbb629617bdce0490688d25dcf9a8756c58b7f9d81c69f4e7b8790d73126dcfeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cfbc178b4b9ec792cb3e9ba3c613c3ac2a693c339684e018e3675444b6f71f53ba3f4eadd0fe8949f4f065f01124406fa077edbcad55279aed1cef3d5cb54ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b22ccdd7add20268cea2cbf55d51da65201181f63c0f8c381b8bac1a56724c596ff4872de650fed6824186b245a95c374cb10c3777c165d330095adc265f5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55db259378839a686c1086ea30d6a477e38be045d7d61af5bfceeacb2f7162b4bc00d7459403dcbc4067a4d93182b5ce6d70bc86fee508764c9895943efaa54e"} 19:48:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:48:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:48:08 INFO - Contents: 19:48:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c172943eae3a81881bd92d8634f95992378fe6a0991880a9f3f4341efe64cffbb629617bdce0490688d25dcf9a8756c58b7f9d81c69f4e7b8790d73126dcfeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cfbc178b4b9ec792cb3e9ba3c613c3ac2a693c339684e018e3675444b6f71f53ba3f4eadd0fe8949f4f065f01124406fa077edbcad55279aed1cef3d5cb54ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b22ccdd7add20268cea2cbf55d51da65201181f63c0f8c381b8bac1a56724c596ff4872de650fed6824186b245a95c374cb10c3777c165d330095adc265f5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55db259378839a686c1086ea30d6a477e38be045d7d61af5bfceeacb2f7162b4bc00d7459403dcbc4067a4d93182b5ce6d70bc86fee508764c9895943efaa54e"} 19:48:08 INFO - Running post-run listener: copy_logs_to_upload_dir 19:48:08 INFO - Copying logs to upload dir... 19:48:08 INFO - mkdir: /builds/slave/test/build/upload/logs 19:48:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.074186 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-17 19:48:08.898996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 19:48:08.903209) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c172943eae3a81881bd92d8634f95992378fe6a0991880a9f3f4341efe64cffbb629617bdce0490688d25dcf9a8756c58b7f9d81c69f4e7b8790d73126dcfeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cfbc178b4b9ec792cb3e9ba3c613c3ac2a693c339684e018e3675444b6f71f53ba3f4eadd0fe8949f4f065f01124406fa077edbcad55279aed1cef3d5cb54ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b22ccdd7add20268cea2cbf55d51da65201181f63c0f8c381b8bac1a56724c596ff4872de650fed6824186b245a95c374cb10c3777c165d330095adc265f5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55db259378839a686c1086ea30d6a477e38be045d7d61af5bfceeacb2f7162b4bc00d7459403dcbc4067a4d93182b5ce6d70bc86fee508764c9895943efaa54e"} build_url:https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011047 build_url: 'https://queue.taskcluster.net/v1/task/NMkj9gIbSyeIlHIbfXHWzA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c172943eae3a81881bd92d8634f95992378fe6a0991880a9f3f4341efe64cffbb629617bdce0490688d25dcf9a8756c58b7f9d81c69f4e7b8790d73126dcfeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cfbc178b4b9ec792cb3e9ba3c613c3ac2a693c339684e018e3675444b6f71f53ba3f4eadd0fe8949f4f065f01124406fa077edbcad55279aed1cef3d5cb54ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b22ccdd7add20268cea2cbf55d51da65201181f63c0f8c381b8bac1a56724c596ff4872de650fed6824186b245a95c374cb10c3777c165d330095adc265f5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55db259378839a686c1086ea30d6a477e38be045d7d61af5bfceeacb2f7162b4bc00d7459403dcbc4067a4d93182b5ce6d70bc86fee508764c9895943efaa54e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 19:48:08.939770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 19:48:08.940183) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2Ci9pB30ZS/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.d1tWkpHC1l/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005077 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 19:48:08.990064) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 19:48:08.990438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 19:48:08.990826) ========= ========= Total master_lag: 0.19 =========