builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0072 starttime: 1491320767.38 results: success (0) buildid: 20170404075027 builduid: 3c564eada91d48c19dcb87045ec95680 revision: 99f58b8a313ed97f16109ef5838e3b8a3ca21316 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:07.383712) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:07.384184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:07.384476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:07.410325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:07.410728) ========= 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.lDN2dirN6D/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.oUq973cySh/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-04-04 08:46:07-- 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% 5.59M=0.002s 2017-04-04 08:46:07 (5.59 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:07.538137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:07.538465) ========= 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.lDN2dirN6D/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.oUq973cySh/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.026140 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:07.589688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 08:46:07.590089) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 99f58b8a313ed97f16109ef5838e3b8a3ca21316 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 99f58b8a313ed97f16109ef5838e3b8a3ca21316 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lDN2dirN6D/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.oUq973cySh/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-04-04 08:46:07,678 truncating revision to first 12 chars 2017-04-04 08:46:07,678 Setting DEBUG logging. 2017-04-04 08:46:07,678 attempt 1/10 2017-04-04 08:46:07,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/99f58b8a313e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 08:46:08,951 unpacking tar archive at: mozilla-beta-99f58b8a313e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.537007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 08:46:09.151106) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:09.151457) ========= script_repo_revision: 99f58b8a313ed97f16109ef5838e3b8a3ca21316 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:09.151909) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:09.152197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 08:46:09.170218) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-04-04 08:46:09.170648) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lDN2dirN6D/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.oUq973cySh/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46:09 INFO - MultiFileLogger online at 20170404 08:46:09 in /builds/slave/test 08:46:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:46:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:09 INFO - {'append_to_log': False, 08:46:09 INFO - 'base_work_dir': '/builds/slave/test', 08:46:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:46:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:09 INFO - 'branch': 'Mozilla-Beta', 08:46:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:09 INFO - 'config_files': ('talos/mac_config.py',), 08:46:09 INFO - 'default_actions': ('clobber', 08:46:09 INFO - 'read-buildbot-config', 08:46:09 INFO - 'download-and-extract', 08:46:09 INFO - 'populate-webroot', 08:46:09 INFO - 'create-virtualenv', 08:46:09 INFO - 'install', 08:46:09 INFO - 'run-tests'), 08:46:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:09 INFO - 'download_minidump_stackwalk': True, 08:46:09 INFO - 'download_symbols': 'ondemand', 08:46:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:09 INFO - 'installer_path': 'installer.exe', 08:46:09 INFO - 'log_level': 'info', 08:46:09 INFO - 'log_name': 'talos', 08:46:09 INFO - 'log_to_console': True, 08:46:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:46:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:46:09 INFO - 'opt_config_files': (), 08:46:09 INFO - 'pip_index': False, 08:46:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:46:09 INFO - 'cmd': ('bash', 08:46:09 INFO - '-c', 08:46:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:46:09 INFO - 'enabled': True, 08:46:09 INFO - 'halt_on_failure': False, 08:46:09 INFO - 'name': 'check_screen_resolution'},), 08:46:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:46:09 INFO - 'cmd': ('bash', 08:46:09 INFO - '-c', 08:46:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:46:09 INFO - 'enabled': True, 08:46:09 INFO - 'halt_on_failure': False, 08:46:09 INFO - 'name': 'check_screen_resolution'},), 08:46:09 INFO - 'run_cmd_checks_enabled': True, 08:46:09 INFO - 'sps_profile': False, 08:46:09 INFO - 'sps_profile_interval': 0, 08:46:09 INFO - 'suite': 'dromaeojs', 08:46:09 INFO - 'system_bits': '32', 08:46:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:09 INFO - 'title': 't-yosemite-r7-0072', 08:46:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:09 INFO - 'use_talos_json': True, 08:46:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:09 INFO - 'work_dir': 'build'} 08:46:09 INFO - [mozharness: 2017-04-04 15:46:09.388886Z] Running clobber step. 08:46:09 INFO - Running pre-action listener: _resource_record_pre_action 08:46:09 INFO - Running main action method: clobber 08:46:09 INFO - rmtree: /builds/slave/test/build 08:46:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:12 INFO - Running post-action listener: _resource_record_post_action 08:46:12 INFO - [mozharness: 2017-04-04 15:46:12.781111Z] Finished clobber step (success) 08:46:12 INFO - [mozharness: 2017-04-04 15:46:12.781280Z] Running read-buildbot-config step. 08:46:12 INFO - Running pre-action listener: _resource_record_pre_action 08:46:12 INFO - Running main action method: read_buildbot_config 08:46:12 INFO - Using buildbot properties: 08:46:12 INFO - { 08:46:12 INFO - "project": "", 08:46:12 INFO - "product": "firefox", 08:46:12 INFO - "script_repo_revision": "production", 08:46:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:46:12 INFO - "repository": "", 08:46:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:46:12 INFO - "buildid": "20170404075027", 08:46:12 INFO - "pgo_build": "False", 08:46:12 INFO - "basedir": "/builds/slave/test", 08:46:12 INFO - "buildnumber": 13, 08:46:12 INFO - "slavename": "t-yosemite-r7-0072", 08:46:12 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:46:12 INFO - "platform": "yosemite_r7", 08:46:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:46:12 INFO - "branch": "mozilla-beta", 08:46:12 INFO - "repo_path": "releases/mozilla-beta", 08:46:12 INFO - "revision": "99f58b8a313ed97f16109ef5838e3b8a3ca21316", 08:46:12 INFO - "stage_platform": "macosx64", 08:46:12 INFO - "builduid": "3c564eada91d48c19dcb87045ec95680", 08:46:12 INFO - "slavebuilddir": "test" 08:46:12 INFO - } 08:46:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 08:46:12 INFO - Running post-action listener: _resource_record_post_action 08:46:12 INFO - [mozharness: 2017-04-04 15:46:12.784690Z] Finished read-buildbot-config step (success) 08:46:12 INFO - [mozharness: 2017-04-04 15:46:12.784784Z] Running download-and-extract step. 08:46:12 INFO - Running pre-action listener: _resource_record_pre_action 08:46:12 INFO - Running main action method: download_and_extract 08:46:12 INFO - mkdir: /builds/slave/test/build/tests 08:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:12 INFO - trying https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 08:46:12 INFO - Downloading https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 08:46:14 INFO - Downloaded 1165 bytes. 08:46:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:46:14 INFO - Using the following test package requirements: 08:46:14 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:46:14 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:46:14 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 08:46:14 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:46:14 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 08:46:14 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:46:14 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:46:14 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 08:46:14 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:46:14 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:46:14 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 08:46:14 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:46:14 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 08:46:14 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:46:14 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 08:46:14 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:46:14 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 08:46:14 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 08:46:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:46:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:46:14 INFO - Fetch https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:46:15 INFO - Expected file size: 16116753 08:46:15 INFO - Obtained file size: 16116753 08:46:22 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:46:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:46:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:46:22 INFO - Fetch https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:46:23 INFO - Expected file size: 16116753 08:46:23 INFO - Obtained file size: 16116753 08:46:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 08:46:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 08:46:29 INFO - Fetch https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 08:46:30 INFO - Expected file size: 14403663 08:46:30 INFO - Obtained file size: 14403663 08:46: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')]} 08:46:30 INFO - trying https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:46:30 INFO - Downloading https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 08:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 08:46:32 INFO - Downloaded 58738587 bytes. 08:46:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:46:32 INFO - mkdir: /builds/slave/test/properties 08:46:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:32 INFO - Contents: 08:46:32 INFO - build_url:https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:46:33 INFO - Running post-action listener: _resource_record_post_action 08:46:33 INFO - Running post-action listener: set_extra_try_arguments 08:46:33 INFO - [mozharness: 2017-04-04 15:46:33.385762Z] Finished download-and-extract step (success) 08:46:33 INFO - [mozharness: 2017-04-04 15:46:33.385934Z] Running populate-webroot step. 08:46:33 INFO - Running pre-action listener: _resource_record_pre_action 08:46:33 INFO - Running main action method: populate_webroot 08:46:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:33 INFO - '--tppagecycles', 08:46:33 INFO - '7'], 08:46:33 INFO - 'tests': ['tsvgm']}}, 08:46:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:46:33 INFO - 'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:46:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:46:33 INFO - 'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['damp', 'tps']}, 08:46:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:46:33 INFO - 'tests': ['damp', 'tps']}, 08:46:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['dromaeo_dom']}, 08:46:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['basic_compositor_video']}, 08:46:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:46:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['a11yr', 08:46:33 INFO - 'ts_paint', 08:46:33 INFO - 'tpaint', 08:46:33 INFO - 'sessionrestore', 08:46:33 INFO - 'sessionrestore_no_auto_restore', 08:46:33 INFO - 'tabpaint']}, 08:46:33 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:33 INFO - 'ts_paint', 08:46:33 INFO - 'tpaint', 08:46:33 INFO - 'sessionrestore', 08:46:33 INFO - 'sessionrestore_no_auto_restore', 08:46:33 INFO - 'tabpaint']}, 08:46:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:33 INFO - 'ts_paint', 08:46:33 INFO - 'tpaint', 08:46:33 INFO - 'sessionrestore', 08:46:33 INFO - 'sessionrestore_no_auto_restore', 08:46:33 INFO - 'tabpaint']}, 08:46:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:33 INFO - 'ts_paint', 08:46:33 INFO - 'tpaint', 08:46:33 INFO - 'sessionrestore', 08:46:33 INFO - 'sessionrestore_no_auto_restore', 08:46:33 INFO - 'tabpaint']}, 08:46:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['a11yr', 08:46:33 INFO - 'ts_paint', 08:46:33 INFO - 'tpaint', 08:46:33 INFO - 'sessionrestore', 08:46:33 INFO - 'sessionrestore_no_auto_restore', 08:46:33 INFO - 'tabpaint']}, 08:46:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['a11yr', 08:46:33 INFO - 'ts_paint', 08:46:33 INFO - 'tpaint', 08:46:33 INFO - 'sessionrestore', 08:46:33 INFO - 'sessionrestore_no_auto_restore', 08:46:33 INFO - 'tabpaint']}, 08:46:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['tsvgx', 08:46:33 INFO - 'tsvgr_opacity', 08:46:33 INFO - 'tart', 08:46:33 INFO - 'tscrollx', 08:46:33 INFO - 'cart', 08:46:33 INFO - 'tsvg_static']}, 08:46:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:33 INFO - 'tsvgr_opacity', 08:46:33 INFO - 'tart', 08:46:33 INFO - 'tscrollx', 08:46:33 INFO - 'cart', 08:46:33 INFO - 'tsvg_static']}, 08:46:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:46:33 INFO - 'talos_options': ['--disable-e10s'], 08:46:33 INFO - 'tests': ['tp5o']}, 08:46:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:46:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:46:33 INFO - 'talos_options': ['--disable-e10s', 08:46:33 INFO - '--xperf_path', 08:46:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:33 INFO - 'tests': ['tp5n']}, 08:46:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:46:33 INFO - 'talos_options': ['--xperf_path', 08:46:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:33 INFO - 'tests': ['tp5n']}}, 08:46:33 INFO - 'talos.zip': {'path': '', 08:46:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:33 INFO - Running post-action listener: _resource_record_post_action 08:46:33 INFO - [mozharness: 2017-04-04 15:46:33.406216Z] Finished populate-webroot step (success) 08:46:33 INFO - [mozharness: 2017-04-04 15:46:33.406333Z] Running create-virtualenv step. 08:46:33 INFO - Running pre-action listener: _resource_record_pre_action 08:46:33 INFO - Running main action method: create_virtualenv 08:46:33 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:46:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:33 INFO - Using real prefix '/tools/python27' 08:46:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:34 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:37 INFO - Installing pip.................done. 08:46:37 INFO - Return code: 0 08:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:46:37 INFO - Reading from file tmpfile_stdout 08:46:37 INFO - Output received: 08:46:37 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) 08:46:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:37 INFO - 'HOME': '/Users/cltbld', 08:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:37 INFO - 'LOGNAME': 'cltbld', 08:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:37 INFO - 'MOZ_NO_REMOTE': '1', 08:46:37 INFO - 'NO_EM_RESTART': '1', 08:46:37 INFO - 'PAGER': '/bin/cat', 08:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:37 INFO - 'PWD': '/builds/slave/test', 08:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:37 INFO - 'SHELL': '/bin/bash', 08:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:46:37 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:37 INFO - 'USER': 'cltbld', 08:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:37 INFO - 'XPC_FLAGS': '0x0', 08:46:37 INFO - 'XPC_SERVICE_NAME': '0', 08:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:46:37 INFO - Cleaning up... 08:46:37 INFO - Return code: 0 08:46:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:37 INFO - 'HOME': '/Users/cltbld', 08:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:37 INFO - 'LOGNAME': 'cltbld', 08:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:37 INFO - 'MOZ_NO_REMOTE': '1', 08:46:37 INFO - 'NO_EM_RESTART': '1', 08:46:37 INFO - 'PAGER': '/bin/cat', 08:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:37 INFO - 'PWD': '/builds/slave/test', 08:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:37 INFO - 'SHELL': '/bin/bash', 08:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:46:37 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:37 INFO - 'USER': 'cltbld', 08:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:37 INFO - 'XPC_FLAGS': '0x0', 08:46:37 INFO - 'XPC_SERVICE_NAME': '0', 08:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:37 INFO - Downloading/unpacking psutil>=3.1.1 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:41 INFO - Installing collected packages: psutil 08:46:41 INFO - Running setup.py install for psutil 08:46:41 INFO - building 'psutil._psutil_osx' extension 08:46:41 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 08:46:42 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 08:46:42 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 08:46:42 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 08:46:42 INFO - building 'psutil._psutil_posix' extension 08:46:42 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 08:46:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:46:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:46:42 INFO - ^ 08:46:42 INFO - 1 warning generated. 08:46:42 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 08:46:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:42 INFO - Successfully installed psutil 08:46:42 INFO - Cleaning up... 08:46:42 INFO - Return code: 0 08:46:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:46: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 mozsystemmonitor==0.3 08:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:42 INFO - 'HOME': '/Users/cltbld', 08:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:42 INFO - 'LOGNAME': 'cltbld', 08:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:42 INFO - 'MOZ_NO_REMOTE': '1', 08:46:42 INFO - 'NO_EM_RESTART': '1', 08:46:42 INFO - 'PAGER': '/bin/cat', 08:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:42 INFO - 'PWD': '/builds/slave/test', 08:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:42 INFO - 'SHELL': '/bin/bash', 08:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:46:42 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:42 INFO - 'USER': 'cltbld', 08:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:42 INFO - 'XPC_FLAGS': '0x0', 08:46:42 INFO - 'XPC_SERVICE_NAME': '0', 08:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:46:45 INFO - Installing collected packages: mozsystemmonitor 08:46:45 INFO - Running setup.py install for mozsystemmonitor 08:46:45 INFO - Successfully installed mozsystemmonitor 08:46:45 INFO - Cleaning up... 08:46:45 INFO - Return code: 0 08:46:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:45 INFO - 'HOME': '/Users/cltbld', 08:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:45 INFO - 'LOGNAME': 'cltbld', 08:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:45 INFO - 'MOZ_NO_REMOTE': '1', 08:46:45 INFO - 'NO_EM_RESTART': '1', 08:46:45 INFO - 'PAGER': '/bin/cat', 08:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:45 INFO - 'PWD': '/builds/slave/test', 08:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:45 INFO - 'SHELL': '/bin/bash', 08:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:46:45 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:45 INFO - 'USER': 'cltbld', 08:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:45 INFO - 'XPC_FLAGS': '0x0', 08:46:45 INFO - 'XPC_SERVICE_NAME': '0', 08:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:46:48 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 08:46:48 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 08:46:48 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 08:46:48 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 08:46:48 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 08:46:48 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 08:46:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:49 INFO - warning: no files found matching '*.txt' 08:46:49 INFO - no previously-included directories found matching 'build' 08:46:49 INFO - no previously-included directories found matching 'dist' 08:46:49 INFO - no previously-included directories found matching '.git*' 08:46:49 INFO - Installing collected packages: jsonschema, functools32 08:46:49 INFO - Running setup.py install for functools32 08:46:49 INFO - warning: no files found matching '*.txt' 08:46:49 INFO - no previously-included directories found matching 'build' 08:46:49 INFO - no previously-included directories found matching 'dist' 08:46:49 INFO - no previously-included directories found matching '.git*' 08:46:49 INFO - Successfully installed jsonschema functools32 08:46:49 INFO - Cleaning up... 08:46:49 INFO - Return code: 0 08:46:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:46:49 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')]} 08:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:49 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')]} 08:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:49 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 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46:49 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 08:46:49 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 08:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:49 INFO - 'HOME': '/Users/cltbld', 08:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:49 INFO - 'LOGNAME': 'cltbld', 08:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:49 INFO - 'MOZ_NO_REMOTE': '1', 08:46:49 INFO - 'NO_EM_RESTART': '1', 08:46:49 INFO - 'PAGER': '/bin/cat', 08:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:49 INFO - 'PWD': '/builds/slave/test', 08:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:49 INFO - 'SHELL': '/bin/bash', 08:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:46:49 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:49 INFO - 'USER': 'cltbld', 08:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:49 INFO - 'XPC_FLAGS': '0x0', 08:46:49 INFO - 'XPC_SERVICE_NAME': '0', 08:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:46:49 INFO - Cleaning up... 08:46:49 INFO - Return code: 0 08:46:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46:49 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')]} 08:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:49 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')]} 08:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:49 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 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46:49 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 08:46:49 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 08:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:49 INFO - 'HOME': '/Users/cltbld', 08:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:49 INFO - 'LOGNAME': 'cltbld', 08:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:49 INFO - 'MOZ_NO_REMOTE': '1', 08:46:49 INFO - 'NO_EM_RESTART': '1', 08:46:49 INFO - 'PAGER': '/bin/cat', 08:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:49 INFO - 'PWD': '/builds/slave/test', 08:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:49 INFO - 'SHELL': '/bin/bash', 08:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:46:49 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:49 INFO - 'USER': 'cltbld', 08:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:49 INFO - 'XPC_FLAGS': '0x0', 08:46:49 INFO - 'XPC_SERVICE_NAME': '0', 08:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:46:49 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 08:46:49 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 08:46:49 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 08:46:49 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 08:46:49 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 08:46:49 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 08:46:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:53 INFO - Downloading docopt-0.6.1.tar.gz 08:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:53 INFO - Running setup.py install for blobuploader 08:46:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:53 INFO - Running setup.py install for requests 08:46:54 INFO - Running setup.py install for docopt 08:46:54 INFO - Successfully installed blobuploader requests docopt 08:46:54 INFO - Cleaning up... 08:46:54 INFO - Return code: 0 08:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:54 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 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46:54 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 08:46:54 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 08:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:54 INFO - 'HOME': '/Users/cltbld', 08:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:54 INFO - 'LOGNAME': 'cltbld', 08:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:54 INFO - 'MOZ_NO_REMOTE': '1', 08:46:54 INFO - 'NO_EM_RESTART': '1', 08:46:54 INFO - 'PAGER': '/bin/cat', 08:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:54 INFO - 'PWD': '/builds/slave/test', 08:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:54 INFO - 'SHELL': '/bin/bash', 08:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:46:54 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:54 INFO - 'USER': 'cltbld', 08:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:54 INFO - 'XPC_FLAGS': '0x0', 08:46:54 INFO - 'XPC_SERVICE_NAME': '0', 08:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:54 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-UzvC3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-YCY0mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-BS0yiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-XY6IPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-DWlnKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-3nRLIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-bd5COo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-uX4hQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-BrbxJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:55 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ArmHuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:56 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-xluAzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:56 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-T8BW9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:56 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-FzHhjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:56 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Mon9Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:56 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Za93Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:56 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-yFpcZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:56 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-39cE1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:56 INFO - Running setup.py install for manifestparser 08:46:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:56 INFO - Running setup.py install for mozcrash 08:46:57 INFO - Running setup.py install for mozdebug 08:46:57 INFO - Running setup.py install for mozdevice 08:46:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Running setup.py install for mozfile 08:46:57 INFO - Running setup.py install for mozhttpd 08:46:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Running setup.py install for mozinfo 08:46:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Running setup.py install for mozInstall 08:46:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Running setup.py install for mozleak 08:46:58 INFO - Running setup.py install for mozlog 08:46:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for moznetwork 08:46:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozprocess 08:46:58 INFO - Running setup.py install for mozprofile 08:46:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozrunner 08:46:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozscreenshot 08:46:59 INFO - Running setup.py install for moztest 08:46:59 INFO - Running setup.py install for mozversion 08:46:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:59 INFO - Cleaning up... 08:46:59 INFO - Return code: 0 08:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:59 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')]} 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:59 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')]} 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:59 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 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:46:59 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 08:46:59 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 08:46:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:46:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:59 INFO - 'HOME': '/Users/cltbld', 08:46:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:59 INFO - 'LOGNAME': 'cltbld', 08:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:59 INFO - 'MOZ_NO_REMOTE': '1', 08:46:59 INFO - 'NO_EM_RESTART': '1', 08:46:59 INFO - 'PAGER': '/bin/cat', 08:46:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:59 INFO - 'PWD': '/builds/slave/test', 08:46:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:59 INFO - 'SHELL': '/bin/bash', 08:46:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:46:59 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:46:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:59 INFO - 'USER': 'cltbld', 08:46:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:59 INFO - 'XPC_FLAGS': '0x0', 08:46:59 INFO - 'XPC_SERVICE_NAME': '0', 08:46:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:59 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-JsmGNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:59 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TOFu94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:59 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-9ExO5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-g9AQdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-CMD7lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-e9Vmai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-jJHX5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-xt5FLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-SW8bNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Wt3SuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-cj6Tii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:00 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-xSICj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:01 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)) 08:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:01 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-1aWICl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:01 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)) 08:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:01 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-qWv6ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:01 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)) 08:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:01 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ZudYBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:01 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)) 08:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:01 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-egMUVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:01 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)) 08:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:01 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-D_jEkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:01 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)) 08:47:01 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)) 08:47:01 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)) 08:47:01 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)) 08:47:01 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)) 08:47:01 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)) 08:47:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:01 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 08:47:01 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 08:47:01 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 08:47:01 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 08:47:01 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 08:47:01 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 08:47:04 INFO - Downloading blessings-1.6.tar.gz 08:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:04 INFO - Installing collected packages: blessings 08:47:04 INFO - Running setup.py install for blessings 08:47:04 INFO - Successfully installed blessings 08:47:04 INFO - Cleaning up... 08:47:04 INFO - Return code: 0 08:47:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:04 INFO - Reading from file tmpfile_stdout 08:47:04 INFO - Current package versions: 08:47:04 INFO - blessings == 1.6 08:47:04 INFO - blobuploader == 1.2.4 08:47:04 INFO - docopt == 0.6.1 08:47:04 INFO - functools32 == 3.2.3-2 08:47:04 INFO - jsonschema == 2.5.1 08:47:04 INFO - manifestparser == 1.1 08:47:04 INFO - mozInstall == 1.12 08:47:04 INFO - mozcrash == 1.0 08:47:04 INFO - mozdebug == 0.1 08:47:04 INFO - mozdevice == 0.49 08:47:04 INFO - mozfile == 1.2 08:47:04 INFO - mozhttpd == 0.7 08:47:04 INFO - mozinfo == 0.9 08:47:04 INFO - mozleak == 0.1 08:47:04 INFO - mozlog == 3.4 08:47:04 INFO - moznetwork == 0.27 08:47:04 INFO - mozprocess == 0.24 08:47:04 INFO - mozprofile == 0.28 08:47:04 INFO - mozrunner == 6.13 08:47:04 INFO - mozscreenshot == 0.1 08:47:04 INFO - mozsystemmonitor == 0.3 08:47:04 INFO - moztest == 0.8 08:47:04 INFO - mozversion == 1.4 08:47:04 INFO - psutil == 3.1.1 08:47:04 INFO - requests == 1.2.3 08:47:04 INFO - wsgiref == 0.1.2 08:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:04 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')]} 08:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:05 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')]} 08:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:05 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 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:47:05 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 08:47:05 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 08:47:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:47:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:05 INFO - 'HOME': '/Users/cltbld', 08:47:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:05 INFO - 'LOGNAME': 'cltbld', 08:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:05 INFO - 'MOZ_NO_REMOTE': '1', 08:47:05 INFO - 'NO_EM_RESTART': '1', 08:47:05 INFO - 'PAGER': '/bin/cat', 08:47:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:05 INFO - 'PWD': '/builds/slave/test', 08:47:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:05 INFO - 'SHELL': '/bin/bash', 08:47:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:47:05 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:47:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:05 INFO - 'USER': 'cltbld', 08:47:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:05 INFO - 'XPC_FLAGS': '0x0', 08:47:05 INFO - 'XPC_SERVICE_NAME': '0', 08:47:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 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)) 08:47:05 INFO - Cleaning up... 08:47:05 INFO - Return code: 0 08:47:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:05 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')]} 08:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:05 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')]} 08:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:06 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 0x1100adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e005d7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, '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.lDN2dirN6D/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.oUq973cySh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 08:47:06 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 08:47:06 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 08:47:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:47:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:06 INFO - 'HOME': '/Users/cltbld', 08:47:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:06 INFO - 'LOGNAME': 'cltbld', 08:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:06 INFO - 'MOZ_NO_REMOTE': '1', 08:47:06 INFO - 'NO_EM_RESTART': '1', 08:47:06 INFO - 'PAGER': '/bin/cat', 08:47:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:06 INFO - 'PWD': '/builds/slave/test', 08:47:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:06 INFO - 'SHELL': '/bin/bash', 08:47:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:47:06 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:47:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:06 INFO - 'USER': 'cltbld', 08:47:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:06 INFO - 'XPC_FLAGS': '0x0', 08:47:06 INFO - 'XPC_SERVICE_NAME': '0', 08:47:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:47:06 INFO - Cleaning up... 08:47:06 INFO - Return code: 0 08:47:06 INFO - Running post-action listener: _resource_record_post_action 08:47:06 INFO - Running post-action listener: _start_resource_monitoring 08:47:06 INFO - Starting resource monitoring. 08:47:06 INFO - [mozharness: 2017-04-04 15:47:06.648753Z] Finished create-virtualenv step (success) 08:47:06 INFO - [mozharness: 2017-04-04 15:47:06.649712Z] Running install step. 08:47:06 INFO - Running pre-action listener: _resource_record_pre_action 08:47:06 INFO - Running main action method: install 08:47:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:06 INFO - Reading from file tmpfile_stdout 08:47:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:07 INFO - Reading from file tmpfile_stdout 08:47:07 INFO - Output received: 08:47:07 INFO - Usage: mozinstall [options] installer 08:47:07 INFO - Options: 08:47:07 INFO - -h, --help show this help message and exit 08:47:07 INFO - -d DEST, --destination=DEST 08:47:07 INFO - Directory to install application into. [default: 08:47:07 INFO - "/builds/slave/test"] 08:47:07 INFO - --app=APP Application being installed. [default: firefox] 08:47:07 INFO - mkdir: /builds/slave/test/build/application 08:47:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:47:22 INFO - Reading from file tmpfile_stdout 08:47:22 INFO - Output received: 08:47:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:47:22 INFO - Running post-action listener: _resource_record_post_action 08:47:22 INFO - [mozharness: 2017-04-04 15:47:22.131443Z] Finished install step (success) 08:47:22 INFO - [mozharness: 2017-04-04 15:47:22.131646Z] Running run-tests step. 08:47:22 INFO - Running pre-action listener: _resource_record_pre_action 08:47:22 INFO - Running main action method: run_tests 08:47:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:47:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:47:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:47:22 INFO - 2017-04-04 08:47:22.146 screenresolution[2160:72163] starting screenresolution argv=screenresolution get 08:47:22 INFO - 2017-04-04 08:47:22.149 screenresolution[2160:72163] Display 0: 1600x1200x32@60 08:47:22 INFO - 2017-04-04 08:47:22.154 screenresolution[2161:72165] starting screenresolution argv=screenresolution list 08:47:22 INFO - Available Modes on Display 0 08:47:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:47:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:47:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:47:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:47:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:47:22 INFO - Intel Iris: 08:47:22 INFO - Chipset Model: Intel Iris 08:47:22 INFO - Type: GPU 08:47:22 INFO - Bus: Built-In 08:47:22 INFO - VRAM (Dynamic, Max): 1536 MB 08:47:22 INFO - Vendor: Intel (0x8086) 08:47:22 INFO - Device ID: 0x0a2e 08:47:22 INFO - Revision ID: 0x0009 08:47:22 INFO - Displays: 08:47:22 INFO - Display: 08:47:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:47:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:47:22 INFO - Display Serial Number: 1600x1200 60 08:47:22 INFO - Main Display: Yes 08:47:22 INFO - Mirror: Off 08:47:22 INFO - Online: Yes 08:47:22 INFO - Rotation: Supported 08:47:22 INFO - Return code: 0 08:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:22 INFO - Python 2.7.3 08:47:22 INFO - Return code: 0 08:47:22 INFO - grabbing minidump binary from tooltool 08:47:22 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')]} 08:47:22 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 0x10fe8bd30>, '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 0x10fdb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe80be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:22 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 08:47:22 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 08:47:22 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 08:47:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:22 INFO - Return code: 0 08:47:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:47:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:47:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 08:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --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 08:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDN2dirN6D/Render', 08:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:22 INFO - 'HOME': '/Users/cltbld', 08:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:22 INFO - 'LOGNAME': 'cltbld', 08:47:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:22 INFO - 'MOZ_NO_REMOTE': '1', 08:47:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:22 INFO - 'NO_EM_RESTART': '1', 08:47:22 INFO - 'PAGER': '/bin/cat', 08:47:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:22 INFO - 'PWD': '/builds/slave/test', 08:47:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:22 INFO - 'SHELL': '/bin/bash', 08:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oUq973cySh/Listeners', 08:47:22 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 08:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:22 INFO - 'USER': 'cltbld', 08:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:22 INFO - 'XPC_FLAGS': '0x0', 08:47:22 INFO - 'XPC_SERVICE_NAME': '0', 08:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 08:47:22 INFO - mozversion application_buildid: 20170404075027 08:47:22 INFO - mozversion application_changeset: 99f58b8a313ed97f16109ef5838e3b8a3ca21316 08:47:22 INFO - mozversion application_display_name: Firefox 08:47:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:22 INFO - mozversion application_name: Firefox 08:47:22 INFO - mozversion application_remotingname: firefox 08:47:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:47:22 INFO - mozversion application_vendor: Mozilla 08:47:22 INFO - mozversion application_version: 53.0 08:47:22 INFO - mozversion platform_buildid: 20170404075027 08:47:22 INFO - mozversion platform_changeset: 99f58b8a313ed97f16109ef5838e3b8a3ca21316 08:47:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:47:22 INFO - mozversion platform_version: 53.0 08:47:22 INFO - using testdate: 1491320842 08:47:22 INFO - actual date: 1491320842 08:47:22 INFO - starting webserver on 'localhost:56366' 08:47:22 INFO - SUITE-START | Running 2 tests 08:47:22 INFO - TEST-START | dromaeo_css 08:47:22 INFO - operating with platform_type : mac_ 08:47:22 INFO - Initialising browser for dromaeo_css test... 08:47:23 INFO - TEST-INFO | started process 2171 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpUIhPkF/profile http://localhost:56366/getInfo.html) 08:47:25 INFO - PROCESS | 2171 | __metrics Screen width/height:1600/1200 08:47:25 INFO - PROCESS | 2171 | colorDepth:24 08:47:25 INFO - PROCESS | 2171 | Browser inner width/height: 1024/689 08:47:25 INFO - PROCESS | 2171 | __metrics 08:47:25 INFO - PROCESS | 2171 | 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" 08:47:25 INFO - PROCESS | 2171 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:26 INFO - TEST-INFO | 2171: exit 0 08:47:26 INFO - Browser initialized. 08:47:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:26 INFO - TEST-INFO | started process 2174 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpUIhPkF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:37 INFO - PROCESS | 2174 | RSS: Main: 164151296 08:47:37 INFO - PROCESS | 2174 | 08:50:41 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:56366/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56366/tests/dromaeo/cssquery-ext.html) 08:50:43 INFO - PROCESS | 2174 | RSS: Main: 261484544 08:50:43 INFO - PROCESS | 2174 | 08:53:47 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:56366/tests/dromaeo/cssquery-ext.html (next: http://localhost:56366/tests/dromaeo/cssquery-jquery.html) 08:53:47 INFO - PROCESS | 2174 | RSS: Main: 308744192 08:53:47 INFO - PROCESS | 2174 | 08:56:50 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:56366/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56366/tests/dromaeo/cssquery-mootools.html) 08:56:50 INFO - PROCESS | 2174 | RSS: Main: 271224832 08:56:50 INFO - PROCESS | 2174 | 08:59:52 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:56366/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56366/tests/dromaeo/cssquery-prototype.html) 08:59:53 INFO - PROCESS | 2174 | RSS: Main: 272928768 08:59:53 INFO - PROCESS | 2174 | 09:02:56 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:56366/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56366/tests/dromaeo/cssquery-yui.html) 09:02:57 INFO - PROCESS | 2174 | RSS: Main: 273260544 09:02:57 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:56366/tests/dromaeo/cssquery-yui.html (next: http://localhost:56366/tests/dromaeo/cssquery-dojo.html) 09:06:00 INFO - PROCESS | 2174 | RSS: Main: 402452480 09:06:00 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | __start_tp_report 09:06:00 INFO - PROCESS | 2174 | _x_x_mozilla_page_load 09:06:00 INFO - PROCESS | 2174 | _x_x_mozilla_page_load_details 09:06:00 INFO - PROCESS | 2174 | |i|pagename|runs| 09:06:00 INFO - PROCESS | 2174 | |0;dojo.html;3456.2396272819974;3468.2543253200574;3492.5808902931653;3498.3528047311243;3540.752147349685;5979.760809567618;6036.426539478743;6036.939630603692;6072.939270607292;6119.479844213247;5866.266716660418;6016.849578760533;6088.421599948009;6122.35715249899;6123.601965872226;5266.4733526647415;5403;5439.238506609078;5447.509724124828;5540.307461567304;5372.086745253317;5390.029794636964;5393.946060539403;5459.235707001023;5578.665280083188;5393.81121660742;5475.698836563987;5484.149956756709;5485.588580856432;5491.368492623339;5464.754086066137;5469.835904922858;5509.834704958857;5513.173024046385;5541.473560011793;5304.946950530484;5428.782848686048;5441.537469315113;5460.945390546083;5482.122860342326;6130.509559235251;6186.969065154691;6196.907046394308;6198.6280823150755;6203.348648391944;6220.1602783624085;6266.4360207581085;6296.874062518724;6312.242530896276;6332.4934005279465;6365.777197798101;6367.299597044322;6391.744330226786;6408.070829729663;6462.644554549498;6186.381361863868;6190.566660333779;6219.315875253718;6231.3145553989025;6234.937650623527;6324.9051264231075;6384.553081284358;6538.248101468297;6573.80278591643;6575.638339891256;6247.875042499216;6250.1874756281395;6269.247690277105;6300.842478938063;6320.55756097078;6410.038494225811;6410.67946602668;6417.679116044179;6430.807075787734;6435.646039467781;6199.56603037783;6236.906446403307;6333.778317758856;6339.11252424661;6346.9682651586445;6262.2172228471445;6269.0909818076125;6274.968625156845;6285.371462853678;6297.370262973757;5184;5197.480251974772;5205.609579281569;5212.55693266069;5226.5818734501145;4434.26834572292;4655.627549796008;4671.602913752301;4687.320338550891;4689.577937985529;5892.204552385373;6012.338642749294;6032.3967603239325;6048.485878700271;6126.136919559505;6313.747450102036;6359.713812878432;6392.776252831221;6412.294647588855;6423.74305027803;6112.694365281807;6122.265328160649;6126.816195514141;6128.203333566607;6133.325334213233;5486.615936884459;5617.747201375866;5673.971630141823;5674.148877668383;5717.085266357363;6456.9354306456335;6468.6442245676;6469.805905822833;6490.837729056811;6518.185226846645;6381.266154392304;6386.361363863576;6402.6158430494315;6409.7436102555375;6413.1021656969;6498.285188629342;6504.739810407531;6541.313162117909;6570.8028759137305;6595.505337099641;5260.789568417221;6259.96870015647;6262.780802671885;6280.905786413116;6311.684415779285;6355.459785918249;6386.96806515983;6388.93611063902;6410.871782564416;6415.06981487691;6210;6228.190335256388;6266.968665156645;6279.026750853625;6288.6855657217875;6229.190205273286;6237.407446292595;6304.621722696653;6306.527010474325;6314.210723659543;6282.151909492343;6301.338359472189;6335.239771227482;6336.303006669171;6339.175907132043;6210.285817130907;6281.497480201664;6286.842828929313;6300.936990630035;6300.9684951574945;6165.260168779775;6196.938030619636;6272.278687950761;6274.435300822948;6326.905096423466 09:06:00 INFO - PROCESS | 2174 | |1;ext.html;514.9880484847274;517.1699422427005;528.091682306433;535.330836454432;556.1102236421726;41318.586814131886;43319;43476.347854782165;43489.78255108728;43592;45406.54593454064;46069.76965115178;46140.538594614045;46143.76928115363;46153.53846461535;9244;9494.287928405363;9648.758781030478;9883.604655813795;9899.653512127077;11986.70033249167;12384.442700078473;12413.44139513724;12529.749405011895;12544.749105017894;12142.575009874656;12158.270503769758;12231.694207644836;12245.142840001203;12280.324582147978;12284.692882677915;12324.014078873668;12333;12342.753144937096;12348.259104453671;12248.81626775599;12354;12355.691107722289;12369.814452783216;12381.133320667557;43303.56696433027;43602.909927251756;43618.78190609027;43657;43745;4043.211573743092;4081.673466122703;4084.775337356444;4116.485439320085;4124.587541245852;28064.719352806416;31248.8437557813;32304.19239519007;33127.83436082804;33596;3376.1559610097474;3392.270661807723;3408.3694516514524;3534.045807631925;3558.484019817138;505557;511006;511838.4408077973;512008;514962.4251878792;66433;66949.99575006281;66977.99533006911;66992;67009.32990670031;66850.66574667193;69230.65384673145;69287.61424771477;69399.65300173467;69625.60748784996;17321.7401738974;17331.306747730203;17946.282148713904;18028.819711802713;18034.008129552738;10226.23303252259;12589.811152832715;12903.290319032543;13413.329333533284;13685.452581896812;17652.940823550372;17720.55698607545;17892.194851231467;17914.28342866297;18010.279588816302;7250.4199664026755;7304.853902921912;7354.632268386559;7374.483786134919;7383.261673832574;823.5305875650821;870.7126648206076;878.872563478292;888.4314039015036;913.1507697841072;29904.55143172854;30986;30993.830431869552;31630.36739265248;31778.56996435166;970.3886551472668;1078.9730256743644;1096.030013438097;1105.9889401106047;1212.8362671039474;13545.86454135446;15765.527034188992;15890.76163857543;16550.42073527421;16659.500214993568;637188;637519;640554;643046;643295;66228;66301;66303.66848165728;66367;66423;1324.4966912573161;1389.6942672611808;1393.2894223945862;1459.3651761483789;1493.3653197391066;30894.691053090082;32195.195120122185;33164.33671326608;33314;33491;53417.46582534125;53421.7328913353;53426.46573534215;54498.45501544934;54555.454445455034;518755.40622296644;520630;520880;522325;522692;34855.47716784199;37302.81348593348;37984.24031519299;42550.78724606357;44239.11521769611;43876.56123438725;43932.68201953947;44247.77876110599;44550.66348009565;45403;33015.00954971355;33585.49621755627;33788.662113379534;34087.65912340845;35303.823480882435;32838.67161328452;33766.49350259699;33931.15172120618;35321;35667.64332356643;40306.99232519211;40749.38875916805;40764.757938313676;40939;41269.38095928504;33837.830810845786;34078.82960585181;34206.48690269598;34799.47800783041;35386.29227415489;24657.506849862544;25883.741162588885;26477.205683829518;26583.202503924913;26937.73062269352 09:06:00 INFO - PROCESS | 2174 | |2;jquery.html;343.0981863421652;390.8358489434439;392.21361170852447;399.8480577380594;428.12694461729933;20733.85963771992;22236.666450003264;22363.217287394964;22370.55258894823;23132.768672313272;21444.678329825027;21854.344369668936;23194;23275.068997240134;23433;5973.731182096805;6318.557700960934;6329.556931014831;6329.905051424233;6350.523710721691;5992.370801065891;6128.601640893327;6164.260288765355;6247.312795592481;6256.843578910518;6088.269407671086;6090.512758979271;6170.444659980601;6214.8446288842915;6237.906431403532;5935.85160370992;6108.14485971962;6185.948388773919;6190.84522886927;6205.1623030890705;5406.351237851483;5475.616706830523;5485.75314110862;5486.478784515464;5493.478119578634;26692.866535667392;27021;27092.864535677196;27361.726382736317;27401.588976165374;2633.644457998165;2655.269800804794;2671.9599206011926;2689.287338855205;2696.191142657195;10408.01123893229;10414.687559373231;10437.634682786065;10705.25063245573;10810.67567972962;1836.40316897009;1915.6264528416964;1931.4012656076661;2000.4098790856588;2004.6491863923754;111137.44431277872;113394.43302783516;114236;114944.27583586253;115541;10884.238103332691;10903.890961090447;10943.83584246237;11084.722881928017;11212.215144939775;13526.93236533811;13577.932110339385;13599.524016659567;13601.04792664504;13612.591622251348;8485.703000394957;8632.48205107683;8704.912950870537;8780.824383512294;8805.339599529932;7333.376662983599;8731.602943529006;8864.290856731446;9019;9082.909170908206;3927.823247953792;4248.87253382399;4256.884016558375;4321.070969741458;4321.783910804447;2038.2254743197786;2085.322270262171;2093.71734815801;2096.6540520813896;2099.6220680277697;688.008083406057;992.8780478059746;1022.156720705421;1031.4017869635743;1086.6305456144948;19890.801091989186;21520.784792151877;23086.769132308797;23136.42158946006;23147;1012.3622118065572;1015.7206768138673;1031.7936412717486;1050.795094956476;1054.1303424674675;10387.68836934893;11191.608293709844;11864.347460889734;11949.940250298867;11983.64049078529;423956;675244;758289;758407;790300;128197;133484;158792.20603897137;163265;166429.6714065712;988.7528117970508;1013.6350913671073;1035.9274850760526;1037.0459177556666;1037.4242295525905;17739.29042838272;19347.839129652268;20652;21246.893765531073;21274.36176914695;55555.722221388634;59523.70238148955;59722;61487.692561536904;62090.68954655198;92543;92782.53608731914;96104;96235.81995530459;96411;7438.6652600632015;7664.616769161631;7769;8443.451175673561;8720.694775682821;8517.616707248064;11190.552377904793;11601.419929003685;13080.672983175496;13504.797428038784;5789.421057894346;6567.9671601641685;11217.102631789601;11398.917102875213;11762.764744704888;7979.880301795361;9603.471809050568;9802.215822734022;10381.688549343531;10629.202809789142;11610.825837612612;11727.35499547533;12038.75922481563;12069.818952715892;12098.971587415168;7702.537847729154;7739.651715672921;7911.604419779103;7923;7942.761717148494;6295.905561416674;11350.94324528372;11588.884111159117;11791.941040294743;11910.940445297718 09:06:00 INFO - PROCESS | 2174 | |3;mootools.html;1421.7298713244484;1433.9928300358497;1438.2233593859314;1441.682829777449;1446.3636000159922;8198.467099638527;8589.871151932726;8600.569971501416;8603.870941935867;8611.698590549331;7609.5434273943465;7880.408969327309;7886.132525422199;8208.712695055674;8418.789530261747;2383.380321116509;2417.2385698505004;2420.3102115896972;2421.5641184586766;2425.3815277104313;2066.318115022039;2393.5930891748358;2422.1643532981093;2430.2344761400104;2440.987795061031;2132.573485302938;2209.6962791952747;2327.697399338092;2389.832711710181;2410.4817464245184;2414.1912459326145;2415.649730789043;2417.721961974369;2420.782129608326;2429.441228517433;2386.355683965337;2400.9039638414442;2413.686220791286;2413.734489206186;2423.345696661909;7139.60732159731;8489.363297752694;8541.743747687578;8565.486070835708;8648.437851539693;5144.279800827887;5306.389765176977;5309;5311.548518375943;5320.228566857784;3171.5559821624993;3274.6889045540634;3364.771858271713;3382.222088919538;3668.394714872043;1200.6218041316956;1246.819211214378;1252.768237875996;1298.6104168749432;1308.9280089595068;10919.945400273027;11050.281731687415;11093.83359249612;11103.55585776568;11173.553057877756;3941.9802900985887;4549.340345649863;4829.444613869379;4850.835799408117;4852.272159176152;9610.135087841987;9619;9619.230461563058;9633.277504187214;9654.324197306121;5296.973515132399;5382.219578161144;5383.246345511631;5396.460353964572;5398.595105367034;4346.1525002624185;4411.955880441219;4850.878728031827;4866.489018653061;4949.727764972961;3855.9228815423535;3914.9217015660097;3966.345552983783;3998.28030954431;4007.438958545806;1087.1683162380784;1274.31187158935;1275.0628288208345;1284.7880099783617;1289.4906511927736;872.3152325424638;909.2634965677822;939.4551160326994;949.6818565780541;1002.7593377589326;4957.958828646025;5163.40620828602;5552.639078459887;5624.184493248538;5902.6458412495385;572.5991805736002;960.351762560269;968.1770495079127;974.3715303629119;994.9900500994897;3798.848046078181;3899.064224586079;3912.197999410114;3921.3725803871816;4039.111395492987;10011.149052330487;10115.645952391631;10210.387376757419;10288.845667314996;10293.7426564335;10116.140128089195;10220.488975551192;10234.948825255975;10239.436830974368;10260;7464.178940316561;7864.685412583547;7901.407394445325;7929.246721561442;7989.400794940403;5821.09772985188;5832.591718579659;5840.766369345349;5885.5880088395115;6018.909716354171;9253.352265341362;9491.098345657152;9518.762030949281;9522.666706665234;9526.761830954281;9225.72322830316;9415.152636262495;9542.42745435276;9638;9645.71062868115;7223.2776722329445;7271.054762880792;7401.629918504161;7427;7433.516821406592;7863.606819658879;7958.920410795818;7964.561949092856;7964.681412743425;7975.72084977023;6762.120924279812;6915.51591388598;6950.582965022115;6955.23492415844;7067.646617668993;6492.545521813617;6591.802245932629;6676.298988606321;6708.42978346846;6932;6389.361063893573;6417.550771445954;6455.935440645533;6501.8699626008165;6504.642244676588;5037.647364684583;5056.811649262494;5060.924086138637;5085.3134826797905;5116.232565115113;4969.652124351261;5045.772940217626;5074.3657042869645;5167.379914410144;5242.2922905408805 09:06:00 INFO - PROCESS | 2174 | |4;prototype.html;363.28070420567275;369.9482072509849;373.9887803365899;384.43680008787123;386.9632384923431;4977.7262250576205;5122.6926384416965;5363.785448582057;5373.220882971967;5481.75332110055;5126.769295381708;5130.563902068328;5307.601929855257;5334.91997620035;5348.197770334452;3622.1669016126307;4097.692673049533;4186.539480657125;4227.526896765388;4239.5548467410945;3566.4472006838982;4085.81613827377;4188.455500784894;4206.095689426773;4221.32458806591;3627.981860090696;3811.8475260989526;4112.485939257593;4155.0083939563465;4236.703430759848;3853.344931361675;3861.6524512793985;4133.462649855514;4151.522574903879;4194.454720886296;2962.1486570893194;3139.5290706393994;3435.811030393327;3712.684421824148;3720.534933133358;4799.2801079837955;5036.816348158217;5204.271402003723;5211.557017653504;5242.292290540767;4071.959280407217;4829.275608658694;4829.27560865873;4845.685030473008;4847.345608342864;5114.28400023997;5565.332160140769;5582.748776305036;5601.859953501154;5627.887442251173;3497.090756403328;3866.5360156781085;4072.226277007359;4113.341865301538;4116.6912481564;4905.626424601118;5907.822765317004;5916.881662366729;5918.8816223675285;5930.911036334415;4036.324925156086;4178.811953462102;4190.5180904195795;4193.391958166048;4243.554426785205;3985.029055451579;4165.230121968857;4235.576442355739;4240.830366785294;4241.724287921275;4411.963188650665;4480.529544397857;4505.61702255312;4752.263399173134;4827.444843842933;4994.725290109079;5674.290713660793;5687.744051517691;5693.886122277531;5738.794853080816;1216.9026477881748;1271;1341.6784467299701;1362.4958765256918;1369.3427154965473;867.5185272173878;881.391460584436;920.4109370003204;927.4945154890601;956.5121787888088;4044.919101617951;4205.64715519436;4903.656744027884;4912.901741965141;4942.57988071018;4810.494898035726;4990.6257030722845;5085.863937146408;5146.639735218574;5183.481651834862;4087.7751723654887;4145.875623731293;4263.978680106579;4850.296706977469;4870.512948705101;2481.888315025828;2521.3192438041992;2809.9297517562222;2827.7313655202724;2852.557853532706;4995.975020124876;5385.703786291713;5589.413111623302;5600.383957764642;5664.660120392789;4754.191787396151;5547.557635014925;5571.359293681197;5606.579506536945;5691.573132015115;4747.905041899143;4888.7311197884455;4942.5304596063315;5564.721763911869;5630.774769009194;5411;5423.020597481969;5445.918311225256;5447.727613619382;5496.945030549643;4426.026274219666;5331.573474122139;5385.3268341457315;5399.9460005401015;5471.753771080391;4683.906321873612;5109.959574053432;5219.8434046978655;5390.894866552426;5665.546756259407;3339.612177293247;3562.59030211529;3721.2557488501866;4017;4075.9592404076766;4288.442502474658;4617.376654151781;4908.803647854046;5292.862034662566;5569.526590239713;4875.464228767927;5167;5265.7367131642495;5273.367195936512;5307.99148161848;4573.085382923495;4587.243104887656;5020.673656212334;5137.92293115611;5265.657732247391;4135.669146468215;4788.61691064721;5127.794888204579;5131.25596788471;5199.870003249797;4949.82675606352;5041.6722913010535;5239.921401179062;5241.135212689864;5258.447862974485;4336.653067754509;4360.454943132108;4555.703879247838;5167.560757335668;5186.6369354144845 09:06:00 INFO - PROCESS | 2174 | |5;yui.html;733.6551820644295;746.08231874794;786.2452046035805;859.3125499600318;870.4820631724126;13010;15266.007709498876;15642.765358519631;15801.367945282174;15817.209139543034;14408.35162417691;14692.485762998298;14696.265186740673;14709.04391214573;14716.484923027696;715.5134508534221;744.7505085796265;745.3850573277041;883.5891310540582;901.8151278987824;863.5250612163317;890.559173209259;898.4743924803997;906.8549032154857;907.6188001039546;930.2372054914972;949.4161090929064;953.0183910572122;955.9187469065103;957.4351132831628;952.1525842000625;953.4041224234853;954.0364232125534;954.5799848066863;954.9665761698308;708.8263375472991;709.1915216653019;709.4111887133719;709.5387997801419;709.7409445552388;13834.861651383459;15348.846511534854;15691.058536487848;15796.842031579767;15984.440544580884;14354.49759258421;14638.780418293734;14796.852031479655;14854.70290594182;15072.773908391273;11456.656300311004;11818;11927.761444771057;11948.223365481215;12003.579874704343;3218.742500599946;3605.603383627799;3736.663700266989;3864.942025869614;4006.098627808749;96722.5163874176;107602.99999999921;109705.45147274292;110223;110427.44786276098;9011.819763604823;11305.830412543819;11511.19421640477;11527.308361498337;11651.76696466066;23559.293221203392;23560.64659030116;23595.410114746926;23612.763872361058;23618.93714782839;7520.285572870568;7618.428617853572;8190.344772418192;8299.29455996235;8317.293030092389;4500.257457519473;4559.544045595414;4579.152856721517;4597.7011494252765;4659.4175728034;3618.4029635110437;3642.9817850910576;3646.9817650911577;3720.2373513430225;3724.8266795959184;675.3584095109666;675.4866301610812;682.846359569093;684.6782012454139;692.5117791956759;656.2878532139285;668.5019660353069;670.7162113005224;677.3226773226774;693.7467824244216;9637.42175469474;9785.107446276861;10292.433916134534;10393.53229104692;10459.84310235347;668.0913957018452;689.3692271571456;695.7843068648735;700.3696672994346;702.8594281143792;4504.414426124583;4913.213885778258;4916.3362946001835;4921.089598424303;4946.826861059845;84822.57588712017;94769;101972;102151.97848021574;103990.48004759928;87320;87448;87615.68576471358;90143.54928225317;92744;79112.6044369786;80175;80931;82222.17777822145;82733;9602.471864047266;9622.759431014281;9629.518524073628;9653.1794797443;9659.613615455302;50075;52844.20733688921;53118;53508.46491535035;54275;69762.60474790577;69915;70729.64635176997;70739;72679;9207.585658645243;10983.725406864893;11490.08079353633;11515.30908145514;11828.82256766132;12241.510339586674;12622.747545049231;12657.620271391874;13033.087683862417;13065.934670326968;9671.564779585076;11737.450205132422;11858.881411185777;11937.940310298392;11976.640700778991;12952.805707914576;13792;13937.09408888419;13992.589346189205;14183.368912574773;12729.427175776927;13920.443182272596;14346.139231646135;14418;14422.567322980327;9387.718368448957;9820.361676491006;9864.062914023156;9886.851697224403;9908.653197138066;10298.433586152834;10824.404657743584;11235.55057797679;11553.24903881245;11685.357305348287 09:06:00 INFO - PROCESS | 2174 | __end_tp_report 09:06:00 INFO - PROCESS | 2174 | __start_cc_report 09:06:00 INFO - PROCESS | 2174 | _x_x_mozilla_cycle_collect,2262 09:06:00 INFO - PROCESS | 2174 | __end_cc_report 09:06:00 INFO - PROCESS | 2174 | __startTimestamp1491321960924__endTimestamp 09:06:00 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | ------- Summary: start ------- 09:06:00 INFO - PROCESS | 2174 | Number of tests: 6 09:06:00 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | [#0] dojo.html Cycles:165 Average:5967.18 Median:6231.31 stddev:630.36 (10.1%) stddev-sans-first:600.73 09:06:00 INFO - PROCESS | 2174 | Values: 3456.2 3468.3 3492.6 3498.4 3540.8 5979.8 6036.4 6036.9 6072.9 6119.5 5866.3 6016.8 6088.4 6122.4 6123.6 5266.5 5403.0 5439.2 5447.5 5540.3 5372.1 5390.0 5393.9 5459.2 5578.7 5393.8 5475.7 5484.1 5485.6 5491.4 5464.8 5469.8 5509.8 5513.2 5541.5 5304.9 5428.8 5441.5 5460.9 5482.1 6130.5 6187.0 6196.9 6198.6 6203.3 6220.2 6266.4 6296.9 6312.2 6332.5 6365.8 6367.3 6391.7 6408.1 6462.6 6186.4 6190.6 6219.3 6231.3 6234.9 6324.9 6384.6 6538.2 6573.8 6575.6 6247.9 6250.2 6269.2 6300.8 6320.6 6410.0 6410.7 6417.7 6430.8 6435.6 6199.6 6236.9 6333.8 6339.1 6347.0 6262.2 6269.1 6275.0 6285.4 6297.4 5184.0 5197.5 5205.6 5212.6 5226.6 4434.3 4655.6 4671.6 4687.3 4689.6 5892.2 6012.3 6032.4 6048.5 6126.1 6313.7 6359.7 6392.8 6412.3 6423.7 6112.7 6122.3 6126.8 6128.2 6133.3 5486.6 5617.7 5674.0 5674.1 5717.1 6456.9 6468.6 6469.8 6490.8 6518.2 6381.3 6386.4 6402.6 6409.7 6413.1 6498.3 6504.7 6541.3 6570.8 6595.5 5260.8 6260.0 6262.8 6280.9 6311.7 6355.5 6387.0 6388.9 6410.9 6415.1 6210.0 6228.2 6267.0 6279.0 6288.7 6229.2 6237.4 6304.6 6306.5 6314.2 6282.2 6301.3 6335.2 6336.3 6339.2 6210.3 6281.5 6286.8 6300.9 6301.0 6165.3 6196.9 6272.3 6274.4 6326.9 09:06:00 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | [#1] ext.html Cycles:180 Average:70868.13 Median:37643.53 stddev:149353.52 (396.8%) stddev-sans-first:149679.09 09:06:00 INFO - PROCESS | 2174 | Values: 515.0 517.2 528.1 535.3 556.1 41318.6 43319.0 43476.3 43489.8 43592.0 45406.5 46069.8 46140.5 46143.8 46153.5 9244.0 9494.3 9648.8 9883.6 9899.7 11986.7 12384.4 12413.4 12529.7 12544.7 12142.6 12158.3 12231.7 12245.1 12280.3 12284.7 12324.0 12333.0 12342.8 12348.3 12248.8 12354.0 12355.7 12369.8 12381.1 43303.6 43602.9 43618.8 43657.0 43745.0 4043.2 4081.7 4084.8 4116.5 4124.6 28064.7 31248.8 32304.2 33127.8 33596.0 3376.2 3392.3 3408.4 3534.0 3558.5 505557.0 511006.0 511838.4 512008.0 514962.4 66433.0 66950.0 66978.0 66992.0 67009.3 66850.7 69230.7 69287.6 69399.7 69625.6 17321.7 17331.3 17946.3 18028.8 18034.0 10226.2 12589.8 12903.3 13413.3 13685.5 17652.9 17720.6 17892.2 17914.3 18010.3 7250.4 7304.9 7354.6 7374.5 7383.3 823.5 870.7 878.9 888.4 913.2 29904.6 30986.0 30993.8 31630.4 31778.6 970.4 1079.0 1096.0 1106.0 1212.8 13545.9 15765.5 15890.8 16550.4 16659.5 637188.0 637519.0 640554.0 643046.0 643295.0 66228.0 66301.0 66303.7 66367.0 66423.0 1324.5 1389.7 1393.3 1459.4 1493.4 30894.7 32195.2 33164.3 33314.0 33491.0 53417.5 53421.7 53426.5 54498.5 54555.5 518755.4 520630.0 520880.0 522325.0 522692.0 34855.5 37302.8 37984.2 42550.8 44239.1 43876.6 43932.7 44247.8 44550.7 45403.0 33015.0 33585.5 33788.7 34087.7 35303.8 32838.7 33766.5 33931.2 35321.0 35667.6 40307.0 40749.4 40764.8 40939.0 41269.4 33837.8 34078.8 34206.5 34799.5 35386.3 24657.5 25883.7 26477.2 26583.2 26937.7 09:06:00 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | [#2] jquery.html Cycles:180 Average:38641.54 Median:2644.46 stddev:115899.37 (4382.7%) stddev-sans-first:116188.82 09:06:00 INFO - PROCESS | 2174 | Values: 343.1 390.8 392.2 399.8 428.1 20733.9 22236.7 22363.2 22370.6 23132.8 21444.7 21854.3 23194.0 23275.1 23433.0 5973.7 6318.6 6329.6 6329.9 6350.5 5992.4 6128.6 6164.3 6247.3 6256.8 6088.3 6090.5 6170.4 6214.8 6237.9 5935.9 6108.1 6185.9 6190.8 6205.2 5406.4 5475.6 5485.8 5486.5 5493.5 26692.9 27021.0 27092.9 27361.7 27401.6 2633.6 2655.3 2672.0 2689.3 2696.2 10408.0 10414.7 10437.6 10705.3 10810.7 1836.4 1915.6 1931.4 2000.4 2004.6 111137.4 113394.4 114236.0 114944.3 115541.0 10884.2 10903.9 10943.8 11084.7 11212.2 13526.9 13577.9 13599.5 13601.0 13612.6 8485.7 8632.5 8704.9 8780.8 8805.3 7333.4 8731.6 8864.3 9019.0 9082.9 3927.8 4248.9 4256.9 4321.1 4321.8 2038.2 2085.3 2093.7 2096.7 2099.6 688.0 992.9 1022.2 1031.4 1086.6 19890.8 21520.8 23086.8 23136.4 23147.0 1012.4 1015.7 1031.8 1050.8 1054.1 10387.7 11191.6 11864.3 11949.9 11983.6 423956.0 675244.0 758289.0 758407.0 790300.0 128197.0 133484.0 158792.2 163265.0 166429.7 988.8 1013.6 1035.9 1037.0 1037.4 17739.3 19347.8 20652.0 21246.9 21274.4 55555.7 59523.7 59722.0 61487.7 62090.7 92543.0 92782.5 96104.0 96235.8 96411.0 7438.7 7664.6 7769.0 8443.5 8720.7 8517.6 11190.6 11601.4 13080.7 13504.8 5789.4 6568.0 11217.1 11398.9 11762.8 7979.9 9603.5 9802.2 10381.7 10629.2 11610.8 11727.4 12038.8 12069.8 12099.0 7702.5 7739.7 7911.6 7923.0 7942.8 6295.9 11350.9 11588.9 11791.9 11910.9 09:06:00 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | [#3] mootools.html Cycles:180 Average:5509.98 Median:5153.84 stddev:2999.18 (58.2%) stddev-sans-first:2991.86 09:06:00 INFO - PROCESS | 2174 | Values: 1421.7 1434.0 1438.2 1441.7 1446.4 8198.5 8589.9 8600.6 8603.9 8611.7 7609.5 7880.4 7886.1 8208.7 8418.8 2383.4 2417.2 2420.3 2421.6 2425.4 2066.3 2393.6 2422.2 2430.2 2441.0 2132.6 2209.7 2327.7 2389.8 2410.5 2414.2 2415.6 2417.7 2420.8 2429.4 2386.4 2400.9 2413.7 2413.7 2423.3 7139.6 8489.4 8541.7 8565.5 8648.4 5144.3 5306.4 5309.0 5311.5 5320.2 3171.6 3274.7 3364.8 3382.2 3668.4 1200.6 1246.8 1252.8 1298.6 1308.9 10919.9 11050.3 11093.8 11103.6 11173.6 3942.0 4549.3 4829.4 4850.8 4852.3 9610.1 9619.0 9619.2 9633.3 9654.3 5297.0 5382.2 5383.2 5396.5 5398.6 4346.2 4412.0 4850.9 4866.5 4949.7 3855.9 3914.9 3966.3 3998.3 4007.4 1087.2 1274.3 1275.1 1284.8 1289.5 872.3 909.3 939.5 949.7 1002.8 4958.0 5163.4 5552.6 5624.2 5902.6 572.6 960.4 968.2 974.4 995.0 3798.8 3899.1 3912.2 3921.4 4039.1 10011.1 10115.6 10210.4 10288.8 10293.7 10116.1 10220.5 10234.9 10239.4 10260.0 7464.2 7864.7 7901.4 7929.2 7989.4 5821.1 5832.6 5840.8 5885.6 6018.9 9253.4 9491.1 9518.8 9522.7 9526.8 9225.7 9415.2 9542.4 9638.0 9645.7 7223.3 7271.1 7401.6 7427.0 7433.5 7863.6 7958.9 7964.6 7964.7 7975.7 6762.1 6915.5 6950.6 6955.2 7067.6 6492.5 6591.8 6676.3 6708.4 6932.0 6389.4 6417.6 6455.9 6501.9 6504.6 5037.6 5056.8 5060.9 5085.3 5116.2 4969.7 5045.8 5074.4 5167.4 5242.3 09:06:00 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | [#4] prototype.html Cycles:180 Average:4397.02 Median:4860.40 stddev:1289.35 (26.5%) stddev-sans-first:1256.92 09:06:00 INFO - PROCESS | 2174 | Values: 363.3 369.9 374.0 384.4 387.0 4977.7 5122.7 5363.8 5373.2 5481.8 5126.8 5130.6 5307.6 5334.9 5348.2 3622.2 4097.7 4186.5 4227.5 4239.6 3566.4 4085.8 4188.5 4206.1 4221.3 3628.0 3811.8 4112.5 4155.0 4236.7 3853.3 3861.7 4133.5 4151.5 4194.5 2962.1 3139.5 3435.8 3712.7 3720.5 4799.3 5036.8 5204.3 5211.6 5242.3 4072.0 4829.3 4829.3 4845.7 4847.3 5114.3 5565.3 5582.7 5601.9 5627.9 3497.1 3866.5 4072.2 4113.3 4116.7 4905.6 5907.8 5916.9 5918.9 5930.9 4036.3 4178.8 4190.5 4193.4 4243.6 3985.0 4165.2 4235.6 4240.8 4241.7 4412.0 4480.5 4505.6 4752.3 4827.4 4994.7 5674.3 5687.7 5693.9 5738.8 1216.9 1271.0 1341.7 1362.5 1369.3 867.5 881.4 920.4 927.5 956.5 4044.9 4205.6 4903.7 4912.9 4942.6 4810.5 4990.6 5085.9 5146.6 5183.5 4087.8 4145.9 4264.0 4850.3 4870.5 2481.9 2521.3 2809.9 2827.7 2852.6 4996.0 5385.7 5589.4 5600.4 5664.7 4754.2 5547.6 5571.4 5606.6 5691.6 4747.9 4888.7 4942.5 5564.7 5630.8 5411.0 5423.0 5445.9 5447.7 5496.9 4426.0 5331.6 5385.3 5399.9 5471.8 4683.9 5110.0 5219.8 5390.9 5665.5 3339.6 3562.6 3721.3 4017.0 4076.0 4288.4 4617.4 4908.8 5292.9 5569.5 4875.5 5167.0 5265.7 5273.4 5308.0 4573.1 4587.2 5020.7 5137.9 5265.7 4135.7 4788.6 5127.8 5131.3 5199.9 4949.8 5041.7 5239.9 5241.1 5258.4 4336.7 4360.5 4555.7 5167.6 5186.6 09:06:00 INFO - PROCESS | 2174 | 09:06:00 INFO - PROCESS | 2174 | [#5] yui.html Cycles:180 Average:20550.13 Median:4933.96 stddev:29518.84 (598.3%) stddev-sans-first:29564.14 09:06:00 INFO - PROCESS | 2174 | Values: 733.7 746.1 786.2 859.3 870.5 13010.0 15266.0 15642.8 15801.4 15817.2 14408.4 14692.5 14696.3 14709.0 14716.5 715.5 744.8 745.4 883.6 901.8 863.5 890.6 898.5 906.9 907.6 930.2 949.4 953.0 955.9 957.4 952.2 953.4 954.0 954.6 955.0 708.8 709.2 709.4 709.5 709.7 13834.9 15348.8 15691.1 15796.8 15984.4 14354.5 14638.8 14796.9 14854.7 15072.8 11456.7 11818.0 11927.8 11948.2 12003.6 3218.7 3605.6 3736.7 3864.9 4006.1 96722.5 107603.0 109705.5 110223.0 110427.4 9011.8 11305.8 11511.2 11527.3 11651.8 23559.3 23560.6 23595.4 23612.8 23618.9 7520.3 7618.4 8190.3 8299.3 8317.3 4500.3 4559.5 4579.2 4597.7 4659.4 3618.4 3643.0 3647.0 3720.2 3724.8 675.4 675.5 682.8 684.7 692.5 656.3 668.5 670.7 677.3 693.7 9637.4 9785.1 10292.4 10393.5 10459.8 668.1 689.4 695.8 700.4 702.9 4504.4 4913.2 4916.3 4921.1 4946.8 84822.6 94769.0 101972.0 102152.0 103990.5 87320.0 87448.0 87615.7 90143.5 92744.0 79112.6 80175.0 80931.0 82222.2 82733.0 9602.5 9622.8 9629.5 9653.2 9659.6 50075.0 52844.2 53118.0 53508.5 54275.0 69762.6 69915.0 70729.6 70739.0 72679.0 9207.6 10983.7 11490.1 11515.3 11828.8 12241.5 12622.7 12657.6 13033.1 13065.9 9671.6 11737.5 11858.9 11937.9 11976.6 12952.8 13792.0 13937.1 13992.6 14183.4 12729.4 13920.4 14346.1 14418.0 14422.6 9387.7 9820.4 9864.1 9886.9 9908.7 10298.4 10824.4 11235.6 11553.2 11685.4 09:06:00 INFO - PROCESS | 2174 | -------- Summary: end -------- 09:06:00 INFO - PROCESS | 2174 | 09:06:01 INFO - TEST-INFO | 2174: exit 0 09:06:01 INFO - TEST-OK | dromaeo_css | took 1118749ms 09:06:01 INFO - TEST-START | kraken 09:06:01 INFO - operating with platform_type : mac_ 09:06:01 INFO - Initialising browser for kraken test... 09:06:01 INFO - TEST-INFO | started process 2176 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpluglFH/profile http://localhost:56366/getInfo.html) 09:06:03 INFO - PROCESS | 2176 | __metrics Screen width/height:1600/1200 09:06:03 INFO - PROCESS | 2176 | colorDepth:24 09:06:03 INFO - PROCESS | 2176 | Browser inner width/height: 1024/689 09:06:03 INFO - PROCESS | 2176 | __metrics 09:06:03 INFO - PROCESS | 2176 | 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" 09:06:03 INFO - PROCESS | 2176 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:04 INFO - TEST-INFO | 2176: exit 0 09:06:04 INFO - Browser initialized. 09:06:04 INFO - Running cycle 1/1 for kraken test... 09:06:04 INFO - TEST-INFO | started process 2178 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpluglFH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:16 INFO - PROCESS | 2178 | RSS: Main: 164085760 09:06:16 INFO - PROCESS | 2178 | 09:06:19 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56366/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:20 INFO - PROCESS | 2178 | RSS: Main: 214876160 09:06:20 INFO - PROCESS | 2178 | 09:06:22 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56366/tests/kraken/driver.html?testName=audio-dft) 09:06:23 INFO - PROCESS | 2178 | RSS: Main: 229740544 09:06:23 INFO - PROCESS | 2178 | 09:06:26 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56366/tests/kraken/driver.html?testName=audio-fft) 09:06:27 INFO - PROCESS | 2178 | RSS: Main: 325398528 09:06:27 INFO - PROCESS | 2178 | 09:06:29 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56366/tests/kraken/driver.html?testName=audio-oscillator) 09:06:29 INFO - PROCESS | 2178 | RSS: Main: 230023168 09:06:29 INFO - PROCESS | 2178 | 09:06:31 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56366/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:32 INFO - PROCESS | 2178 | RSS: Main: 231464960 09:06:32 INFO - PROCESS | 2178 | 09:06:35 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56366/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:35 INFO - PROCESS | 2178 | RSS: Main: 270741504 09:06:35 INFO - PROCESS | 2178 | 09:06:38 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56366/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:39 INFO - PROCESS | 2178 | RSS: Main: 269398016 09:06:39 INFO - PROCESS | 2178 | 09:06:42 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56366/tests/kraken/driver.html?testName=json-parse-financial) 09:06:42 INFO - PROCESS | 2178 | RSS: Main: 266649600 09:06:42 INFO - PROCESS | 2178 | 09:06:44 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56366/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:45 INFO - PROCESS | 2178 | RSS: Main: 245170176 09:06:45 INFO - PROCESS | 2178 | 09:06:47 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56366/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:47 INFO - PROCESS | 2178 | RSS: Main: 247451648 09:06:47 INFO - PROCESS | 2178 | 09:06:49 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56366/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:50 INFO - PROCESS | 2178 | RSS: Main: 255971328 09:06:50 INFO - PROCESS | 2178 | 09:06:53 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:54 INFO - PROCESS | 2178 | RSS: Main: 269582336 09:06:54 INFO - PROCESS | 2178 | 09:06:57 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:06:57 INFO - PROCESS | 2178 | RSS: Main: 263630848 09:06:57 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:56366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56366/tests/kraken/driver.html?testName=ai-astar) 09:06:59 INFO - PROCESS | 2178 | RSS: Main: 308105216 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | __start_tp_report 09:06:59 INFO - PROCESS | 2178 | _x_x_mozilla_page_load 09:06:59 INFO - PROCESS | 2178 | _x_x_mozilla_page_load_details 09:06:59 INFO - PROCESS | 2178 | |i|pagename|runs| 09:06:59 INFO - PROCESS | 2178 | |0;ai-astar;103;114;114;115;115;114;113;113;114;118 09:06:59 INFO - PROCESS | 2178 | |1;audio-beat-detection;137;132;106;142;107;107;106;105;126;109 09:06:59 INFO - PROCESS | 2178 | |2;audio-dft;186;182;187;199;257;204;185;184;186;186 09:06:59 INFO - PROCESS | 2178 | |3;audio-fft;82;59;59;91;62;59;58;60;74;57 09:06:59 INFO - PROCESS | 2178 | |4;audio-oscillator;88;70;85;69;68;68;82;68;70;82 09:06:59 INFO - PROCESS | 2178 | |5;imaging-gaussian-blur;90;88;74;127;133;94;92;89;92;88 09:06:59 INFO - PROCESS | 2178 | |6;imaging-darkroom;96;96;95;96;97;95;95;132;148;121 09:06:59 INFO - PROCESS | 2178 | |7;imaging-desaturate;84;85;83;85;87;85;83;84;88;86 09:06:59 INFO - PROCESS | 2178 | |8;json-parse-financial;54;53;59;54;56;54;55;55;56;55 09:06:59 INFO - PROCESS | 2178 | |9;json-stringify-tinderbox;66;80;71;83;70;67;69;69;69;70 09:06:59 INFO - PROCESS | 2178 | |10;stanford-crypto-aes;87;84;81;105;100;98;99;86;88;88 09:06:59 INFO - PROCESS | 2178 | |11;stanford-crypto-ccm;134;135;137;137;138;141;142;141;173;144 09:06:59 INFO - PROCESS | 2178 | |12;stanford-crypto-pbkdf2;182;215;196;165;163;164;163;169;159;159 09:06:59 INFO - PROCESS | 2178 | |13;stanford-crypto-sha256-iterative;63;66;64;64;63;64;63;64;62;63 09:06:59 INFO - PROCESS | 2178 | __end_tp_report 09:06:59 INFO - PROCESS | 2178 | __start_cc_report 09:06:59 INFO - PROCESS | 2178 | _x_x_mozilla_cycle_collect,2022 09:06:59 INFO - PROCESS | 2178 | __end_cc_report 09:06:59 INFO - PROCESS | 2178 | __startTimestamp1491322019722__endTimestamp 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | ------- Summary: start ------- 09:06:59 INFO - PROCESS | 2178 | Number of tests: 14 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.89 (3.4%) stddev-sans-first:1.51 09:06:59 INFO - PROCESS | 2178 | Values: 103.0 114.0 114.0 115.0 115.0 114.0 113.0 113.0 114.0 118.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:117.50 stddev:14.82 (12.6%) stddev-sans-first:13.97 09:06:59 INFO - PROCESS | 2178 | Values: 137.0 132.0 106.0 142.0 107.0 107.0 106.0 105.0 126.0 109.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#2] audio-dft Cycles:10 Average:195.60 Median:186.50 stddev:22.69 (12.2%) stddev-sans-first:23.80 09:06:59 INFO - PROCESS | 2178 | Values: 186.0 182.0 187.0 199.0 257.0 204.0 185.0 184.0 186.0 186.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:11.97 (19.6%) stddev-sans-first:11.22 09:06:59 INFO - PROCESS | 2178 | Values: 82.0 59.0 59.0 91.0 62.0 59.0 58.0 60.0 74.0 57.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.00 stddev:8.16 (10.7%) stddev-sans-first:7.18 09:06:59 INFO - PROCESS | 2178 | Values: 88.0 70.0 85.0 69.0 68.0 68.0 82.0 68.0 70.0 82.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#5] imaging-gaussian-blur Cycles:10 Average:96.70 Median:89.50 stddev:18.43 (20.6%) stddev-sans-first:19.39 09:06:59 INFO - PROCESS | 2178 | Values: 90.0 88.0 74.0 127.0 133.0 94.0 92.0 89.0 92.0 88.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#6] imaging-darkroom Cycles:10 Average:107.10 Median:95.50 stddev:19.43 (20.3%) stddev-sans-first:20.19 09:06:59 INFO - PROCESS | 2178 | Values: 96.0 96.0 95.0 96.0 97.0 95.0 95.0 132.0 148.0 121.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.63 (1.9%) stddev-sans-first:1.69 09:06:59 INFO - PROCESS | 2178 | Values: 84.0 85.0 83.0 85.0 87.0 85.0 83.0 84.0 88.0 86.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.66 (3.0%) stddev-sans-first:1.72 09:06:59 INFO - PROCESS | 2178 | Values: 54.0 53.0 59.0 54.0 56.0 54.0 55.0 55.0 56.0 55.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:70.00 stddev:5.56 (7.9%) stddev-sans-first:5.55 09:06:59 INFO - PROCESS | 2178 | Values: 66.0 80.0 71.0 83.0 70.0 67.0 69.0 69.0 69.0 70.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:87.50 stddev:8.13 (9.3%) stddev-sans-first:8.45 09:06:59 INFO - PROCESS | 2178 | Values: 87.0 84.0 81.0 105.0 100.0 98.0 99.0 86.0 88.0 88.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:141.00 stddev:11.28 (8.0%) stddev-sans-first:11.57 09:06:59 INFO - PROCESS | 2178 | Values: 134.0 135.0 137.0 137.0 138.0 141.0 142.0 141.0 173.0 144.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:167.00 stddev:18.63 (11.2%) stddev-sans-first:19.51 09:06:59 INFO - PROCESS | 2178 | Values: 182.0 215.0 196.0 165.0 163.0 164.0 163.0 169.0 159.0 159.0 09:06:59 INFO - PROCESS | 2178 | 09:06:59 INFO - PROCESS | 2178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 09:06:59 INFO - PROCESS | 2178 | Values: 63.0 66.0 64.0 64.0 63.0 64.0 63.0 64.0 62.0 63.0 09:06:59 INFO - PROCESS | 2178 | -------- Summary: end -------- 09:06:59 INFO - PROCESS | 2178 | 09:07:00 INFO - TEST-INFO | 2178: exit 0 09:07:00 INFO - TEST-OK | kraken | took 59129ms 09:07:00 INFO - SUITE-END | took 1177s 09:07:00 INFO - Completed test suite (00:19:38) 09:07:00 INFO - javascript benchmark 09:07:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3456.2396272819974, 3468.2543253200574, 3492.5808902931653, 3498.3528047311243, 3540.752147349685, 5979.760809567618, 6036.426539478743, 6036.939630603692, 6072.939270607292, 6119.479844213247, 5866.266716660418, 6016.849578760533, 6088.421599948009, 6122.35715249899, 6123.601965872226, 5266.4733526647415, 5403.0, 5439.238506609078, 5447.509724124828, 5540.307461567304, 5372.086745253317, 5390.029794636964, 5393.946060539403, 5459.235707001023, 5578.665280083188, 5393.81121660742, 5475.698836563987, 5484.149956756709, 5485.588580856432, 5491.368492623339, 5464.754086066137, 5469.835904922858, 5509.834704958857, 5513.173024046385, 5541.473560011793, 5304.946950530484, 5428.782848686048, 5441.537469315113, 5460.945390546083, 5482.122860342326, 6130.509559235251, 6186.969065154691, 6196.907046394308, 6198.6280823150755, 6203.348648391944, 6220.1602783624085, 6266.4360207581085, 6296.874062518724, 6312.242530896276, 6332.4934005279465, 6365.777197798101, 6367.299597044322, 6391.744330226786, 6408.070829729663, 6462.644554549498, 6186.381361863868, 6190.566660333779, 6219.315875253718, 6231.3145553989025, 6234.937650623527, 6324.9051264231075, 6384.553081284358, 6538.248101468297, 6573.80278591643, 6575.638339891256, 6247.875042499216, 6250.1874756281395, 6269.247690277105, 6300.842478938063, 6320.55756097078, 6410.038494225811, 6410.67946602668, 6417.679116044179, 6430.807075787734, 6435.646039467781, 6199.56603037783, 6236.906446403307, 6333.778317758856, 6339.11252424661, 6346.9682651586445, 6262.2172228471445, 6269.0909818076125, 6274.968625156845, 6285.371462853678, 6297.370262973757, 5184.0, 5197.480251974772, 5205.609579281569, 5212.55693266069, 5226.5818734501145, 4434.26834572292, 4655.627549796008, 4671.602913752301, 4687.320338550891, 4689.577937985529, 5892.204552385373, 6012.338642749294, 6032.3967603239325, 6048.485878700271, 6126.136919559505, 6313.747450102036, 6359.713812878432, 6392.776252831221, 6412.294647588855, 6423.74305027803, 6112.694365281807, 6122.265328160649, 6126.816195514141, 6128.203333566607, 6133.325334213233, 5486.615936884459, 5617.747201375866, 5673.971630141823, 5674.148877668383, 5717.085266357363, 6456.9354306456335, 6468.6442245676, 6469.805905822833, 6490.837729056811, 6518.185226846645, 6381.266154392304, 6386.361363863576, 6402.6158430494315, 6409.7436102555375, 6413.1021656969, 6498.285188629342, 6504.739810407531, 6541.313162117909, 6570.8028759137305, 6595.505337099641, 5260.789568417221, 6259.96870015647, 6262.780802671885, 6280.905786413116, 6311.684415779285, 6355.459785918249, 6386.96806515983, 6388.93611063902, 6410.871782564416, 6415.06981487691, 6210.0, 6228.190335256388, 6266.968665156645, 6279.026750853625, 6288.6855657217875, 6229.190205273286, 6237.407446292595, 6304.621722696653, 6306.527010474325, 6314.210723659543, 6282.151909492343, 6301.338359472189, 6335.239771227482, 6336.303006669171, 6339.175907132043, 6210.285817130907, 6281.497480201664, 6286.842828929313, 6300.936990630035, 6300.9684951574945, 6165.260168779775, 6196.938030619636, 6272.278687950761, 6274.435300822948, 6326.905096423466], "value": 5927.663554558303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.9880484847274, 517.1699422427005, 528.091682306433, 535.330836454432, 556.1102236421726, 41318.586814131886, 43319.0, 43476.347854782165, 43489.78255108728, 43592.0, 45406.54593454064, 46069.76965115178, 46140.538594614045, 46143.76928115363, 46153.53846461535, 9244.0, 9494.287928405363, 9648.758781030478, 9883.604655813795, 9899.653512127077, 11986.70033249167, 12384.442700078473, 12413.44139513724, 12529.749405011895, 12544.749105017894, 12142.575009874656, 12158.270503769758, 12231.694207644836, 12245.142840001203, 12280.324582147978, 12284.692882677915, 12324.014078873668, 12333.0, 12342.753144937096, 12348.259104453671, 12248.81626775599, 12354.0, 12355.691107722289, 12369.814452783216, 12381.133320667557, 43303.56696433027, 43602.909927251756, 43618.78190609027, 43657.0, 43745.0, 4043.211573743092, 4081.673466122703, 4084.775337356444, 4116.485439320085, 4124.587541245852, 28064.719352806416, 31248.8437557813, 32304.19239519007, 33127.83436082804, 33596.0, 3376.1559610097474, 3392.270661807723, 3408.3694516514524, 3534.045807631925, 3558.484019817138, 505557.0, 511006.0, 511838.4408077973, 512008.0, 514962.4251878792, 66433.0, 66949.99575006281, 66977.99533006911, 66992.0, 67009.32990670031, 66850.66574667193, 69230.65384673145, 69287.61424771477, 69399.65300173467, 69625.60748784996, 17321.7401738974, 17331.306747730203, 17946.282148713904, 18028.819711802713, 18034.008129552738, 10226.23303252259, 12589.811152832715, 12903.290319032543, 13413.329333533284, 13685.452581896812, 17652.940823550372, 17720.55698607545, 17892.194851231467, 17914.28342866297, 18010.279588816302, 7250.4199664026755, 7304.853902921912, 7354.632268386559, 7374.483786134919, 7383.261673832574, 823.5305875650821, 870.7126648206076, 878.872563478292, 888.4314039015036, 913.1507697841072, 29904.55143172854, 30986.0, 30993.830431869552, 31630.36739265248, 31778.56996435166, 970.3886551472668, 1078.9730256743644, 1096.030013438097, 1105.9889401106047, 1212.8362671039474, 13545.86454135446, 15765.527034188992, 15890.76163857543, 16550.42073527421, 16659.500214993568, 637188.0, 637519.0, 640554.0, 643046.0, 643295.0, 66228.0, 66301.0, 66303.66848165728, 66367.0, 66423.0, 1324.4966912573161, 1389.6942672611808, 1393.2894223945862, 1459.3651761483789, 1493.3653197391066, 30894.691053090082, 32195.195120122185, 33164.33671326608, 33314.0, 33491.0, 53417.46582534125, 53421.7328913353, 53426.46573534215, 54498.45501544934, 54555.454445455034, 518755.40622296644, 520630.0, 520880.0, 522325.0, 522692.0, 34855.47716784199, 37302.81348593348, 37984.24031519299, 42550.78724606357, 44239.11521769611, 43876.56123438725, 43932.68201953947, 44247.77876110599, 44550.66348009565, 45403.0, 33015.00954971355, 33585.49621755627, 33788.662113379534, 34087.65912340845, 35303.823480882435, 32838.67161328452, 33766.49350259699, 33931.15172120618, 35321.0, 35667.64332356643, 40306.99232519211, 40749.38875916805, 40764.757938313676, 40939.0, 41269.38095928504, 33837.830810845786, 34078.82960585181, 34206.48690269598, 34799.47800783041, 35386.29227415489, 24657.506849862544, 25883.741162588885, 26477.205683829518, 26583.202503924913, 26937.73062269352], "value": 21238.078451869813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.0981863421652, 390.8358489434439, 392.21361170852447, 399.8480577380594, 428.12694461729933, 20733.85963771992, 22236.666450003264, 22363.217287394964, 22370.55258894823, 23132.768672313272, 21444.678329825027, 21854.344369668936, 23194.0, 23275.068997240134, 23433.0, 5973.731182096805, 6318.557700960934, 6329.556931014831, 6329.905051424233, 6350.523710721691, 5992.370801065891, 6128.601640893327, 6164.260288765355, 6247.312795592481, 6256.843578910518, 6088.269407671086, 6090.512758979271, 6170.444659980601, 6214.8446288842915, 6237.906431403532, 5935.85160370992, 6108.14485971962, 6185.948388773919, 6190.84522886927, 6205.1623030890705, 5406.351237851483, 5475.616706830523, 5485.75314110862, 5486.478784515464, 5493.478119578634, 26692.866535667392, 27021.0, 27092.864535677196, 27361.726382736317, 27401.588976165374, 2633.644457998165, 2655.269800804794, 2671.9599206011926, 2689.287338855205, 2696.191142657195, 10408.01123893229, 10414.687559373231, 10437.634682786065, 10705.25063245573, 10810.67567972962, 1836.40316897009, 1915.6264528416964, 1931.4012656076661, 2000.4098790856588, 2004.6491863923754, 111137.44431277872, 113394.43302783516, 114236.0, 114944.27583586253, 115541.0, 10884.238103332691, 10903.890961090447, 10943.83584246237, 11084.722881928017, 11212.215144939775, 13526.93236533811, 13577.932110339385, 13599.524016659567, 13601.04792664504, 13612.591622251348, 8485.703000394957, 8632.48205107683, 8704.912950870537, 8780.824383512294, 8805.339599529932, 7333.376662983599, 8731.602943529006, 8864.290856731446, 9019.0, 9082.909170908206, 3927.823247953792, 4248.87253382399, 4256.884016558375, 4321.070969741458, 4321.783910804447, 2038.2254743197786, 2085.322270262171, 2093.71734815801, 2096.6540520813896, 2099.6220680277697, 688.008083406057, 992.8780478059746, 1022.156720705421, 1031.4017869635743, 1086.6305456144948, 19890.801091989186, 21520.784792151877, 23086.769132308797, 23136.42158946006, 23147.0, 1012.3622118065572, 1015.7206768138673, 1031.7936412717486, 1050.795094956476, 1054.1303424674675, 10387.68836934893, 11191.608293709844, 11864.347460889734, 11949.940250298867, 11983.64049078529, 423956.0, 675244.0, 758289.0, 758407.0, 790300.0, 128197.0, 133484.0, 158792.20603897137, 163265.0, 166429.6714065712, 988.7528117970508, 1013.6350913671073, 1035.9274850760526, 1037.0459177556666, 1037.4242295525905, 17739.29042838272, 19347.839129652268, 20652.0, 21246.893765531073, 21274.36176914695, 55555.722221388634, 59523.70238148955, 59722.0, 61487.692561536904, 62090.68954655198, 92543.0, 92782.53608731914, 96104.0, 96235.81995530459, 96411.0, 7438.6652600632015, 7664.616769161631, 7769.0, 8443.451175673561, 8720.694775682821, 8517.616707248064, 11190.552377904793, 11601.419929003685, 13080.672983175496, 13504.797428038784, 5789.421057894346, 6567.9671601641685, 11217.102631789601, 11398.917102875213, 11762.764744704888, 7979.880301795361, 9603.471809050568, 9802.215822734022, 10381.688549343531, 10629.202809789142, 11610.825837612612, 11727.35499547533, 12038.75922481563, 12069.818952715892, 12098.971587415168, 7702.537847729154, 7739.651715672921, 7911.604419779103, 7923.0, 7942.761717148494, 6295.905561416674, 11350.94324528372, 11588.884111159117, 11791.941040294743, 11910.940445297718], "value": 9879.518136807683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.7298713244484, 1433.9928300358497, 1438.2233593859314, 1441.682829777449, 1446.3636000159922, 8198.467099638527, 8589.871151932726, 8600.569971501416, 8603.870941935867, 8611.698590549331, 7609.5434273943465, 7880.408969327309, 7886.132525422199, 8208.712695055674, 8418.789530261747, 2383.380321116509, 2417.2385698505004, 2420.3102115896972, 2421.5641184586766, 2425.3815277104313, 2066.318115022039, 2393.5930891748358, 2422.1643532981093, 2430.2344761400104, 2440.987795061031, 2132.573485302938, 2209.6962791952747, 2327.697399338092, 2389.832711710181, 2410.4817464245184, 2414.1912459326145, 2415.649730789043, 2417.721961974369, 2420.782129608326, 2429.441228517433, 2386.355683965337, 2400.9039638414442, 2413.686220791286, 2413.734489206186, 2423.345696661909, 7139.60732159731, 8489.363297752694, 8541.743747687578, 8565.486070835708, 8648.437851539693, 5144.279800827887, 5306.389765176977, 5309.0, 5311.548518375943, 5320.228566857784, 3171.5559821624993, 3274.6889045540634, 3364.771858271713, 3382.222088919538, 3668.394714872043, 1200.6218041316956, 1246.819211214378, 1252.768237875996, 1298.6104168749432, 1308.9280089595068, 10919.945400273027, 11050.281731687415, 11093.83359249612, 11103.55585776568, 11173.553057877756, 3941.9802900985887, 4549.340345649863, 4829.444613869379, 4850.835799408117, 4852.272159176152, 9610.135087841987, 9619.0, 9619.230461563058, 9633.277504187214, 9654.324197306121, 5296.973515132399, 5382.219578161144, 5383.246345511631, 5396.460353964572, 5398.595105367034, 4346.1525002624185, 4411.955880441219, 4850.878728031827, 4866.489018653061, 4949.727764972961, 3855.9228815423535, 3914.9217015660097, 3966.345552983783, 3998.28030954431, 4007.438958545806, 1087.1683162380784, 1274.31187158935, 1275.0628288208345, 1284.7880099783617, 1289.4906511927736, 872.3152325424638, 909.2634965677822, 939.4551160326994, 949.6818565780541, 1002.7593377589326, 4957.958828646025, 5163.40620828602, 5552.639078459887, 5624.184493248538, 5902.6458412495385, 572.5991805736002, 960.351762560269, 968.1770495079127, 974.3715303629119, 994.9900500994897, 3798.848046078181, 3899.064224586079, 3912.197999410114, 3921.3725803871816, 4039.111395492987, 10011.149052330487, 10115.645952391631, 10210.387376757419, 10288.845667314996, 10293.7426564335, 10116.140128089195, 10220.488975551192, 10234.948825255975, 10239.436830974368, 10260.0, 7464.178940316561, 7864.685412583547, 7901.407394445325, 7929.246721561442, 7989.400794940403, 5821.09772985188, 5832.591718579659, 5840.766369345349, 5885.5880088395115, 6018.909716354171, 9253.352265341362, 9491.098345657152, 9518.762030949281, 9522.666706665234, 9526.761830954281, 9225.72322830316, 9415.152636262495, 9542.42745435276, 9638.0, 9645.71062868115, 7223.2776722329445, 7271.054762880792, 7401.629918504161, 7427.0, 7433.516821406592, 7863.606819658879, 7958.920410795818, 7964.561949092856, 7964.681412743425, 7975.72084977023, 6762.120924279812, 6915.51591388598, 6950.582965022115, 6955.23492415844, 7067.646617668993, 6492.545521813617, 6591.802245932629, 6676.298988606321, 6708.42978346846, 6932.0, 6389.361063893573, 6417.550771445954, 6455.935440645533, 6501.8699626008165, 6504.642244676588, 5037.647364684583, 5056.811649262494, 5060.924086138637, 5085.3134826797905, 5116.232565115113, 4969.652124351261, 5045.772940217626, 5074.3657042869645, 5167.379914410144, 5242.2922905408805], "value": 4484.51313418259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.28070420567275, 369.9482072509849, 373.9887803365899, 384.43680008787123, 386.9632384923431, 4977.7262250576205, 5122.6926384416965, 5363.785448582057, 5373.220882971967, 5481.75332110055, 5126.769295381708, 5130.563902068328, 5307.601929855257, 5334.91997620035, 5348.197770334452, 3622.1669016126307, 4097.692673049533, 4186.539480657125, 4227.526896765388, 4239.5548467410945, 3566.4472006838982, 4085.81613827377, 4188.455500784894, 4206.095689426773, 4221.32458806591, 3627.981860090696, 3811.8475260989526, 4112.485939257593, 4155.0083939563465, 4236.703430759848, 3853.344931361675, 3861.6524512793985, 4133.462649855514, 4151.522574903879, 4194.454720886296, 2962.1486570893194, 3139.5290706393994, 3435.811030393327, 3712.684421824148, 3720.534933133358, 4799.2801079837955, 5036.816348158217, 5204.271402003723, 5211.557017653504, 5242.292290540767, 4071.959280407217, 4829.275608658694, 4829.27560865873, 4845.685030473008, 4847.345608342864, 5114.28400023997, 5565.332160140769, 5582.748776305036, 5601.859953501154, 5627.887442251173, 3497.090756403328, 3866.5360156781085, 4072.226277007359, 4113.341865301538, 4116.6912481564, 4905.626424601118, 5907.822765317004, 5916.881662366729, 5918.8816223675285, 5930.911036334415, 4036.324925156086, 4178.811953462102, 4190.5180904195795, 4193.391958166048, 4243.554426785205, 3985.029055451579, 4165.230121968857, 4235.576442355739, 4240.830366785294, 4241.724287921275, 4411.963188650665, 4480.529544397857, 4505.61702255312, 4752.263399173134, 4827.444843842933, 4994.725290109079, 5674.290713660793, 5687.744051517691, 5693.886122277531, 5738.794853080816, 1216.9026477881748, 1271.0, 1341.6784467299701, 1362.4958765256918, 1369.3427154965473, 867.5185272173878, 881.391460584436, 920.4109370003204, 927.4945154890601, 956.5121787888088, 4044.919101617951, 4205.64715519436, 4903.656744027884, 4912.901741965141, 4942.57988071018, 4810.494898035726, 4990.6257030722845, 5085.863937146408, 5146.639735218574, 5183.481651834862, 4087.7751723654887, 4145.875623731293, 4263.978680106579, 4850.296706977469, 4870.512948705101, 2481.888315025828, 2521.3192438041992, 2809.9297517562222, 2827.7313655202724, 2852.557853532706, 4995.975020124876, 5385.703786291713, 5589.413111623302, 5600.383957764642, 5664.660120392789, 4754.191787396151, 5547.557635014925, 5571.359293681197, 5606.579506536945, 5691.573132015115, 4747.905041899143, 4888.7311197884455, 4942.5304596063315, 5564.721763911869, 5630.774769009194, 5411.0, 5423.020597481969, 5445.918311225256, 5447.727613619382, 5496.945030549643, 4426.026274219666, 5331.573474122139, 5385.3268341457315, 5399.9460005401015, 5471.753771080391, 4683.906321873612, 5109.959574053432, 5219.8434046978655, 5390.894866552426, 5665.546756259407, 3339.612177293247, 3562.59030211529, 3721.2557488501866, 4017.0, 4075.9592404076766, 4288.442502474658, 4617.376654151781, 4908.803647854046, 5292.862034662566, 5569.526590239713, 4875.464228767927, 5167.0, 5265.7367131642495, 5273.367195936512, 5307.99148161848, 4573.085382923495, 4587.243104887656, 5020.673656212334, 5137.92293115611, 5265.657732247391, 4135.669146468215, 4788.61691064721, 5127.794888204579, 5131.25596788471, 5199.870003249797, 4949.82675606352, 5041.6722913010535, 5239.921401179062, 5241.135212689864, 5258.447862974485, 4336.653067754509, 4360.454943132108, 4555.703879247838, 5167.560757335668, 5186.6369354144845], "value": 4009.752784239453, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.6551820644295, 746.08231874794, 786.2452046035805, 859.3125499600318, 870.4820631724126, 13010.0, 15266.007709498876, 15642.765358519631, 15801.367945282174, 15817.209139543034, 14408.35162417691, 14692.485762998298, 14696.265186740673, 14709.04391214573, 14716.484923027696, 715.5134508534221, 744.7505085796265, 745.3850573277041, 883.5891310540582, 901.8151278987824, 863.5250612163317, 890.559173209259, 898.4743924803997, 906.8549032154857, 907.6188001039546, 930.2372054914972, 949.4161090929064, 953.0183910572122, 955.9187469065103, 957.4351132831628, 952.1525842000625, 953.4041224234853, 954.0364232125534, 954.5799848066863, 954.9665761698308, 708.8263375472991, 709.1915216653019, 709.4111887133719, 709.5387997801419, 709.7409445552388, 13834.861651383459, 15348.846511534854, 15691.058536487848, 15796.842031579767, 15984.440544580884, 14354.49759258421, 14638.780418293734, 14796.852031479655, 14854.70290594182, 15072.773908391273, 11456.656300311004, 11818.0, 11927.761444771057, 11948.223365481215, 12003.579874704343, 3218.742500599946, 3605.603383627799, 3736.663700266989, 3864.942025869614, 4006.098627808749, 96722.5163874176, 107602.99999999921, 109705.45147274292, 110223.0, 110427.44786276098, 9011.819763604823, 11305.830412543819, 11511.19421640477, 11527.308361498337, 11651.76696466066, 23559.293221203392, 23560.64659030116, 23595.410114746926, 23612.763872361058, 23618.93714782839, 7520.285572870568, 7618.428617853572, 8190.344772418192, 8299.29455996235, 8317.293030092389, 4500.257457519473, 4559.544045595414, 4579.152856721517, 4597.7011494252765, 4659.4175728034, 3618.4029635110437, 3642.9817850910576, 3646.9817650911577, 3720.2373513430225, 3724.8266795959184, 675.3584095109666, 675.4866301610812, 682.846359569093, 684.6782012454139, 692.5117791956759, 656.2878532139285, 668.5019660353069, 670.7162113005224, 677.3226773226774, 693.7467824244216, 9637.42175469474, 9785.107446276861, 10292.433916134534, 10393.53229104692, 10459.84310235347, 668.0913957018452, 689.3692271571456, 695.7843068648735, 700.3696672994346, 702.8594281143792, 4504.414426124583, 4913.213885778258, 4916.3362946001835, 4921.089598424303, 4946.826861059845, 84822.57588712017, 94769.0, 101972.0, 102151.97848021574, 103990.48004759928, 87320.0, 87448.0, 87615.68576471358, 90143.54928225317, 92744.0, 79112.6044369786, 80175.0, 80931.0, 82222.17777822145, 82733.0, 9602.471864047266, 9622.759431014281, 9629.518524073628, 9653.1794797443, 9659.613615455302, 50075.0, 52844.20733688921, 53118.0, 53508.46491535035, 54275.0, 69762.60474790577, 69915.0, 70729.64635176997, 70739.0, 72679.0, 9207.585658645243, 10983.725406864893, 11490.08079353633, 11515.30908145514, 11828.82256766132, 12241.510339586674, 12622.747545049231, 12657.620271391874, 13033.087683862417, 13065.934670326968, 9671.564779585076, 11737.450205132422, 11858.881411185777, 11937.940310298392, 11976.640700778991, 12952.805707914576, 13792.0, 13937.09408888419, 13992.589346189205, 14183.368912574773, 12729.427175776927, 13920.443182272596, 14346.139231646135, 14418.0, 14422.567322980327, 9387.718368448957, 9820.361676491006, 9864.062914023156, 9886.851697224403, 9908.653197138066, 10298.433586152834, 10824.404657743584, 11235.55057797679, 11553.24903881245, 11685.357305348287], "value": 7545.731834387526, "unit": "score"}], "name": "dromaeo_css", "value": 7433.952354024634, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 115.0, 115.0, 114.0, 113.0, 113.0, 114.0, 118.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 106.0, 142.0, 107.0, 107.0, 106.0, 105.0, 126.0, 109.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 187.0, 199.0, 257.0, 204.0, 185.0, 184.0, 186.0, 186.0], "value": 195.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 91.0, 62.0, 59.0, 58.0, 60.0, 74.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 69.0, 68.0, 68.0, 82.0, 68.0, 70.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 74.0, 127.0, 133.0, 94.0, 92.0, 89.0, 92.0, 88.0], "value": 96.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 95.0, 132.0, 148.0, 121.0], "value": 107.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 85.0, 87.0, 85.0, 83.0, 84.0, 88.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 59.0, 54.0, 56.0, 54.0, 55.0, 55.0, 56.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 80.0, 71.0, 83.0, 70.0, 67.0, 69.0, 69.0, 69.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 81.0, 105.0, 100.0, 98.0, 99.0, 86.0, 88.0, 88.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 137.0, 137.0, 138.0, 141.0, 142.0, 141.0, 173.0, 144.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 215.0, 196.0, 165.0, 163.0, 164.0, 163.0, 169.0, 159.0, 159.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 62.0, 63.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1453.9, "alertThreshold": 2.0}]} 09:07:00 INFO - Return code: 0 09:07:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:07:01 INFO - # TBPL SUCCESS # 09:07:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:07:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:07:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:07:01 INFO - 2017-04-04 09:07:01.046 screenresolution[2182:74258] starting screenresolution argv=screenresolution get 09:07:01 INFO - 2017-04-04 09:07:01.049 screenresolution[2182:74258] Display 0: 1600x1200x32@60 09:07:01 INFO - 2017-04-04 09:07:01.055 screenresolution[2183:74261] starting screenresolution argv=screenresolution list 09:07:01 INFO - Available Modes on Display 0 09:07:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:07:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:07:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:07:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:07:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:07:01 INFO - Intel Iris: 09:07:01 INFO - Chipset Model: Intel Iris 09:07:01 INFO - Type: GPU 09:07:01 INFO - Bus: Built-In 09:07:01 INFO - VRAM (Dynamic, Max): 1536 MB 09:07:01 INFO - Vendor: Intel (0x8086) 09:07:01 INFO - Device ID: 0x0a2e 09:07:01 INFO - Revision ID: 0x0009 09:07:01 INFO - Displays: 09:07:01 INFO - Display: 09:07:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:07:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:07:01 INFO - Display Serial Number: 1600x1200 60 09:07:01 INFO - Main Display: Yes 09:07:01 INFO - Mirror: Off 09:07:01 INFO - Online: Yes 09:07:01 INFO - Rotation: Supported 09:07:01 INFO - Return code: 0 09:07:01 INFO - Running post-action listener: _resource_record_post_action 09:07:01 INFO - [mozharness: 2017-04-04 16:07:01.292574Z] Finished run-tests step (success) 09:07:01 INFO - Running post-run listener: _resource_record_post_run 09:07:01 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 143872; Write bytes: 420765184; Read time: 3; Write time: 1413 09:07:01 INFO - TinderboxPrint: CPU usage
53.6% 09:07:01 INFO - TinderboxPrint: I/O read bytes / time
143,872 / 3 09:07:01 INFO - TinderboxPrint: I/O write bytes / time
420,765,184 / 1,413 09:07:01 INFO - TinderboxPrint: CPU idle
2,218.4 (46.4%) 09:07:01 INFO - TinderboxPrint: CPU system
956.9 (20.0%) 09:07:01 INFO - TinderboxPrint: CPU user
1,602.4 (33.5%) 09:07:01 INFO - TinderboxPrint: Swap in / out
121,364,480 / 0 09:07:01 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 117078528; Write bytes: 114570752; Read time: 10851; Write time: 289 09:07:01 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 143360; Write bytes: 295426048; Read time: 3; Write time: 1089 09:07:01 INFO - Running post-run listener: _upload_blobber_files 09:07:01 INFO - Blob upload gear active. 09:07:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:01 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 09:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:07:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:02 INFO - (blobuploader) - INFO - Done attempting. 09:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:03 INFO - (blobuploader) - INFO - Done attempting. 09:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:07:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:04 INFO - (blobuploader) - INFO - Done attempting. 09:07:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:07:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:07 INFO - (blobuploader) - INFO - Done attempting. 09:07:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:07 INFO - Return code: 0 09:07:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a343231a8f9030a94abb680239348bfbceeb97e11ef642b849967aa245affea52fe717fdfa85884b33077920669b1f372299fef0b2aec7d6d13b92e1a066c91d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8b90a55b7d9c8bd39cfe66e84457a5749b6dcc00404ca89b2de3ef59ad492f7ebc359d9a1a718419a10152877a217865cf061df8d2a72131fd2b7bbad5bad62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0e90d9b52923508fe9707fdff1ad87f46f58a65ea4df1bd6c78b5f7840eaa4344e229622dc9fe6eb8c90ceb1e627d74e0f8599116505a0b94360cf907d74a91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3ac105e45579824717f0372eb3b586fcaaea6d26adf7b87dc1d16d306ead564564deaa19eb924add74b75de60f601df53aa052b153d42be9015bba6929a8f1a"} 09:07:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:07 INFO - Contents: 09:07:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a343231a8f9030a94abb680239348bfbceeb97e11ef642b849967aa245affea52fe717fdfa85884b33077920669b1f372299fef0b2aec7d6d13b92e1a066c91d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8b90a55b7d9c8bd39cfe66e84457a5749b6dcc00404ca89b2de3ef59ad492f7ebc359d9a1a718419a10152877a217865cf061df8d2a72131fd2b7bbad5bad62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0e90d9b52923508fe9707fdff1ad87f46f58a65ea4df1bd6c78b5f7840eaa4344e229622dc9fe6eb8c90ceb1e627d74e0f8599116505a0b94360cf907d74a91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3ac105e45579824717f0372eb3b586fcaaea6d26adf7b87dc1d16d306ead564564deaa19eb924add74b75de60f601df53aa052b153d42be9015bba6929a8f1a"} 09:07:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:07 INFO - Copying logs to upload dir... 09:07:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.907496 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-04-04 09:07:07.123364) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 09:07:07.126950) ========= 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.lDN2dirN6D/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.oUq973cySh/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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/Mozilla-Beta/sha512/a343231a8f9030a94abb680239348bfbceeb97e11ef642b849967aa245affea52fe717fdfa85884b33077920669b1f372299fef0b2aec7d6d13b92e1a066c91d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8b90a55b7d9c8bd39cfe66e84457a5749b6dcc00404ca89b2de3ef59ad492f7ebc359d9a1a718419a10152877a217865cf061df8d2a72131fd2b7bbad5bad62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0e90d9b52923508fe9707fdff1ad87f46f58a65ea4df1bd6c78b5f7840eaa4344e229622dc9fe6eb8c90ceb1e627d74e0f8599116505a0b94360cf907d74a91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3ac105e45579824717f0372eb3b586fcaaea6d26adf7b87dc1d16d306ead564564deaa19eb924add74b75de60f601df53aa052b153d42be9015bba6929a8f1a"} build_url:https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/VIOKhK-jQqCixFdwo4BaaA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a343231a8f9030a94abb680239348bfbceeb97e11ef642b849967aa245affea52fe717fdfa85884b33077920669b1f372299fef0b2aec7d6d13b92e1a066c91d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8b90a55b7d9c8bd39cfe66e84457a5749b6dcc00404ca89b2de3ef59ad492f7ebc359d9a1a718419a10152877a217865cf061df8d2a72131fd2b7bbad5bad62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0e90d9b52923508fe9707fdff1ad87f46f58a65ea4df1bd6c78b5f7840eaa4344e229622dc9fe6eb8c90ceb1e627d74e0f8599116505a0b94360cf907d74a91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3ac105e45579824717f0372eb3b586fcaaea6d26adf7b87dc1d16d306ead564564deaa19eb924add74b75de60f601df53aa052b153d42be9015bba6929a8f1a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 09:07:07.164966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:07:07.165341) ========= 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.lDN2dirN6D/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.oUq973cySh/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005330 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:07:07.230379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 09:07:07.230745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 09:07:07.231078) ========= ========= Total master_lag: 0.20 =========