builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0054 starttime: 1492804020.85 results: success (0) buildid: 20170421112620 builduid: d02c09f8255640d4b250b0031bfec7f3 revision: ff6abe20041933a67f636b748ed698e9616a6833 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:00.854185) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:00.854649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:00.854931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:00.882133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:00.882508) ========= 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.PdABtlJtrg/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.bmqcltvmzQ/Listeners TMPDIR=/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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-21 12:47:00-- 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% 52.6M=0s 2017-04-21 12:47:01 (52.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175649 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:01.084170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:01.084487) ========= 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.PdABtlJtrg/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.bmqcltvmzQ/Listeners TMPDIR=/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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.029734 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:01.136540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 12:47:01.136896) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff6abe20041933a67f636b748ed698e9616a6833 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ff6abe20041933a67f636b748ed698e9616a6833 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PdABtlJtrg/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.bmqcltvmzQ/Listeners TMPDIR=/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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-21 12:47:01,217 truncating revision to first 12 chars 2017-04-21 12:47:01,217 Setting DEBUG logging. 2017-04-21 12:47:01,217 attempt 1/10 2017-04-21 12:47:01,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff6abe200419?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 12:47:02,286 unpacking tar archive at: mozilla-central-ff6abe200419/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348582 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 12:47:02.511034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:02.511578) ========= script_repo_revision: ff6abe20041933a67f636b748ed698e9616a6833 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:02.512142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:02.512528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 12:47:02.533399) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-21 12:47:02.533809) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PdABtlJtrg/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.bmqcltvmzQ/Listeners TMPDIR=/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:47:02 INFO - MultiFileLogger online at 20170421 12:47:02 in /builds/slave/test 12:47:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:47:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:47:02 INFO - {'append_to_log': False, 12:47:02 INFO - 'base_work_dir': '/builds/slave/test', 12:47:02 INFO - 'blob_upload_branch': 'Firefox', 12:47:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:47:02 INFO - 'branch': 'Firefox', 12:47:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:02 INFO - 'config_files': ('talos/mac_config.py',), 12:47:02 INFO - 'default_actions': ('clobber', 12:47:02 INFO - 'read-buildbot-config', 12:47:02 INFO - 'download-and-extract', 12:47:02 INFO - 'populate-webroot', 12:47:02 INFO - 'create-virtualenv', 12:47:02 INFO - 'install', 12:47:02 INFO - 'run-tests'), 12:47:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:02 INFO - 'download_minidump_stackwalk': True, 12:47:02 INFO - 'download_symbols': 'ondemand', 12:47:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:02 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:02 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:02 INFO - 'gecko_profile': False, 12:47:02 INFO - 'gecko_profile_interval': 0, 12:47:02 INFO - 'installer_path': 'installer.exe', 12:47:02 INFO - 'log_level': 'info', 12:47:02 INFO - 'log_name': 'talos', 12:47:02 INFO - 'log_to_console': True, 12:47:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:47:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:47:02 INFO - 'opt_config_files': (), 12:47:02 INFO - 'pip_index': False, 12:47:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:02 INFO - 'cmd': ('bash', 12:47:02 INFO - '-c', 12:47:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:02 INFO - 'enabled': True, 12:47:02 INFO - 'halt_on_failure': False, 12:47:02 INFO - 'name': 'check_screen_resolution'},), 12:47:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:02 INFO - 'cmd': ('bash', 12:47:02 INFO - '-c', 12:47:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:02 INFO - 'enabled': True, 12:47:02 INFO - 'halt_on_failure': False, 12:47:02 INFO - 'name': 'check_screen_resolution'},), 12:47:02 INFO - 'run_cmd_checks_enabled': True, 12:47:02 INFO - 'suite': 'dromaeojs', 12:47:02 INFO - 'system_bits': '32', 12:47:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:02 INFO - 'title': 't-yosemite-r7-0054', 12:47:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:02 INFO - 'use_talos_json': True, 12:47:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:47:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:02 INFO - 'work_dir': 'build'} 12:47:02 INFO - [mozharness: 2017-04-21 19:47:02.720182Z] Running clobber step. 12:47:02 INFO - Running pre-action listener: _resource_record_pre_action 12:47:02 INFO - Running main action method: clobber 12:47:02 INFO - rmtree: /builds/slave/test/build 12:47:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:47:05 INFO - Running post-action listener: _resource_record_post_action 12:47:05 INFO - [mozharness: 2017-04-21 19:47:05.233323Z] Finished clobber step (success) 12:47:05 INFO - [mozharness: 2017-04-21 19:47:05.233551Z] Running read-buildbot-config step. 12:47:05 INFO - Running pre-action listener: _resource_record_pre_action 12:47:05 INFO - Running main action method: read_buildbot_config 12:47:05 INFO - Using buildbot properties: 12:47:05 INFO - { 12:47:05 INFO - "project": "", 12:47:05 INFO - "product": "firefox", 12:47:05 INFO - "script_repo_revision": "production", 12:47:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:47:05 INFO - "repository": "", 12:47:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:47:05 INFO - "buildid": "20170421112620", 12:47:05 INFO - "pgo_build": "False", 12:47:05 INFO - "basedir": "/builds/slave/test", 12:47:05 INFO - "buildnumber": 14, 12:47:05 INFO - "slavename": "t-yosemite-r7-0054", 12:47:05 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 12:47:05 INFO - "platform": "yosemite_r7", 12:47:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:47:05 INFO - "branch": "mozilla-central", 12:47:05 INFO - "repo_path": "mozilla-central", 12:47:05 INFO - "revision": "ff6abe20041933a67f636b748ed698e9616a6833", 12:47:05 INFO - "stage_platform": "macosx64", 12:47:05 INFO - "builduid": "d02c09f8255640d4b250b0031bfec7f3", 12:47:05 INFO - "slavebuilddir": "test" 12:47:05 INFO - } 12:47:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:47:05 INFO - Running post-action listener: _resource_record_post_action 12:47:05 INFO - [mozharness: 2017-04-21 19:47:05.239348Z] Finished read-buildbot-config step (success) 12:47:05 INFO - [mozharness: 2017-04-21 19:47:05.239566Z] Running download-and-extract step. 12:47:05 INFO - Running pre-action listener: _resource_record_pre_action 12:47:05 INFO - Running main action method: download_and_extract 12:47:05 INFO - mkdir: /builds/slave/test/build/tests 12: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')]} 12:47:05 INFO - trying https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:47:05 INFO - Downloading https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 12:47:06 INFO - Downloaded 1325 bytes. 12:47:06 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:47:06 INFO - Using the following test package requirements: 12:47:06 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:47:06 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:47:06 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:47:06 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:47:06 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'jsshell-mac.zip'], 12:47:06 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:47:06 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:47:06 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:47:06 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:47:06 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:47:06 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:47:06 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:47:06 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:47:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:47:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:47:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:47:08 INFO - Expected file size: 52522618 12:47:08 INFO - Obtained file size: 52522618 12:47:24 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:47:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:47:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:47:24 INFO - Fetch https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:47:26 INFO - Expected file size: 52522618 12:47:26 INFO - Obtained file size: 52522618 12:47:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:47:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:47:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:47:42 INFO - Expected file size: 14408811 12:47:42 INFO - Obtained file size: 14408811 12:47: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')]} 12:47:42 INFO - trying https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:47:42 INFO - Downloading https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 12:47:45 INFO - Downloaded 71025445 bytes. 12:47:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:47:45 INFO - mkdir: /builds/slave/test/properties 12:47:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:47:45 INFO - Writing to file /builds/slave/test/properties/build_url 12:47:45 INFO - Contents: 12:47:45 INFO - build_url:https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:47:46 INFO - Running post-action listener: _resource_record_post_action 12:47:46 INFO - Running post-action listener: set_extra_try_arguments 12:47:46 INFO - [mozharness: 2017-04-21 19:47:46.794288Z] Finished download-and-extract step (success) 12:47:46 INFO - [mozharness: 2017-04-21 19:47:46.794412Z] Running populate-webroot step. 12:47:46 INFO - Running pre-action listener: _resource_record_pre_action 12:47:46 INFO - Running main action method: populate_webroot 12:47:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:47:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:47:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:47:46 INFO - '--tppagecycles', 12:47:46 INFO - '7'], 12:47:46 INFO - 'tests': ['tsvgm']}}, 12:47:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:47:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:47:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:47:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:47:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:47:46 INFO - 'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:47:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:47:46 INFO - 'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['damp', 'tps']}, 12:47:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:47:46 INFO - 'tests': ['damp', 'tps']}, 12:47:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['dromaeo_dom']}, 12:47:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:47:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:47:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:47:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['a11yr', 12:47:46 INFO - 'ts_paint', 12:47:46 INFO - 'tpaint', 12:47:46 INFO - 'sessionrestore', 12:47:46 INFO - 'sessionrestore_no_auto_restore', 12:47:46 INFO - 'tabpaint']}, 12:47:46 INFO - 'other-e10s': {'tests': ['a11yr', 12:47:46 INFO - 'ts_paint', 12:47:46 INFO - 'tpaint', 12:47:46 INFO - 'sessionrestore', 12:47:46 INFO - 'sessionrestore_no_auto_restore', 12:47:46 INFO - 'tabpaint']}, 12:47:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:47:46 INFO - 'ts_paint', 12:47:46 INFO - 'tpaint', 12:47:46 INFO - 'sessionrestore', 12:47:46 INFO - 'sessionrestore_no_auto_restore', 12:47:46 INFO - 'tabpaint']}, 12:47:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:47:46 INFO - 'ts_paint', 12:47:46 INFO - 'tpaint', 12:47:46 INFO - 'sessionrestore', 12:47:46 INFO - 'sessionrestore_no_auto_restore', 12:47:46 INFO - 'tabpaint']}, 12:47:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['a11yr', 12:47:46 INFO - 'ts_paint', 12:47:46 INFO - 'tpaint', 12:47:46 INFO - 'sessionrestore', 12:47:46 INFO - 'sessionrestore_no_auto_restore', 12:47:46 INFO - 'tabpaint']}, 12:47:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['a11yr', 12:47:46 INFO - 'ts_paint', 12:47:46 INFO - 'tpaint', 12:47:46 INFO - 'sessionrestore', 12:47:46 INFO - 'sessionrestore_no_auto_restore', 12:47:46 INFO - 'tabpaint']}, 12:47:46 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:47:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:47:46 INFO - 'bloom_basic_ref']}, 12:47:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['tsvgx', 12:47:46 INFO - 'tsvgr_opacity', 12:47:46 INFO - 'tart', 12:47:46 INFO - 'tscrollx', 12:47:46 INFO - 'cart', 12:47:46 INFO - 'tsvg_static']}, 12:47:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:47:46 INFO - 'tsvgr_opacity', 12:47:46 INFO - 'tart', 12:47:46 INFO - 'tscrollx', 12:47:46 INFO - 'cart', 12:47:46 INFO - 'tsvg_static']}, 12:47:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:47:46 INFO - 'talos_options': ['--disable-e10s'], 12:47:46 INFO - 'tests': ['tp5o']}, 12:47:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:47:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:47:46 INFO - 'talos_options': ['--disable-e10s', 12:47:46 INFO - '--xperf_path', 12:47:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:46 INFO - 'tests': ['tp5n']}, 12:47:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:47:46 INFO - 'talos_options': ['--xperf_path', 12:47:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:46 INFO - 'tests': ['tp5n']}}, 12:47:46 INFO - 'talos.zip': {'path': '', 12:47:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:47:46 INFO - Running post-action listener: _resource_record_post_action 12:47:46 INFO - [mozharness: 2017-04-21 19:47:46.813711Z] Finished populate-webroot step (success) 12:47:46 INFO - [mozharness: 2017-04-21 19:47:46.813848Z] Running create-virtualenv step. 12:47:46 INFO - Running pre-action listener: _resource_record_pre_action 12:47:46 INFO - Running main action method: create_virtualenv 12:47:46 INFO - Creating virtualenv /builds/slave/test/build/venv 12:47:46 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 12:47:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:47:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:47:46 INFO - Using real prefix '/tools/python27' 12:47:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:47:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:47:50 INFO - Installing pip.................done. 12:47:50 INFO - Return code: 0 12:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:47:50 INFO - Reading from file tmpfile_stdout 12:47:50 INFO - Output received: 12:47:50 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) 12:47:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:47:50 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')]} 12:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:50 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')]} 12:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:50 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:47:50 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 12:47:50 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 12:47:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:47:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:50 INFO - 'HOME': '/Users/cltbld', 12:47:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:50 INFO - 'LOGNAME': 'cltbld', 12:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:50 INFO - 'MOZ_NO_REMOTE': '1', 12:47:50 INFO - 'NO_EM_RESTART': '1', 12:47:50 INFO - 'PAGER': '/bin/cat', 12:47:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:50 INFO - 'PWD': '/builds/slave/test', 12:47:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:50 INFO - 'SHELL': '/bin/bash', 12:47:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:47:50 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:47:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:50 INFO - 'USER': 'cltbld', 12:47:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:50 INFO - 'XPC_FLAGS': '0x0', 12:47:50 INFO - 'XPC_SERVICE_NAME': '0', 12:47:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:51 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 12:47:51 INFO - Cleaning up... 12:47:51 INFO - Return code: 0 12:47:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:51 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:47:51 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 12:47:51 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 12:47:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:47:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:51 INFO - 'HOME': '/Users/cltbld', 12:47:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:51 INFO - 'LOGNAME': 'cltbld', 12:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:51 INFO - 'MOZ_NO_REMOTE': '1', 12:47:51 INFO - 'NO_EM_RESTART': '1', 12:47:51 INFO - 'PAGER': '/bin/cat', 12:47:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:51 INFO - 'PWD': '/builds/slave/test', 12:47:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:51 INFO - 'SHELL': '/bin/bash', 12:47:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:47:51 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:47:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:51 INFO - 'USER': 'cltbld', 12:47:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:51 INFO - 'XPC_FLAGS': '0x0', 12:47:51 INFO - 'XPC_SERVICE_NAME': '0', 12:47:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:51 INFO - Downloading/unpacking psutil>=3.1.1 12:47:51 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 12:47:51 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 12:47:51 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 12:47:51 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 12:47:51 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 12:47:51 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 12:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:54 INFO - Installing collected packages: psutil 12:47:54 INFO - Running setup.py install for psutil 12:47:55 INFO - building 'psutil._psutil_osx' extension 12:47:55 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 12:47:55 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 12:47:55 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 12:47:55 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 12:47:55 INFO - building 'psutil._psutil_posix' extension 12:47:55 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 12:47:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:47:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:47:55 INFO - ^ 12:47:56 INFO - 1 warning generated. 12:47:56 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 12:47:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:56 INFO - Successfully installed psutil 12:47:56 INFO - Cleaning up... 12:47:56 INFO - Return code: 0 12:47:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:47:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:47:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:56 INFO - 'HOME': '/Users/cltbld', 12:47:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:56 INFO - 'LOGNAME': 'cltbld', 12:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:56 INFO - 'MOZ_NO_REMOTE': '1', 12:47:56 INFO - 'NO_EM_RESTART': '1', 12:47:56 INFO - 'PAGER': '/bin/cat', 12:47:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:56 INFO - 'PWD': '/builds/slave/test', 12:47:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:56 INFO - 'SHELL': '/bin/bash', 12:47:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:47:56 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:47:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:56 INFO - 'USER': 'cltbld', 12:47:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:56 INFO - 'XPC_FLAGS': '0x0', 12:47:56 INFO - 'XPC_SERVICE_NAME': '0', 12:47:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:47:59 INFO - Installing collected packages: mozsystemmonitor 12:47:59 INFO - Running setup.py install for mozsystemmonitor 12:47:59 INFO - Successfully installed mozsystemmonitor 12:47:59 INFO - Cleaning up... 12:47:59 INFO - Return code: 0 12:47:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:47: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')]} 12:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:00 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')]} 12:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:00 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:48:00 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 12:48:00 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 12:48:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:48:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:00 INFO - 'HOME': '/Users/cltbld', 12:48:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:00 INFO - 'LOGNAME': 'cltbld', 12:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:00 INFO - 'MOZ_NO_REMOTE': '1', 12:48:00 INFO - 'NO_EM_RESTART': '1', 12:48:00 INFO - 'PAGER': '/bin/cat', 12:48:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:00 INFO - 'PWD': '/builds/slave/test', 12:48:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:00 INFO - 'SHELL': '/bin/bash', 12:48:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:48:00 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:48:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:00 INFO - 'USER': 'cltbld', 12:48:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:00 INFO - 'XPC_FLAGS': '0x0', 12:48:00 INFO - 'XPC_SERVICE_NAME': '0', 12:48:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:00 INFO - Downloading/unpacking jsonschema==2.5.1 12:48:00 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 12:48:00 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 12:48:00 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 12:48:00 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 12:48:00 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 12:48:00 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 12:48:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:48:03 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 12:48:03 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 12:48:03 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 12:48:03 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 12:48:03 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 12:48:03 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 12:48:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:03 INFO - warning: no files found matching '*.txt' 12:48:03 INFO - no previously-included directories found matching 'build' 12:48:03 INFO - no previously-included directories found matching 'dist' 12:48:03 INFO - no previously-included directories found matching '.git*' 12:48:03 INFO - Installing collected packages: jsonschema, functools32 12:48:03 INFO - Running setup.py install for functools32 12:48:03 INFO - warning: no files found matching '*.txt' 12:48:03 INFO - no previously-included directories found matching 'build' 12:48:03 INFO - no previously-included directories found matching 'dist' 12:48:03 INFO - no previously-included directories found matching '.git*' 12:48:03 INFO - Successfully installed jsonschema functools32 12:48:03 INFO - Cleaning up... 12:48:03 INFO - Return code: 0 12:48:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:48:03 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')]} 12:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:03 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')]} 12:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:03 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:48:03 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 12:48:03 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 12:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:03 INFO - 'HOME': '/Users/cltbld', 12:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:03 INFO - 'LOGNAME': 'cltbld', 12:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:03 INFO - 'MOZ_NO_REMOTE': '1', 12:48:03 INFO - 'NO_EM_RESTART': '1', 12:48:03 INFO - 'PAGER': '/bin/cat', 12:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:03 INFO - 'PWD': '/builds/slave/test', 12:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:03 INFO - 'SHELL': '/bin/bash', 12:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:48:03 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:03 INFO - 'USER': 'cltbld', 12:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:03 INFO - 'XPC_FLAGS': '0x0', 12:48:03 INFO - 'XPC_SERVICE_NAME': '0', 12:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:48:04 INFO - Cleaning up... 12:48:04 INFO - Return code: 0 12:48:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:04 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:48:04 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 12:48:04 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 12:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:04 INFO - 'HOME': '/Users/cltbld', 12:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:04 INFO - 'LOGNAME': 'cltbld', 12:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:04 INFO - 'MOZ_NO_REMOTE': '1', 12:48:04 INFO - 'NO_EM_RESTART': '1', 12:48:04 INFO - 'PAGER': '/bin/cat', 12:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:04 INFO - 'PWD': '/builds/slave/test', 12:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:04 INFO - 'SHELL': '/bin/bash', 12:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:48:04 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:04 INFO - 'USER': 'cltbld', 12:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:04 INFO - 'XPC_FLAGS': '0x0', 12:48:04 INFO - 'XPC_SERVICE_NAME': '0', 12:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:04 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 12:48:04 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 12:48:04 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 12:48:04 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 12:48:04 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 12:48:04 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 12:48:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:07 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 12:48:07 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 12:48:07 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 12:48:07 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 12:48:07 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 12:48:07 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 12:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:07 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 12:48:07 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 12:48:07 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 12:48:07 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 12:48:07 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 12:48:07 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 12:48:08 INFO - Downloading docopt-0.6.1.tar.gz 12:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:08 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:08 INFO - Running setup.py install for blobuploader 12:48:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:08 INFO - Running setup.py install for requests 12:48:09 INFO - Running setup.py install for docopt 12:48:09 INFO - Successfully installed blobuploader requests docopt 12:48:09 INFO - Cleaning up... 12:48:09 INFO - Return code: 0 12:48:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:09 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')]} 12:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:09 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')]} 12:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:09 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:48:09 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 12:48:09 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 12:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:09 INFO - 'HOME': '/Users/cltbld', 12:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:09 INFO - 'LOGNAME': 'cltbld', 12:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:09 INFO - 'MOZ_NO_REMOTE': '1', 12:48:09 INFO - 'NO_EM_RESTART': '1', 12:48:09 INFO - 'PAGER': '/bin/cat', 12:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:09 INFO - 'PWD': '/builds/slave/test', 12:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:09 INFO - 'SHELL': '/bin/bash', 12:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:48:09 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:09 INFO - 'USER': 'cltbld', 12:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:09 INFO - 'XPC_FLAGS': '0x0', 12:48:09 INFO - 'XPC_SERVICE_NAME': '0', 12:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:09 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-R9IEoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:09 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-FpwxLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:09 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-0nF2_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:09 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-weEkNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-Y9p275-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-81RNx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-D6aalq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-OrjVL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-669i2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-LCLwjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-qeglj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-gznCdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-qvIGW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:10 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-2FxMit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:11 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-1kAdVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:11 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-tHr4Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:11 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-cKNt58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:11 INFO - Running setup.py install for manifestparser 12:48:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:11 INFO - Running setup.py install for mozcrash 12:48:11 INFO - Running setup.py install for mozdebug 12:48:11 INFO - Running setup.py install for mozdevice 12:48:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:11 INFO - Running setup.py install for mozfile 12:48:12 INFO - Running setup.py install for mozhttpd 12:48:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:12 INFO - Running setup.py install for mozinfo 12:48:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:12 INFO - Running setup.py install for mozInstall 12:48:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:12 INFO - Running setup.py install for mozleak 12:48:12 INFO - Running setup.py install for mozlog 12:48:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:12 INFO - Running setup.py install for moznetwork 12:48:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:12 INFO - Running setup.py install for mozprocess 12:48:13 INFO - Running setup.py install for mozprofile 12:48:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:13 INFO - Running setup.py install for mozrunner 12:48:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:13 INFO - Running setup.py install for mozscreenshot 12:48:13 INFO - Running setup.py install for moztest 12:48:13 INFO - Running setup.py install for mozversion 12:48:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:13 INFO - Cleaning up... 12:48:13 INFO - Return code: 0 12:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:13 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')]} 12:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:13 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')]} 12:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:13 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:48:13 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 12:48:13 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 12:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:13 INFO - 'HOME': '/Users/cltbld', 12:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:13 INFO - 'LOGNAME': 'cltbld', 12:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:13 INFO - 'MOZ_NO_REMOTE': '1', 12:48:13 INFO - 'NO_EM_RESTART': '1', 12:48:13 INFO - 'PAGER': '/bin/cat', 12:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:13 INFO - 'PWD': '/builds/slave/test', 12:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:13 INFO - 'SHELL': '/bin/bash', 12:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:48:13 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:13 INFO - 'USER': 'cltbld', 12:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:13 INFO - 'XPC_FLAGS': '0x0', 12:48:13 INFO - 'XPC_SERVICE_NAME': '0', 12:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:14 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-T5g9mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:14 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)) 12:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:14 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-F_2E24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:14 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)) 12:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:14 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-Q274Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:14 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)) 12:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:14 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-9VutY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 12:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:14 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-qlphHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:14 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)) 12:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:14 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-D3tTJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:14 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)) 12:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:14 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-Hgp3_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:14 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)) 12:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:14 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-rYP4jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:15 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-n4QTzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:15 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-5iqJc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:15 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-N98LS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:15 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-9Rik4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-XpeXBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:15 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-19cGpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:15 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-f8RkzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:15 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-u__HiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:15 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)) 12:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:15 INFO - Running setup.py (path:/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/pip-e2CSkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:15 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)) 12:48:15 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)) 12:48:15 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)) 12:48:15 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)) 12:48:15 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:48:15 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:48:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48:15 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 12:48:15 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 12:48:15 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 12:48:15 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 12:48:15 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 12:48:15 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 12:48:18 INFO - Downloading blessings-1.6.tar.gz 12:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:18 INFO - Installing collected packages: blessings 12:48:18 INFO - Running setup.py install for blessings 12:48:18 INFO - Successfully installed blessings 12:48:18 INFO - Cleaning up... 12:48:18 INFO - Return code: 0 12:48:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:19 INFO - Reading from file tmpfile_stdout 12:48:19 INFO - Current package versions: 12:48:19 INFO - blessings == 1.6 12:48:19 INFO - blobuploader == 1.2.4 12:48:19 INFO - docopt == 0.6.1 12:48:19 INFO - functools32 == 3.2.3-2 12:48:19 INFO - jsonschema == 2.5.1 12:48:19 INFO - manifestparser == 1.1 12:48:19 INFO - mozInstall == 1.12 12:48:19 INFO - mozcrash == 1.0 12:48:19 INFO - mozdebug == 0.1 12:48:19 INFO - mozdevice == 0.50 12:48:19 INFO - mozfile == 1.2 12:48:19 INFO - mozhttpd == 0.7 12:48:19 INFO - mozinfo == 0.9 12:48:19 INFO - mozleak == 0.1 12:48:19 INFO - mozlog == 3.4 12:48:19 INFO - moznetwork == 0.27 12:48:19 INFO - mozprocess == 0.25 12:48:19 INFO - mozprofile == 0.28 12:48:19 INFO - mozrunner == 6.13 12:48:19 INFO - mozscreenshot == 0.1 12:48:19 INFO - mozsystemmonitor == 0.3 12:48:19 INFO - moztest == 0.8 12:48:19 INFO - mozversion == 1.4 12:48:19 INFO - psutil == 3.1.1 12:48:19 INFO - requests == 1.2.3 12:48:19 INFO - wsgiref == 0.1.2 12:48:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:19 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')]} 12:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:19 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')]} 12:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:19 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:48:19 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 12:48:19 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 12:48:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:48:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:19 INFO - 'HOME': '/Users/cltbld', 12:48:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:19 INFO - 'LOGNAME': 'cltbld', 12:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:19 INFO - 'MOZ_NO_REMOTE': '1', 12:48:19 INFO - 'NO_EM_RESTART': '1', 12:48:19 INFO - 'PAGER': '/bin/cat', 12:48:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:19 INFO - 'PWD': '/builds/slave/test', 12:48:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:19 INFO - 'SHELL': '/bin/bash', 12:48:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:48:19 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:48:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:19 INFO - 'USER': 'cltbld', 12:48:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:19 INFO - 'XPC_FLAGS': '0x0', 12:48:19 INFO - 'XPC_SERVICE_NAME': '0', 12:48:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 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)) 12:48:19 INFO - Cleaning up... 12:48:19 INFO - Return code: 0 12:48:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:48:19 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')]} 12:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:19 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')]} 12:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:19 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 0x1083acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe461c77260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, '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.PdABtlJtrg/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.bmqcltvmzQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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 12:48:19 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 12:48:19 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 12:48:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:48:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:19 INFO - 'HOME': '/Users/cltbld', 12:48:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:19 INFO - 'LOGNAME': 'cltbld', 12:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:19 INFO - 'MOZ_NO_REMOTE': '1', 12:48:19 INFO - 'NO_EM_RESTART': '1', 12:48:19 INFO - 'PAGER': '/bin/cat', 12:48:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:19 INFO - 'PWD': '/builds/slave/test', 12:48:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:19 INFO - 'SHELL': '/bin/bash', 12:48:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:48:19 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:48:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:19 INFO - 'USER': 'cltbld', 12:48:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:19 INFO - 'XPC_FLAGS': '0x0', 12:48:19 INFO - 'XPC_SERVICE_NAME': '0', 12:48:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:48:19 INFO - Cleaning up... 12:48:19 INFO - Return code: 0 12:48:19 INFO - Running post-action listener: _resource_record_post_action 12:48:19 INFO - Running post-action listener: _start_resource_monitoring 12:48:19 INFO - Starting resource monitoring. 12:48:19 INFO - [mozharness: 2017-04-21 19:48:19.751892Z] Finished create-virtualenv step (success) 12:48:19 INFO - [mozharness: 2017-04-21 19:48:19.752824Z] Running install step. 12:48:19 INFO - Running pre-action listener: _resource_record_pre_action 12:48:19 INFO - Running main action method: install 12:48:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:20 INFO - Reading from file tmpfile_stdout 12:48:20 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:20 INFO - Reading from file tmpfile_stdout 12:48:20 INFO - Output received: 12:48:20 INFO - Usage: mozinstall [options] installer 12:48:20 INFO - Options: 12:48:20 INFO - -h, --help show this help message and exit 12:48:20 INFO - -d DEST, --destination=DEST 12:48:20 INFO - Directory to install application into. [default: 12:48:20 INFO - "/builds/slave/test"] 12:48:20 INFO - --app=APP Application being installed. [default: firefox] 12:48:20 INFO - mkdir: /builds/slave/test/build/application 12:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:48:40 INFO - Reading from file tmpfile_stdout 12:48:40 INFO - Output received: 12:48:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:48:40 INFO - Running post-action listener: _resource_record_post_action 12:48:40 INFO - [mozharness: 2017-04-21 19:48:40.127195Z] Finished install step (success) 12:48:40 INFO - [mozharness: 2017-04-21 19:48:40.127325Z] Running run-tests step. 12:48:40 INFO - Running pre-action listener: _resource_record_pre_action 12:48:40 INFO - Running main action method: run_tests 12:48:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:48:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:48:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:48:40 INFO - 2017-04-21 12:48:40.141 screenresolution[1621:7329] starting screenresolution argv=screenresolution get 12:48:40 INFO - 2017-04-21 12:48:40.144 screenresolution[1621:7329] Display 0: 1600x1200x32@60 12:48:40 INFO - 2017-04-21 12:48:40.150 screenresolution[1622:7332] starting screenresolution argv=screenresolution list 12:48:40 INFO - Available Modes on Display 0 12:48:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:48:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:48:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:48:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:48:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:48:40 INFO - Intel Iris: 12:48:40 INFO - Chipset Model: Intel Iris 12:48:40 INFO - Type: GPU 12:48:40 INFO - Bus: Built-In 12:48:40 INFO - VRAM (Dynamic, Max): 1536 MB 12:48:40 INFO - Vendor: Intel (0x8086) 12:48:40 INFO - Device ID: 0x0a2e 12:48:40 INFO - Revision ID: 0x0009 12:48:40 INFO - Displays: 12:48:40 INFO - Display: 12:48:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:48:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:48:40 INFO - Display Serial Number: 1600x1200 60 12:48:40 INFO - Main Display: Yes 12:48:40 INFO - Mirror: Off 12:48:40 INFO - Online: Yes 12:48:40 INFO - Rotation: Supported 12:48:40 INFO - Return code: 0 12:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:48:40 INFO - Python 2.7.3 12:48:40 INFO - Return code: 0 12:48:40 INFO - grabbing minidump binary from tooltool 12:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:40 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 0x10818ad30>, '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 0x1080b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10817fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:48:40 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 12:48:40 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 12:48:40 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 12:48:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:48:40 INFO - Return code: 0 12:48:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:48:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:48:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:48:40 INFO - ENV: RUST_BACKTRACE is now 1 12:48:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:48:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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 12:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --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 12:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PdABtlJtrg/Render', 12:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:40 INFO - 'HOME': '/Users/cltbld', 12:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:40 INFO - 'LOGNAME': 'cltbld', 12:48:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:48:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:40 INFO - 'MOZ_NO_REMOTE': '1', 12:48:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:48:40 INFO - 'NO_EM_RESTART': '1', 12:48:40 INFO - 'PAGER': '/bin/cat', 12:48:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:40 INFO - 'PWD': '/builds/slave/test', 12:48:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:40 INFO - 'RUST_BACKTRACE': '1', 12:48:40 INFO - 'SHELL': '/bin/bash', 12:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bmqcltvmzQ/Listeners', 12:48:40 INFO - 'TMPDIR': '/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/', 12:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:40 INFO - 'USER': 'cltbld', 12:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:40 INFO - 'XPC_FLAGS': '0x0', 12:48:40 INFO - 'XPC_SERVICE_NAME': '0', 12:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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 12:48:40 INFO - mozversion application_buildid: 20170421112620 12:48:40 INFO - mozversion application_changeset: ff6abe20041933a67f636b748ed698e9616a6833 12:48:40 INFO - mozversion application_display_name: Nightly 12:48:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:48:40 INFO - mozversion application_name: Firefox 12:48:40 INFO - mozversion application_remotingname: firefox 12:48:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:48:40 INFO - mozversion application_vendor: Mozilla 12:48:40 INFO - mozversion application_version: 55.0a1 12:48:40 INFO - mozversion platform_buildid: 20170421112620 12:48:40 INFO - mozversion platform_changeset: ff6abe20041933a67f636b748ed698e9616a6833 12:48:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:48:40 INFO - mozversion platform_version: 55.0a1 12:48:40 INFO - using testdate: 1492804120 12:48:40 INFO - actual date: 1492804120 12:48:40 INFO - starting webserver on 'localhost:49235' 12:48:40 INFO - SUITE-START | Running 2 tests 12:48:40 INFO - TEST-START | dromaeo_css 12:48:40 INFO - operating with platform_type : mac_ 12:48:40 INFO - Initialising browser for dromaeo_css test... 12:48:40 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/tmpSySysS/profile http://localhost:49235/getInfo.html) 12:48:43 INFO - PID 1632 | __metrics Screen width/height:1600/1200 12:48:43 INFO - PID 1632 | colorDepth:24 12:48:43 INFO - PID 1632 | Browser inner width/height: 1024/689 12:48:43 INFO - PID 1632 | __metrics 12:48:43 INFO - PID 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:48:43 INFO - PID 1632 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:48:44 INFO - TEST-INFO | 1632: exit 0 12:48:44 INFO - Browser initialized. 12:48:44 INFO - Running cycle 1/1 for dromaeo_css test... 12:48:44 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/tmpSySysS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:56 INFO - PID 1634 | RSS: Main: 234041344 12:48:56 INFO - PID 1634 | 12:52:02 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 12:52:03 INFO - PID 1634 | RSS: Main: 415252480 12:52:03 INFO - PID 1634 | 12:53:46 INFO - PID 1634 | ************************* 12:53:46 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 12:53:46 INFO - PID 1634 | 12:53:46 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:53:46 INFO - PID 1634 | Full stack: 12:53:46 INFO - PID 1634 | ************************* 12:53:46 INFO - PID 1634 | ************************* 12:53:46 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 12:53:46 INFO - PID 1634 | 12:53:46 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:53:46 INFO - PID 1634 | Full stack: 12:53:46 INFO - PID 1634 | ************************* 12:53:46 INFO - PID 1634 | ************************* 12:53:46 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 12:53:46 INFO - PID 1634 | 12:53:46 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:53:46 INFO - PID 1634 | Full stack: 12:53:46 INFO - PID 1634 | ************************* 12:53:46 INFO - PID 1634 | ************************* 12:53:46 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 12:53:46 INFO - PID 1634 | 12:53:46 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:53:46 INFO - PID 1634 | Full stack: 12:53:46 INFO - PID 1634 | ************************* 12:55:06 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 12:55:07 INFO - PID 1634 | RSS: Main: 372011008 12:55:07 INFO - PID 1634 | 12:58:09 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 12:58:09 INFO - PID 1634 | RSS: Main: 336130048 12:58:09 INFO - PID 1634 | 13:01:12 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 13:01:12 INFO - PID 1634 | RSS: Main: 361504768 13:01:12 INFO - PID 1634 | 13:04:16 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 13:04:17 INFO - PID 1634 | RSS: Main: 329289728 13:04:17 INFO - PID 1634 | 13:07:19 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 13:07:20 INFO - PID 1634 | RSS: Main: 375730176 13:07:20 INFO - PID 1634 | 13:07:20 INFO - PID 1634 | __start_tp_report 13:07:20 INFO - PID 1634 | _x_x_mozilla_page_load 13:07:20 INFO - PID 1634 | _x_x_mozilla_page_load_details 13:07:20 INFO - PID 1634 | |i|pagename|runs| 13:07:20 INFO - PID 1634 | |0;dojo.html;3524.5065690803285;3524.8413821378035;3552.5026496290507;3560.7329450291218;3584.4623306504022;5981.730822113004;6131.988406491158;6179.443850053489;6197.287311959126;6239.750409983601;6113.658745237698;6124.663143527116;6204.6587437690905;6210.875782484348;6219.129321894939;5208.401033881095;5311.654742441749;5351.812686555972;5380.91928621071;5487.039768040597;4500.369948207253;5465.644733092357;5478.424765399635;5484.506394424501;5489.972550137264;5253.185756207794;5323.627346085776;5328.786848526054;5341.172118321628;5402.35171779389;5292.338457692788;5306.92039619406;5314.760835762361;5329.147336426153;5335.519803217729;5251.474852514718;5283.656562323476;5296.073187192226;5305.602079844027;5308.336457942757;6070.939290607082;6070.939290607082;6095.146679464879;6099.573029887865;6101.298350689639;6354.23749150105;6356.4279214870885;6370.108184854124;6376.585521941105;6389.680515974229;5554.50009499147;6545.509086818508;6558.540902136852;6641;6647.93352066478;6195.4424101831055;6221.129041934133;6236.376362363772;6237.469815065725;6252.374762523802;6524.575902566413;6760.7633732820095;6766.49251306154;6772.11962444879;6786.049953006583;6338.904916426165;6382.425581697669;6434.9678251609375;6447.4197322241225;6452.548321617535;6615.106960560359;6628.801135965929;6630.303818099127;6640.269570347258;6641.302663220389;6520.641364724891;6524.510661700391;6530.706118224692;6533.314002029813;6535.117759102461;6309.936900631027;6361.2048493938255;6381.521385895983;6442.838929026718;6457;5234.555062819703;5246.842594722164;5255;5268.394134674561;5296.25852380667;4596.655250856199;4636.142313671981;4640.443146822403;4644.651651126179;4658.813647454064;5992.221011268507;6108.083787431832;6117.143599896018;6221.875562488724;6234.407731265523;6334.1765570475545;6382.36176382358;6392.648404337806;6394.360563943662;6400.103985442041;6120.751898419022;6127.158986117706;6180.412860778219;6244.375562443719;6247.562670613104;5681.091025435993;5782.710864456761;5809.6223745457255;5821.155932389865;5829.329627092854;6788.422984046214;6849.34931181527;6858.417034552119;6878.449724021966;6880.105586273752;6404.327545607644;6475.352464753675;6479.51403644738;6637.6681165940545;6651.201855777338;6600.60396376219;6604.5046621502615;6615.206175259;6742.595444273359;6819.283975182733;6476.676166191766;6520.510961677988;6528.445082168069;6531.11829902957;6538.967305163444;6574.80275591733;6579.736810527525;6599.142111525471;6599.142111525663;6600.504962127764;6219.720112594853;6272.247330320209;6292.653904035322;6370.235571731422;6376.139221205263;6326;6333.809985700436;6370.458511026614;6371.617702937839;6373.936260637334;5208.775937654724;6233.127362169391;6280.277768056732;6282.528810339334;6286.088517165077;6237.28271248794;6296.433321000949;6390.7763228286785;6391.265004524354;6396.936030639634;6220.098085777628;6226.097215903578;6235.750569977332;6241.407066328691;6264.34224406449 13:07:20 INFO - PID 1634 | |1;ext.html;734.2547314475808;792.3898598079479;804.3645520039171;1111.766529028904;1125.881782412847;26306.185603087542;36105;36490.270194596094;36544.817275913614;36644.450333245026;38299;38665.806670966675;38681.80659096708;38734.06329683511;38760.61239387605;5970.820875373745;8229.83540329193;8404.747857564253;8415.158484151567;8428.578571071452;6036.2152920120325;6809.863802723942;8430.494170349768;8437.282830959375;8455.239028487435;8475.194856488655;8496.78758031048;8499.362547808909;8513.446625969324;8523.275521580674;8378.245957863792;8441.57792110392;8467.110953349902;8476;8477.576121193977;8115.8782618260775;8170.346372290202;8193.79515512111;8195.754127376129;8201.22088401601;34742.82628586841;34978.82510587456;34979.82510087433;35018.29963400743;35023.299534009435;3518.085297822559;3546.804925729084;3547.219611685425;3548.946765798515;3552.3250582389524;30473.390532189453;30514.84742576295;30584.38831223363;30593.541096883564;30668.38663226745;2623.3048242215827;2664.693560240578;3083.9691603083907;3126.218445388653;3138.3409484008384;207839;275232;275996.62001690065;276116;276142;47546.28680569794;47740.283895741595;47748.522514774406;47748.522514774406;47851.5214847854;49268;49389.25916111261;49436;49438.75280623574;49452.752736236085;13501.527446539323;13586.184828910296;13600.115992460458;13601.523946662017;13653.385597647932;9606.567704453317;11018.779624407467;11032.889671103347;11035.668929932115;11058.22592418523;10682.252242342962;10722.463876806129;10736.409497477558;10758.73103172427;10768.623098191525;4990.4011518618;5226.790928362823;5230;5235.214717792362;5243.842684719464;975.3757595139117;997.1275134257525;997.8802543694803;1029.902159294866;1040.095117247999;23777.16779912729;23889.044438222623;23976.40058998539;24018.87990560071;24023.27930162063;1088.1621151713296;1089.9891001090045;1124.9100071994221;1125.6960620632383;1130.6438471881495;12182.695432614255;12340.876591233973;12392;12413;12419.503219871285;304897;305022;305110.9488905127;305139;305512;52204.738976305634;52434.47565524296;52446;52510.424687259445;52514;1424.586869807765;1459.1391079263285;1511.6523199663918;1513.530805450314;1522.2540954932224;23377;23440.53118937646;23503.882480587486;23560.0575976959;23613.881930590236;36573.26853462969;36586.45120323251;36597.634023659426;36632.81683591565;36680;263908;264342;264429.20137186977;264610;265743;27081.916723331633;33668;33668.66331336655;33831.661683383834;34086.48870266898;43800.56199438092;43803.56196437995;43818.56181438272;43831.78084109559;43857.34213986857;28721;28981.98563050283;30342;30612;30633.693663063976;25608.10371636984;29766.404671906872;30653.540196896618;31078.844605776827;31122.755089796156;35678.64321356857;36717.44923826198;36743.897683068484;36752.52989880375;36898.44652330271;30107.698923011365;30546;30783.38433231278;30877.073687788503;31095.222619434695;19112.948787816804;22718.545629086995;23803.761962380155;24318.635220471355;24328.391790205387 13:07:20 INFO - PID 1634 | |2;jquery.html;388.66574745718697;412.25176305006414;425.31934632127314;449.09507342704444;460.6453031166;17287.48137555874;20934.89532552339;21002.159913603457;21289.467763305907;21589;22653.093876244973;22820.20129295475;22984.310470685865;23233.838308084614;23369.298921032354;6054.303755068179;6132.693365331726;6229;6305.527085468585;6352.809415717513;3690.1143725505954;3717.2937141942944;6211.0993905883615;6302.0861975013595;6314.810555683314;3722.5719042310075;3756.248750249947;3983.9601603984024;6354.078658594501;6416.871662566769;6180.845478863064;6193.659348735818;6273.404026617464;6341.52438567107;6345.650989195569;5540.889182216373;5562.666240025612;5571.526420254283;5575.2473416088715;5583.804566840141;26272.73727262722;26322.73677263222;26954.730452695418;27315.043973461034;27613.447731045268;2209.2046863129262;2244.7755224477423;2247.584196923558;2248.05581655705;2248.7638797926147;16880.577985550335;17900.91049544757;18115;18202.635947281113;18286.359977400727;2093.42430831521;2141.4432247615578;2159.0931808640407;2168.9240876569243;2170.3814412892407;164099;165698;166018.33981660148;166676;167342;9116.635334586676;11371.488283027284;12431.564895228623;12447.626571202698;12612.621621351374;16287.429939952044;16425.1787410629;16464.588385290463;16467.176641167895;16494.75257871133;8658.567071646392;8707;8727.825443491221;8832.205101540892;8880.023197448276;8131.349492040623;8145;8151.714689985822;8270.214329638675;8288.627011784483;6203.379662033851;7745.651445684957;7782.649780759766;7802.258785415376;7803.244270039309;2030.46192758919;2034.094827801614;2034.8473864460225;2035.6844689073218;2155.6874253233195;851.6841479913548;891.8038031633031;930.7905721212672;963.2631037256365;976.3604838830578;16365.67268654644;18529;20974.16103355849;21460.785392145877;21649.351037443834;945.3524335829978;969.2004096620317;995.7560397702464;1009.1422291052546;1010.6765834932897;10544.89102179567;10825.296355736851;10970.122390208764;10984.450777461096;10993.395363255098;476218;517075;522575;541296;542447;119725.80274197321;123045;128983.81178070405;130641;130938.34530827476;1093.9343639381502;1103.812351900179;1137.8236373362142;1138.732397886496;1143.9942800285946;16535.83464165391;16888.831111688727;17310.394136205174;17466.388676396266;17852;43951.78024109859;55971.72014139903;57972.71013645073;58019.709901450224;58850.411495884495;72230.63884680544;73699;74652.62673686814;74968;75546.8667969992;8862.778430539289;8905.287576993695;8970.551472426221;9044.457332559805;9059.954700226457;12778.87221127814;13873.4450621974;14129;14202.934779891757;14259.07316024455;11993.160478766402;12000.939995299968;12129;12334.50661973511;12467.93766031164;10965.203873012331;11397.715057123638;11518.136139789716;11583.76832463329;11638.010769084724;12140.332281724237;12195.634130976085;12329.93835030855;12390.194637348544;12431.440585173508;6661.666916654245;8787.384883058125;8873.511956842178;8903;8960.551972401223;11947.701307467383;11986.46060927243;12141.271523708252;12227.388630568614;12238.959688426583 13:07:20 INFO - PID 1634 | |3;mootools.html;1352.4657760184728;1460.451512111366;1480.9555713328605;1495.1552372909298;1495.842936491669;11131.443427828606;11656.475458604362;11666.125040621955;11667.2416292941;11668.35824029678;11239.83140252897;11682.591109311175;11683.532658693663;11691.12316576256;11740.82388764167;2516.1067820923536;2554.7572980566815;2559.4113353928606;2563.5641940870096;2563.782078523328;2101.191041449038;2395.425097976482;2476.962845557318;2539.6825396825398;2539.7079335876333;2012.7383440152832;2086.9060892259886;2091.7489901211875;2143.474848662072;2172.6089303925287;2389.8446600970883;2395.3053614451787;2396.5805983952737;2398.3884109552127;2400.3879010852206;2350.4828937633692;2387.85672859629;2388.4028992751814;2389.749076346993;2394.437307232799;11341.886581134166;11622.418879056098;11629.069674426026;11635.185537012412;11635.941820290844;6476.838079048014;6723.058771771955;6737.898931516032;6738;6745.224299205605;3665.798381089039;4186.518550366686;4245.87262382129;4368.606825385698;4374.103308821684;1193.3675152169365;1211.5093387178206;1217.111508598719;1236.2397125767677;1290.7483040807047;16499.09254990975;16597.585060373465;16598.00411975285;16615.50153495397;16637.33450661984;4569.954300456953;5410.513053825174;5664.291963504562;5669.40471250521;5714.200011998323;12171.634850954486;12189.146759726911;12212.023038156925;12220.083493737828;12233.755324893453;5388.272583201296;6557.344265573404;6559.983202603604;6564.409203171737;6564.704588293443;6053.636781793019;6096.207493025879;6202.472789812826;6279.058141278753;6319.052142178618;4491.618212451913;4637.837675681402;4667.9766601166775;4725.787339569728;4736.005438857878;1432.8495507971722;1473.101408141033;1474.4691910912063;1501.6621260216582;1507.0580886945659;676.864627074587;707.4340527577917;793.2543409195454;808.0707186735184;817.3502065857657;6283.842903927347;6668.999650052531;6761.763338283136;6898.344657257552;6926.238113807477;740.8997638506813;938.380668758616;942.6465075596651;946.2193690205607;949.886013678363;3350.6816852398983;4046.615571520701;4085.8774236772942;4111.650509706648;4200.915981680349;14053.718925621635;14813;14816.481423150139;14843;14844.183569903544;14213.50252741149;14682.926585367004;14710.117392956457;14736.705265894836;14740.926295368454;8251.257386835214;8480.44877083;8481.109483504144;8481.321494280442;8497.62066621347;6107.198376479038;6311.274203466476;6607.2071351438135;6635.971424429221;6940.583564985915;10635.94682026585;12818.294993775431;13178.934105329412;13242.271675057964;13320.666983325495;11392.25950313227;12173;13082.803757943448;13222.669433264246;13564.186148831102;9181.908180918372;9277.814443711222;9370;9430.952845236005;9460.858087128561;10443.94778026105;10537.42044187577;10547.156227501935;10549;10554.841677375;8877.822443550964;9002.099790021208;9063.501507416891;9132.49771262587;9165.312601554777;8819.955900220459;8855.73432797017;8930.508822014852;8939.240164586083;9003.099690030944;6673.165854268216;7886.960565197137;8020.318272946864;8042.557659328793;8056.27493525562;5895.115732640138;5912.46787789101;6007.399260074132;6099.908501372572;6138.416850399205;5921.851953701192;5932.406759324205;6065.60573562717;6123.418275263843;6238.095476156022 13:07:20 INFO - PID 1634 | |4;prototype.html;329.2361720807726;394.73355485047597;402.65975250913004;407.9653229475496;409.1918461039447;4540.9318860217045;5788.942110578893;5932.347441781406;5932.881342373155;5986.7305971231235;4747.406574178228;5594.944050559493;5637.802676906309;5680.431956804317;5782.074868021107;4442.378067070605;4515.503294637587;4533.5693109154745;4549.7725113744345;4552.4764652065105;3310;3672.4858519807117;3805.429185622151;4302.01053757636;4475.412701980464;3665.7433979621437;4448.555144485558;4452.688311818174;4469.854469854472;4499.1901457737595;4433.467983841943;4435.7338559686195;4443.688941774077;4467.151241264182;4470.552944705503;3341.8830340938193;4027.677785777131;4029.2747305485;4032.1532478179615;4073.144639625682;4893;5454.809081682161;5630.380658127644;5725.341585717654;5771.229809691372;4956.603471722254;5350.946490535084;5388.676679399209;5409.161579955114;5441.619086663935;5888.556249156595;6143;6297.527685423612;6305.495560355161;6310.747570097191;4519.796609152563;4531.957649740578;4538.071319689119;4539.909201815978;4552.453705555321;6572.14562106923;6575.56704019511;6658.400743933069;6659.3007734187695;6662.733490660319;3910.276598829226;4418.270985287391;4494.820207191741;4648.581627653527;4670.906581868344;4536.682432229778;4773.904521909542;4786.593139583105;4794.472608013186;4801.807927682854;5397.515683187076;5417.3770016447825;5434.755436005389;5438.320209973754;5441.863953401196;5197.506236907488;5223.451537588575;5955.970220148958;6256.718447669866;6285.748570057147;1451.3178805961181;1573.7875386822861;1574.740167872311;1591.9442819501262;1619.627485678277;953.6948176583566;1000.3997601439079;1033.5555711044324;1101.7410908436511;1141.8058929981923;4943.01139772047;5144.6655967362;5855.3851845556455;5879.735411906475;5888.970555147197;6007;6291.307956124822;6325.430711236011;6340.239171299474;6446.871062578723;4902.41171059468;5637.295338082739;5811.27359080115;5847.9415205848245;5988.461038506468;2956.704329567026;3319.8008119512906;3346.1300061983575;3348.179695974502;3370.3090866372827;5794.913076303858;5998.5003749062735;6663.86672266552;6673.564149085549;6683.832904177434;6220.040687183523;6490.902636460457;6535.248446428626;6556.27880933097;6557;6129.325774164839;6435.002574600944;6650.833729156713;6667.766628168088;6714.462842972551;5338.946610533845;6414.326495718069;6442.420182183626;6454;6493.480521558169;4984.476629953948;6352.968235158794;6381.840453988688;6390.028636683965;6390.265119511316;4941.604671626189;5757.5393968481585;6133.38666133401;6587.341265873374;6589.6705164740615;4294.29144191205;4318.611324980767;4326.2645350289895;4345.782710864507;4353.869383918487;5869.73800632866;5893.230181814541;6012.218411606463;6128.295246046761;6355.809325720235;5330.4957311072085;5571.526420254324;6183.721732521957;6185.505159587312;6198.132261483486;5409.810656626999;6166.475849552839;6180.721867516063;6189.288231853395;6192.969035154795;5180.6891586503425;5842.211301474246;5949.434803693643;6112.266528016667;6113.23584551931;5172.767225474788;6264.31092579825;6267.843303917256;6278.623282603058;6311.526635502264;4985.8005679772405;5264.605154613496;5656.632318899258;5794.652320860761;6133.9079913802225 13:07:20 INFO - PID 1634 | |5;yui.html;699.154023631406;852.7953291210109;858.3219256787138;859.0078459379415;872.9258013068891;12855.614331570056;17516.386926457562;17520.211590478426;18050.63898722028;18147.27410903564;16663;16814.747778783327;17126;17197.82802171978;17219.483415497525;896.995515022424;913.2511340700628;915.0437792506847;916.3173435790312;916.4363916191561;644.9258335291455;660.1517050589993;946.9952650236739;970.9708708738714;974.3861367338602;1009.7021378693303;1010.5705075342987;1010.9949450252739;1012.25093430861;1016.019541142797;1008.9394636321845;1008.9798204035878;1009.1220638044912;1011.3072545306416;1017.8015287019034;494.1327969413692;502.6431233823989;704.5385272646373;720.4416577152696;729.7117638532803;15689.68620627581;15710.214489275604;15759.369625214978;15770.369185232577;15830.920845395814;12192.81710774339;12591.748165036648;12842.229466232056;12869.67825804353;12897.67755806103;13931.721365572632;14368.06607570515;14499.275036248146;14558.670612701917;15232;3561.269939662363;3583.104223944014;3595.6404359564094;3598.748087633867;3600.981995090034;106349.46825265902;109923;110482.34276485779;112488.31267530912;112974;11080.5567777288;11253.381064041556;12547.749045019049;13008.739825203444;13021.869781302255;17770.822291777175;19618.509537261398;24762.804105265917;24816.255512334657;24981.25056248279;7296.343329100407;7500.137484189279;7612.276833700789;7621.695132194761;7626.122995855437;3676.963230367662;3738.420544815558;3743.2513497300647;3743.288775132716;3752.6810221130963;4270.7864606769535;4632.444106707217;4730.716157030521;4791.856244312607;4794.184988551954;825.3727167352855;940.351157701184;962.2013728605241;971.3394891473865;978.2320878110648;646.9256035555877;655.803259022301;658.7529676371361;665.3679004945321;674.9426298764562;9660.516974151406;9863.753406164904;10335.63825266127;10952.406939765706;11969.581064662694;629.263761399155;641.9646919419383;646.5312648330017;655.0436362910204;664.8703502817001;5252.527272545489;5341.679499230058;5387.838364849061;5411.369968344694;5661.971690141523;99477.00522994678;100461;101265.4810177848;102144.48927755313;105376;72447;91107.72230694153;92062.53968730247;92878;94552.05447945432;59001;72189;72906;74464.62767686127;81975;11857.229280096766;12039.819402709141;12237.143399961917;12289.631311060682;12290;37380.50477980959;38147.80926095463;38367.61632383752;39604;40003.79998099991;66463.33536664571;68384.97422538567;70528.64735676289;70937;72793.63603181951;15772.290246939145;16136.515904522883;16177.838221617632;16470.83529164741;16610.584735381228;17957.910210449387;18129.637407251517;18331.478758494806;18430.078496074875;18468;16398.344066237216;16518.587035324214;16714.247858846138;16729;16821.495355139366;16286.267117979482;16415.589610259838;16666.916665416597;16809.663806724042;16825.074620895968;15974.60063498422;16173.191340433166;16382.197958224824;16724.247408866875;16932.492025239262;11720.70698232551;11838.348890810743;12051.638450846489;12066;12179.147459677737;12701.872981270439;13469.461221551028;13605.523806666719;13644.317784110557;13872.514461993782 13:07:20 INFO - PID 1634 | __end_tp_report 13:07:20 INFO - PID 1634 | __start_cc_report 13:07:20 INFO - PID 1634 | _x_x_mozilla_cycle_collect,1809 13:07:20 INFO - PID 1634 | __end_cc_report 13:07:20 INFO - PID 1634 | __startTimestamp1492805240072__endTimestamp 13:07:20 INFO - PID 1634 | 13:07:20 INFO - PID 1634 | ------- Summary: start ------- 13:07:20 INFO - PID 1634 | Number of tests: 6 13:07:20 INFO - PID 1634 | 13:07:20 INFO - PID 1634 | [#0] dojo.html Cycles:165 Average:6031.56 Median:6247.56 stddev:697.88 (11.2%) stddev-sans-first:671.74 13:07:20 INFO - PID 1634 | Values: 3524.5 3524.8 3552.5 3560.7 3584.5 5981.7 6132.0 6179.4 6197.3 6239.8 6113.7 6124.7 6204.7 6210.9 6219.1 5208.4 5311.7 5351.8 5380.9 5487.0 4500.4 5465.6 5478.4 5484.5 5490.0 5253.2 5323.6 5328.8 5341.2 5402.4 5292.3 5306.9 5314.8 5329.1 5335.5 5251.5 5283.7 5296.1 5305.6 5308.3 6070.9 6070.9 6095.1 6099.6 6101.3 6354.2 6356.4 6370.1 6376.6 6389.7 5554.5 6545.5 6558.5 6641.0 6647.9 6195.4 6221.1 6236.4 6237.5 6252.4 6524.6 6760.8 6766.5 6772.1 6786.0 6338.9 6382.4 6435.0 6447.4 6452.5 6615.1 6628.8 6630.3 6640.3 6641.3 6520.6 6524.5 6530.7 6533.3 6535.1 6309.9 6361.2 6381.5 6442.8 6457.0 5234.6 5246.8 5255.0 5268.4 5296.3 4596.7 4636.1 4640.4 4644.7 4658.8 5992.2 6108.1 6117.1 6221.9 6234.4 6334.2 6382.4 6392.6 6394.4 6400.1 6120.8 6127.2 6180.4 6244.4 6247.6 5681.1 5782.7 5809.6 5821.2 5829.3 6788.4 6849.3 6858.4 6878.4 6880.1 6404.3 6475.4 6479.5 6637.7 6651.2 6600.6 6604.5 6615.2 6742.6 6819.3 6476.7 6520.5 6528.4 6531.1 6539.0 6574.8 6579.7 6599.1 6599.1 6600.5 6219.7 6272.2 6292.7 6370.2 6376.1 6326.0 6333.8 6370.5 6371.6 6373.9 5208.8 6233.1 6280.3 6282.5 6286.1 6237.3 6296.4 6390.8 6391.3 6396.9 6220.1 6226.1 6235.8 6241.4 6264.3 13:07:20 INFO - PID 1634 | 13:07:20 INFO - PID 1634 | [#1] ext.html Cycles:180 Average:42619.50 Median:33668.33 stddev:72957.22 (216.7%) stddev-sans-first:73094.11 13:07:20 INFO - PID 1634 | Values: 734.3 792.4 804.4 1111.8 1125.9 26306.2 36105.0 36490.3 36544.8 36644.5 38299.0 38665.8 38681.8 38734.1 38760.6 5970.8 8229.8 8404.7 8415.2 8428.6 6036.2 6809.9 8430.5 8437.3 8455.2 8475.2 8496.8 8499.4 8513.4 8523.3 8378.2 8441.6 8467.1 8476.0 8477.6 8115.9 8170.3 8193.8 8195.8 8201.2 34742.8 34978.8 34979.8 35018.3 35023.3 3518.1 3546.8 3547.2 3548.9 3552.3 30473.4 30514.8 30584.4 30593.5 30668.4 2623.3 2664.7 3084.0 3126.2 3138.3 207839.0 275232.0 275996.6 276116.0 276142.0 47546.3 47740.3 47748.5 47748.5 47851.5 49268.0 49389.3 49436.0 49438.8 49452.8 13501.5 13586.2 13600.1 13601.5 13653.4 9606.6 11018.8 11032.9 11035.7 11058.2 10682.3 10722.5 10736.4 10758.7 10768.6 4990.4 5226.8 5230.0 5235.2 5243.8 975.4 997.1 997.9 1029.9 1040.1 23777.2 23889.0 23976.4 24018.9 24023.3 1088.2 1090.0 1124.9 1125.7 1130.6 12182.7 12340.9 12392.0 12413.0 12419.5 304897.0 305022.0 305110.9 305139.0 305512.0 52204.7 52434.5 52446.0 52510.4 52514.0 1424.6 1459.1 1511.7 1513.5 1522.3 23377.0 23440.5 23503.9 23560.1 23613.9 36573.3 36586.5 36597.6 36632.8 36680.0 263908.0 264342.0 264429.2 264610.0 265743.0 27081.9 33668.0 33668.7 33831.7 34086.5 43800.6 43803.6 43818.6 43831.8 43857.3 28721.0 28982.0 30342.0 30612.0 30633.7 25608.1 29766.4 30653.5 31078.8 31122.8 35678.6 36717.4 36743.9 36752.5 36898.4 30107.7 30546.0 30783.4 30877.1 31095.2 19112.9 22718.5 23803.8 24318.6 24328.4 13:07:20 INFO - PID 1634 | 13:07:20 INFO - PID 1634 | [#2] jquery.html Cycles:180 Average:34654.63 Median:12450.93 stddev:89121.36 (715.8%) stddev-sans-first:89334.23 13:07:20 INFO - PID 1634 | Values: 388.7 412.3 425.3 449.1 460.6 17287.5 20934.9 21002.2 21289.5 21589.0 22653.1 22820.2 22984.3 23233.8 23369.3 6054.3 6132.7 6229.0 6305.5 6352.8 3690.1 3717.3 6211.1 6302.1 6314.8 3722.6 3756.2 3984.0 6354.1 6416.9 6180.8 6193.7 6273.4 6341.5 6345.7 5540.9 5562.7 5571.5 5575.2 5583.8 26272.7 26322.7 26954.7 27315.0 27613.4 2209.2 2244.8 2247.6 2248.1 2248.8 16880.6 17900.9 18115.0 18202.6 18286.4 2093.4 2141.4 2159.1 2168.9 2170.4 164099.0 165698.0 166018.3 166676.0 167342.0 9116.6 11371.5 12431.6 12447.6 12612.6 16287.4 16425.2 16464.6 16467.2 16494.8 8658.6 8707.0 8727.8 8832.2 8880.0 8131.3 8145.0 8151.7 8270.2 8288.6 6203.4 7745.7 7782.6 7802.3 7803.2 2030.5 2034.1 2034.8 2035.7 2155.7 851.7 891.8 930.8 963.3 976.4 16365.7 18529.0 20974.2 21460.8 21649.4 945.4 969.2 995.8 1009.1 1010.7 10544.9 10825.3 10970.1 10984.5 10993.4 476218.0 517075.0 522575.0 541296.0 542447.0 119725.8 123045.0 128983.8 130641.0 130938.3 1093.9 1103.8 1137.8 1138.7 1144.0 16535.8 16888.8 17310.4 17466.4 17852.0 43951.8 55971.7 57972.7 58019.7 58850.4 72230.6 73699.0 74652.6 74968.0 75546.9 8862.8 8905.3 8970.6 9044.5 9060.0 12778.9 13873.4 14129.0 14202.9 14259.1 11993.2 12000.9 12129.0 12334.5 12467.9 10965.2 11397.7 11518.1 11583.8 11638.0 12140.3 12195.6 12329.9 12390.2 12431.4 6661.7 8787.4 8873.5 8903.0 8960.6 11947.7 11986.5 12141.3 12227.4 12239.0 13:07:20 INFO - PID 1634 | 13:07:20 INFO - PID 1634 | [#3] mootools.html Cycles:180 Average:7014.04 Median:3508.24 stddev:4425.40 (126.1%) stddev-sans-first:4417.36 13:07:20 INFO - PID 1634 | Values: 1352.5 1460.5 1481.0 1495.2 1495.8 11131.4 11656.5 11666.1 11667.2 11668.4 11239.8 11682.6 11683.5 11691.1 11740.8 2516.1 2554.8 2559.4 2563.6 2563.8 2101.2 2395.4 2477.0 2539.7 2539.7 2012.7 2086.9 2091.7 2143.5 2172.6 2389.8 2395.3 2396.6 2398.4 2400.4 2350.5 2387.9 2388.4 2389.7 2394.4 11341.9 11622.4 11629.1 11635.2 11635.9 6476.8 6723.1 6737.9 6738.0 6745.2 3665.8 4186.5 4245.9 4368.6 4374.1 1193.4 1211.5 1217.1 1236.2 1290.7 16499.1 16597.6 16598.0 16615.5 16637.3 4570.0 5410.5 5664.3 5669.4 5714.2 12171.6 12189.1 12212.0 12220.1 12233.8 5388.3 6557.3 6560.0 6564.4 6564.7 6053.6 6096.2 6202.5 6279.1 6319.1 4491.6 4637.8 4668.0 4725.8 4736.0 1432.8 1473.1 1474.5 1501.7 1507.1 676.9 707.4 793.3 808.1 817.4 6283.8 6669.0 6761.8 6898.3 6926.2 740.9 938.4 942.6 946.2 949.9 3350.7 4046.6 4085.9 4111.7 4200.9 14053.7 14813.0 14816.5 14843.0 14844.2 14213.5 14682.9 14710.1 14736.7 14740.9 8251.3 8480.4 8481.1 8481.3 8497.6 6107.2 6311.3 6607.2 6636.0 6940.6 10635.9 12818.3 13178.9 13242.3 13320.7 11392.3 12173.0 13082.8 13222.7 13564.2 9181.9 9277.8 9370.0 9431.0 9460.9 10443.9 10537.4 10547.2 10549.0 10554.8 8877.8 9002.1 9063.5 9132.5 9165.3 8820.0 8855.7 8930.5 8939.2 9003.1 6673.2 7887.0 8020.3 8042.6 8056.3 5895.1 5912.5 6007.4 6099.9 6138.4 5921.9 5932.4 6065.6 6123.4 6238.1 13:07:20 INFO - PID 1634 | 13:07:20 INFO - PID 1634 | [#4] prototype.html Cycles:180 Average:5053.52 Median:5448.34 stddev:1521.98 (27.9%) stddev-sans-first:1484.37 13:07:20 INFO - PID 1634 | Values: 329.2 394.7 402.7 408.0 409.2 4540.9 5788.9 5932.3 5932.9 5986.7 4747.4 5594.9 5637.8 5680.4 5782.1 4442.4 4515.5 4533.6 4549.8 4552.5 3310.0 3672.5 3805.4 4302.0 4475.4 3665.7 4448.6 4452.7 4469.9 4499.2 4433.5 4435.7 4443.7 4467.2 4470.6 3341.9 4027.7 4029.3 4032.2 4073.1 4893.0 5454.8 5630.4 5725.3 5771.2 4956.6 5350.9 5388.7 5409.2 5441.6 5888.6 6143.0 6297.5 6305.5 6310.7 4519.8 4532.0 4538.1 4539.9 4552.5 6572.1 6575.6 6658.4 6659.3 6662.7 3910.3 4418.3 4494.8 4648.6 4670.9 4536.7 4773.9 4786.6 4794.5 4801.8 5397.5 5417.4 5434.8 5438.3 5441.9 5197.5 5223.5 5956.0 6256.7 6285.7 1451.3 1573.8 1574.7 1591.9 1619.6 953.7 1000.4 1033.6 1101.7 1141.8 4943.0 5144.7 5855.4 5879.7 5889.0 6007.0 6291.3 6325.4 6340.2 6446.9 4902.4 5637.3 5811.3 5847.9 5988.5 2956.7 3319.8 3346.1 3348.2 3370.3 5794.9 5998.5 6663.9 6673.6 6683.8 6220.0 6490.9 6535.2 6556.3 6557.0 6129.3 6435.0 6650.8 6667.8 6714.5 5338.9 6414.3 6442.4 6454.0 6493.5 4984.5 6353.0 6381.8 6390.0 6390.3 4941.6 5757.5 6133.4 6587.3 6589.7 4294.3 4318.6 4326.3 4345.8 4353.9 5869.7 5893.2 6012.2 6128.3 6355.8 5330.5 5571.5 6183.7 6185.5 6198.1 5409.8 6166.5 6180.7 6189.3 6193.0 5180.7 5842.2 5949.4 6112.3 6113.2 5172.8 6264.3 6267.8 6278.6 6311.5 4985.8 5264.6 5656.6 5794.7 6133.9 13:07:20 INFO - PID 1634 | 13:07:20 INFO - PID 1634 | [#5] yui.html Cycles:180 Average:21040.35 Median:18380.78 stddev:29032.06 (157.9%) stddev-sans-first:29073.32 13:07:20 INFO - PID 1634 | Values: 699.2 852.8 858.3 859.0 872.9 12855.6 17516.4 17520.2 18050.6 18147.3 16663.0 16814.7 17126.0 17197.8 17219.5 897.0 913.3 915.0 916.3 916.4 644.9 660.2 947.0 971.0 974.4 1009.7 1010.6 1011.0 1012.3 1016.0 1008.9 1009.0 1009.1 1011.3 1017.8 494.1 502.6 704.5 720.4 729.7 15689.7 15710.2 15759.4 15770.4 15830.9 12192.8 12591.7 12842.2 12869.7 12897.7 13931.7 14368.1 14499.3 14558.7 15232.0 3561.3 3583.1 3595.6 3598.7 3601.0 106349.5 109923.0 110482.3 112488.3 112974.0 11080.6 11253.4 12547.7 13008.7 13021.9 17770.8 19618.5 24762.8 24816.3 24981.3 7296.3 7500.1 7612.3 7621.7 7626.1 3677.0 3738.4 3743.3 3743.3 3752.7 4270.8 4632.4 4730.7 4791.9 4794.2 825.4 940.4 962.2 971.3 978.2 646.9 655.8 658.8 665.4 674.9 9660.5 9863.8 10335.6 10952.4 11969.6 629.3 642.0 646.5 655.0 664.9 5252.5 5341.7 5387.8 5411.4 5662.0 99477.0 100461.0 101265.5 102144.5 105376.0 72447.0 91107.7 92062.5 92878.0 94552.1 59001.0 72189.0 72906.0 74464.6 81975.0 11857.2 12039.8 12237.1 12289.6 12290.0 37380.5 38147.8 38367.6 39604.0 40003.8 66463.3 68385.0 70528.6 70937.0 72793.6 15772.3 16136.5 16177.8 16470.8 16610.6 17957.9 18129.6 18331.5 18430.1 18468.0 16398.3 16518.6 16714.2 16729.0 16821.5 16286.3 16415.6 16666.9 16809.7 16825.1 15974.6 16173.2 16382.2 16724.2 16932.5 11720.7 11838.3 12051.6 12066.0 12179.1 12701.9 13469.5 13605.5 13644.3 13872.5 13:07:20 INFO - PID 1634 | -------- Summary: end -------- 13:07:20 INFO - PID 1634 | 13:07:20 INFO - TEST-INFO | 1634: exit 0 13:07:20 INFO - TEST-OK | dromaeo_css | took 1119962ms 13:07:20 INFO - TEST-START | kraken 13:07:20 INFO - operating with platform_type : mac_ 13:07:20 INFO - Initialising browser for kraken test... 13:07:20 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/tmpathXdr/profile http://localhost:49235/getInfo.html) 13:07:23 INFO - PID 1643 | __metrics Screen width/height:1600/1200 13:07:23 INFO - PID 1643 | colorDepth:24 13:07:23 INFO - PID 1643 | Browser inner width/height: 1024/689 13:07:23 INFO - PID 1643 | __metrics 13:07:23 INFO - PID 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:07:23 INFO - PID 1643 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:07:24 INFO - TEST-INFO | 1643: exit 0 13:07:24 INFO - Browser initialized. 13:07:24 INFO - Running cycle 1/1 for kraken test... 13:07:24 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/tmpathXdr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:36 INFO - PID 1644 | RSS: Main: 241893376 13:07:36 INFO - PID 1644 | 13:07:39 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:40 INFO - PID 1644 | RSS: Main: 312225792 13:07:40 INFO - PID 1644 | 13:07:43 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 13:07:43 INFO - PID 1644 | RSS: Main: 293412864 13:07:43 INFO - PID 1644 | 13:07:47 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 13:07:47 INFO - PID 1644 | RSS: Main: 385560576 13:07:47 INFO - PID 1644 | 13:07:49 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 13:07:50 INFO - PID 1644 | RSS: Main: 288215040 13:07:50 INFO - PID 1644 | 13:07:52 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:07:53 INFO - PID 1644 | RSS: Main: 291115008 13:07:53 INFO - PID 1644 | 13:07:55 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 13:07:56 INFO - PID 1644 | RSS: Main: 354795520 13:07:56 INFO - PID 1644 | 13:07:59 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:00 INFO - PID 1644 | RSS: Main: 374972416 13:08:00 INFO - PID 1644 | 13:08:02 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 13:08:03 INFO - PID 1644 | RSS: Main: 385511424 13:08:03 INFO - PID 1644 | 13:08:04 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:05 INFO - PID 1644 | RSS: Main: 333709312 13:08:05 INFO - PID 1644 | 13:08:07 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:08 INFO - PID 1644 | RSS: Main: 332865536 13:08:08 INFO - PID 1644 | 13:08:10 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:10 INFO - PID 1644 | RSS: Main: 317321216 13:08:10 INFO - PID 1644 | 13:08:13 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:14 INFO - PID 1644 | RSS: Main: 335069184 13:08:14 INFO - PID 1644 | 13:08:17 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:18 INFO - PID 1644 | RSS: Main: 345415680 13:08:18 INFO - PID 1644 | 13:08:19 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 13:08:20 INFO - PID 1644 | RSS: Main: 389234688 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | __start_tp_report 13:08:20 INFO - PID 1644 | _x_x_mozilla_page_load 13:08:20 INFO - PID 1644 | _x_x_mozilla_page_load_details 13:08:20 INFO - PID 1644 | |i|pagename|runs| 13:08:20 INFO - PID 1644 | |0;ai-astar;109;115;90;165;167;163;112;112;112;111 13:08:20 INFO - PID 1644 | |1;audio-beat-detection;146;110;107;163;144;143;90;137;160;144 13:08:20 INFO - PID 1644 | |2;audio-dft;184;186;184;188;185;183;184;183;263;219 13:08:20 INFO - PID 1644 | |3;audio-fft;81;61;60;90;59;63;59;59;86;60 13:08:20 INFO - PID 1644 | |4;audio-oscillator;89;70;86;68;68;68;90;69;93;117 13:08:20 INFO - PID 1644 | |5;imaging-gaussian-blur;87;88;88;89;87;87;88;88;89;88 13:08:20 INFO - PID 1644 | |6;imaging-darkroom;97;96;97;96;96;96;97;96;96;96 13:08:20 INFO - PID 1644 | |7;imaging-desaturate;87;85;85;86;94;84;87;85;85;86 13:08:20 INFO - PID 1644 | |8;json-parse-financial;51;49;49;48;47;50;49;50;49;49 13:08:20 INFO - PID 1644 | |9;json-stringify-tinderbox;54;54;64;67;64;65;58;57;56;57 13:08:20 INFO - PID 1644 | |10;stanford-crypto-aes;81;83;83;80;83;82;83;80;83;82 13:08:20 INFO - PID 1644 | |11;stanford-crypto-ccm;142;128;136;131;145;138;148;146;178;150 13:08:20 INFO - PID 1644 | |12;stanford-crypto-pbkdf2;193;186;188;184;184;187;183;184;183;216 13:08:20 INFO - PID 1644 | |13;stanford-crypto-sha256-iterative;58;66;61;67;67;68;68;69;67;66 13:08:20 INFO - PID 1644 | __end_tp_report 13:08:20 INFO - PID 1644 | __start_cc_report 13:08:20 INFO - PID 1644 | _x_x_mozilla_cycle_collect,2279 13:08:20 INFO - PID 1644 | __end_cc_report 13:08:20 INFO - PID 1644 | __startTimestamp1492805300193__endTimestamp 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | ------- Summary: start ------- 13:08:20 INFO - PID 1644 | Number of tests: 14 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#0] ai-astar Cycles:10 Average:125.60 Median:139.00 stddev:28.06 (20.2%) stddev-sans-first:29.12 13:08:20 INFO - PID 1644 | Values: 109.0 115.0 90.0 165.0 167.0 163.0 112.0 112.0 112.0 111.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:145.00 stddev:24.01 (16.6%) stddev-sans-first:25.10 13:08:20 INFO - PID 1644 | Values: 146.0 110.0 107.0 163.0 144.0 143.0 90.0 137.0 160.0 144.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#2] audio-dft Cycles:10 Average:195.90 Median:185.50 stddev:25.98 (14.0%) stddev-sans-first:27.19 13:08:20 INFO - PID 1644 | Values: 184.0 186.0 184.0 188.0 185.0 183.0 184.0 183.0 263.0 219.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#3] audio-fft Cycles:10 Average:67.80 Median:62.00 stddev:12.57 (20.3%) stddev-sans-first:12.39 13:08:20 INFO - PID 1644 | Values: 81.0 61.0 60.0 90.0 59.0 63.0 59.0 59.0 86.0 60.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:78.00 stddev:16.25 (20.8%) stddev-sans-first:17.02 13:08:20 INFO - PID 1644 | Values: 89.0 70.0 86.0 68.0 68.0 68.0 90.0 69.0 93.0 117.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:08:20 INFO - PID 1644 | Values: 87.0 88.0 88.0 89.0 87.0 87.0 88.0 88.0 89.0 88.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:08:20 INFO - PID 1644 | Values: 97.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:86.00 stddev:2.84 (3.3%) stddev-sans-first:3.00 13:08:20 INFO - PID 1644 | Values: 87.0 85.0 85.0 86.0 94.0 84.0 87.0 85.0 85.0 86.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:1.10 (2.2%) stddev-sans-first:0.93 13:08:20 INFO - PID 1644 | Values: 51.0 49.0 49.0 48.0 47.0 50.0 49.0 50.0 49.0 49.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:61.00 stddev:4.88 (8.0%) stddev-sans-first:4.74 13:08:20 INFO - PID 1644 | Values: 54.0 54.0 64.0 67.0 64.0 65.0 58.0 57.0 56.0 57.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.00 stddev:1.25 (1.5%) stddev-sans-first:1.27 13:08:20 INFO - PID 1644 | Values: 81.0 83.0 83.0 80.0 83.0 82.0 83.0 80.0 83.0 82.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:145.50 stddev:13.91 (9.6%) stddev-sans-first:14.73 13:08:20 INFO - PID 1644 | Values: 142.0 128.0 136.0 131.0 145.0 138.0 148.0 146.0 178.0 150.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.80 Median:186.50 stddev:10.03 (5.4%) stddev-sans-first:10.52 13:08:20 INFO - PID 1644 | Values: 193.0 186.0 188.0 184.0 184.0 187.0 183.0 184.0 183.0 216.0 13:08:20 INFO - PID 1644 | 13:08:20 INFO - PID 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:67.00 stddev:3.47 (5.2%) stddev-sans-first:2.30 13:08:20 INFO - PID 1644 | Values: 58.0 66.0 61.0 67.0 67.0 68.0 68.0 69.0 67.0 66.0 13:08:20 INFO - PID 1644 | -------- Summary: end -------- 13:08:20 INFO - PID 1644 | 13:08:21 INFO - TEST-INFO | 1644: exit 0 13:08:21 INFO - TEST-OK | kraken | took 60774ms 13:08:21 INFO - SUITE-END | took 1180s 13:08:21 INFO - Completed test suite (00:19:41) 13:08:21 INFO - javascript benchmark 13:08:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7666.027870116261, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3524.5065690803285, 3524.8413821378035, 3552.5026496290507, 3560.7329450291218, 3584.4623306504022, 5981.730822113004, 6131.988406491158, 6179.443850053489, 6197.287311959126, 6239.750409983601, 6113.658745237698, 6124.663143527116, 6204.6587437690905, 6210.875782484348, 6219.129321894939, 5208.401033881095, 5311.654742441749, 5351.812686555972, 5380.91928621071, 5487.039768040597, 4500.369948207253, 5465.644733092357, 5478.424765399635, 5484.506394424501, 5489.972550137264, 5253.185756207794, 5323.627346085776, 5328.786848526054, 5341.172118321628, 5402.35171779389, 5292.338457692788, 5306.92039619406, 5314.760835762361, 5329.147336426153, 5335.519803217729, 5251.474852514718, 5283.656562323476, 5296.073187192226, 5305.602079844027, 5308.336457942757, 6070.939290607082, 6070.939290607082, 6095.146679464879, 6099.573029887865, 6101.298350689639, 6354.23749150105, 6356.4279214870885, 6370.108184854124, 6376.585521941105, 6389.680515974229, 5554.50009499147, 6545.509086818508, 6558.540902136852, 6641.0, 6647.93352066478, 6195.4424101831055, 6221.129041934133, 6236.376362363772, 6237.469815065725, 6252.374762523802, 6524.575902566413, 6760.7633732820095, 6766.49251306154, 6772.11962444879, 6786.049953006583, 6338.904916426165, 6382.425581697669, 6434.9678251609375, 6447.4197322241225, 6452.548321617535, 6615.106960560359, 6628.801135965929, 6630.303818099127, 6640.269570347258, 6641.302663220389, 6520.641364724891, 6524.510661700391, 6530.706118224692, 6533.314002029813, 6535.117759102461, 6309.936900631027, 6361.2048493938255, 6381.521385895983, 6442.838929026718, 6457.0, 5234.555062819703, 5246.842594722164, 5255.0, 5268.394134674561, 5296.25852380667, 4596.655250856199, 4636.142313671981, 4640.443146822403, 4644.651651126179, 4658.813647454064, 5992.221011268507, 6108.083787431832, 6117.143599896018, 6221.875562488724, 6234.407731265523, 6334.1765570475545, 6382.36176382358, 6392.648404337806, 6394.360563943662, 6400.103985442041, 6120.751898419022, 6127.158986117706, 6180.412860778219, 6244.375562443719, 6247.562670613104, 5681.091025435993, 5782.710864456761, 5809.6223745457255, 5821.155932389865, 5829.329627092854, 6788.422984046214, 6849.34931181527, 6858.417034552119, 6878.449724021966, 6880.105586273752, 6404.327545607644, 6475.352464753675, 6479.51403644738, 6637.6681165940545, 6651.201855777338, 6600.60396376219, 6604.5046621502615, 6615.206175259, 6742.595444273359, 6819.283975182733, 6476.676166191766, 6520.510961677988, 6528.445082168069, 6531.11829902957, 6538.967305163444, 6574.80275591733, 6579.736810527525, 6599.142111525471, 6599.142111525663, 6600.504962127764, 6219.720112594853, 6272.247330320209, 6292.653904035322, 6370.235571731422, 6376.139221205263, 6326.0, 6333.809985700436, 6370.458511026614, 6371.617702937839, 6373.936260637334, 5208.775937654724, 6233.127362169391, 6280.277768056732, 6282.528810339334, 6286.088517165077, 6237.28271248794, 6296.433321000949, 6390.7763228286785, 6391.265004524354, 6396.936030639634, 6220.098085777628, 6226.097215903578, 6235.750569977332, 6241.407066328691, 6264.34224406449], "value": 5985.826208812053, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.2547314475808, 792.3898598079479, 804.3645520039171, 1111.766529028904, 1125.881782412847, 26306.185603087542, 36105.0, 36490.270194596094, 36544.817275913614, 36644.450333245026, 38299.0, 38665.806670966675, 38681.80659096708, 38734.06329683511, 38760.61239387605, 5970.820875373745, 8229.83540329193, 8404.747857564253, 8415.158484151567, 8428.578571071452, 6036.2152920120325, 6809.863802723942, 8430.494170349768, 8437.282830959375, 8455.239028487435, 8475.194856488655, 8496.78758031048, 8499.362547808909, 8513.446625969324, 8523.275521580674, 8378.245957863792, 8441.57792110392, 8467.110953349902, 8476.0, 8477.576121193977, 8115.8782618260775, 8170.346372290202, 8193.79515512111, 8195.754127376129, 8201.22088401601, 34742.82628586841, 34978.82510587456, 34979.82510087433, 35018.29963400743, 35023.299534009435, 3518.085297822559, 3546.804925729084, 3547.219611685425, 3548.946765798515, 3552.3250582389524, 30473.390532189453, 30514.84742576295, 30584.38831223363, 30593.541096883564, 30668.38663226745, 2623.3048242215827, 2664.693560240578, 3083.9691603083907, 3126.218445388653, 3138.3409484008384, 207839.0, 275232.0, 275996.62001690065, 276116.0, 276142.0, 47546.28680569794, 47740.283895741595, 47748.522514774406, 47748.522514774406, 47851.5214847854, 49268.0, 49389.25916111261, 49436.0, 49438.75280623574, 49452.752736236085, 13501.527446539323, 13586.184828910296, 13600.115992460458, 13601.523946662017, 13653.385597647932, 9606.567704453317, 11018.779624407467, 11032.889671103347, 11035.668929932115, 11058.22592418523, 10682.252242342962, 10722.463876806129, 10736.409497477558, 10758.73103172427, 10768.623098191525, 4990.4011518618, 5226.790928362823, 5230.0, 5235.214717792362, 5243.842684719464, 975.3757595139117, 997.1275134257525, 997.8802543694803, 1029.902159294866, 1040.095117247999, 23777.16779912729, 23889.044438222623, 23976.40058998539, 24018.87990560071, 24023.27930162063, 1088.1621151713296, 1089.9891001090045, 1124.9100071994221, 1125.6960620632383, 1130.6438471881495, 12182.695432614255, 12340.876591233973, 12392.0, 12413.0, 12419.503219871285, 304897.0, 305022.0, 305110.9488905127, 305139.0, 305512.0, 52204.738976305634, 52434.47565524296, 52446.0, 52510.424687259445, 52514.0, 1424.586869807765, 1459.1391079263285, 1511.6523199663918, 1513.530805450314, 1522.2540954932224, 23377.0, 23440.53118937646, 23503.882480587486, 23560.0575976959, 23613.881930590236, 36573.26853462969, 36586.45120323251, 36597.634023659426, 36632.81683591565, 36680.0, 263908.0, 264342.0, 264429.20137186977, 264610.0, 265743.0, 27081.916723331633, 33668.0, 33668.66331336655, 33831.661683383834, 34086.48870266898, 43800.56199438092, 43803.56196437995, 43818.56181438272, 43831.78084109559, 43857.34213986857, 28721.0, 28981.98563050283, 30342.0, 30612.0, 30633.693663063976, 25608.10371636984, 29766.404671906872, 30653.540196896618, 31078.844605776827, 31122.755089796156, 35678.64321356857, 36717.44923826198, 36743.897683068484, 36752.52989880375, 36898.44652330271, 30107.698923011365, 30546.0, 30783.38433231278, 30877.073687788503, 31095.222619434695, 19112.948787816804, 22718.545629086995, 23803.761962380155, 24318.635220471355, 24328.391790205387], "value": 16834.55882766442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.66574745718697, 412.25176305006414, 425.31934632127314, 449.09507342704444, 460.6453031166, 17287.48137555874, 20934.89532552339, 21002.159913603457, 21289.467763305907, 21589.0, 22653.093876244973, 22820.20129295475, 22984.310470685865, 23233.838308084614, 23369.298921032354, 6054.303755068179, 6132.693365331726, 6229.0, 6305.527085468585, 6352.809415717513, 3690.1143725505954, 3717.2937141942944, 6211.0993905883615, 6302.0861975013595, 6314.810555683314, 3722.5719042310075, 3756.248750249947, 3983.9601603984024, 6354.078658594501, 6416.871662566769, 6180.845478863064, 6193.659348735818, 6273.404026617464, 6341.52438567107, 6345.650989195569, 5540.889182216373, 5562.666240025612, 5571.526420254283, 5575.2473416088715, 5583.804566840141, 26272.73727262722, 26322.73677263222, 26954.730452695418, 27315.043973461034, 27613.447731045268, 2209.2046863129262, 2244.7755224477423, 2247.584196923558, 2248.05581655705, 2248.7638797926147, 16880.577985550335, 17900.91049544757, 18115.0, 18202.635947281113, 18286.359977400727, 2093.42430831521, 2141.4432247615578, 2159.0931808640407, 2168.9240876569243, 2170.3814412892407, 164099.0, 165698.0, 166018.33981660148, 166676.0, 167342.0, 9116.635334586676, 11371.488283027284, 12431.564895228623, 12447.626571202698, 12612.621621351374, 16287.429939952044, 16425.1787410629, 16464.588385290463, 16467.176641167895, 16494.75257871133, 8658.567071646392, 8707.0, 8727.825443491221, 8832.205101540892, 8880.023197448276, 8131.349492040623, 8145.0, 8151.714689985822, 8270.214329638675, 8288.627011784483, 6203.379662033851, 7745.651445684957, 7782.649780759766, 7802.258785415376, 7803.244270039309, 2030.46192758919, 2034.094827801614, 2034.8473864460225, 2035.6844689073218, 2155.6874253233195, 851.6841479913548, 891.8038031633031, 930.7905721212672, 963.2631037256365, 976.3604838830578, 16365.67268654644, 18529.0, 20974.16103355849, 21460.785392145877, 21649.351037443834, 945.3524335829978, 969.2004096620317, 995.7560397702464, 1009.1422291052546, 1010.6765834932897, 10544.89102179567, 10825.296355736851, 10970.122390208764, 10984.450777461096, 10993.395363255098, 476218.0, 517075.0, 522575.0, 541296.0, 542447.0, 119725.80274197321, 123045.0, 128983.81178070405, 130641.0, 130938.34530827476, 1093.9343639381502, 1103.812351900179, 1137.8236373362142, 1138.732397886496, 1143.9942800285946, 16535.83464165391, 16888.831111688727, 17310.394136205174, 17466.388676396266, 17852.0, 43951.78024109859, 55971.72014139903, 57972.71013645073, 58019.709901450224, 58850.411495884495, 72230.63884680544, 73699.0, 74652.62673686814, 74968.0, 75546.8667969992, 8862.778430539289, 8905.287576993695, 8970.551472426221, 9044.457332559805, 9059.954700226457, 12778.87221127814, 13873.4450621974, 14129.0, 14202.934779891757, 14259.07316024455, 11993.160478766402, 12000.939995299968, 12129.0, 12334.50661973511, 12467.93766031164, 10965.203873012331, 11397.715057123638, 11518.136139789716, 11583.76832463329, 11638.010769084724, 12140.332281724237, 12195.634130976085, 12329.93835030855, 12390.194637348544, 12431.440585173508, 6661.666916654245, 8787.384883058125, 8873.511956842178, 8903.0, 8960.551972401223, 11947.701307467383, 11986.46060927243, 12141.271523708252, 12227.388630568614, 12238.959688426583], "value": 10191.868561218484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.4657760184728, 1460.451512111366, 1480.9555713328605, 1495.1552372909298, 1495.842936491669, 11131.443427828606, 11656.475458604362, 11666.125040621955, 11667.2416292941, 11668.35824029678, 11239.83140252897, 11682.591109311175, 11683.532658693663, 11691.12316576256, 11740.82388764167, 2516.1067820923536, 2554.7572980566815, 2559.4113353928606, 2563.5641940870096, 2563.782078523328, 2101.191041449038, 2395.425097976482, 2476.962845557318, 2539.6825396825398, 2539.7079335876333, 2012.7383440152832, 2086.9060892259886, 2091.7489901211875, 2143.474848662072, 2172.6089303925287, 2389.8446600970883, 2395.3053614451787, 2396.5805983952737, 2398.3884109552127, 2400.3879010852206, 2350.4828937633692, 2387.85672859629, 2388.4028992751814, 2389.749076346993, 2394.437307232799, 11341.886581134166, 11622.418879056098, 11629.069674426026, 11635.185537012412, 11635.941820290844, 6476.838079048014, 6723.058771771955, 6737.898931516032, 6738.0, 6745.224299205605, 3665.798381089039, 4186.518550366686, 4245.87262382129, 4368.606825385698, 4374.103308821684, 1193.3675152169365, 1211.5093387178206, 1217.111508598719, 1236.2397125767677, 1290.7483040807047, 16499.09254990975, 16597.585060373465, 16598.00411975285, 16615.50153495397, 16637.33450661984, 4569.954300456953, 5410.513053825174, 5664.291963504562, 5669.40471250521, 5714.200011998323, 12171.634850954486, 12189.146759726911, 12212.023038156925, 12220.083493737828, 12233.755324893453, 5388.272583201296, 6557.344265573404, 6559.983202603604, 6564.409203171737, 6564.704588293443, 6053.636781793019, 6096.207493025879, 6202.472789812826, 6279.058141278753, 6319.052142178618, 4491.618212451913, 4637.837675681402, 4667.9766601166775, 4725.787339569728, 4736.005438857878, 1432.8495507971722, 1473.101408141033, 1474.4691910912063, 1501.6621260216582, 1507.0580886945659, 676.864627074587, 707.4340527577917, 793.2543409195454, 808.0707186735184, 817.3502065857657, 6283.842903927347, 6668.999650052531, 6761.763338283136, 6898.344657257552, 6926.238113807477, 740.8997638506813, 938.380668758616, 942.6465075596651, 946.2193690205607, 949.886013678363, 3350.6816852398983, 4046.615571520701, 4085.8774236772942, 4111.650509706648, 4200.915981680349, 14053.718925621635, 14813.0, 14816.481423150139, 14843.0, 14844.183569903544, 14213.50252741149, 14682.926585367004, 14710.117392956457, 14736.705265894836, 14740.926295368454, 8251.257386835214, 8480.44877083, 8481.109483504144, 8481.321494280442, 8497.62066621347, 6107.198376479038, 6311.274203466476, 6607.2071351438135, 6635.971424429221, 6940.583564985915, 10635.94682026585, 12818.294993775431, 13178.934105329412, 13242.271675057964, 13320.666983325495, 11392.25950313227, 12173.0, 13082.803757943448, 13222.669433264246, 13564.186148831102, 9181.908180918372, 9277.814443711222, 9370.0, 9430.952845236005, 9460.858087128561, 10443.94778026105, 10537.42044187577, 10547.156227501935, 10549.0, 10554.841677375, 8877.822443550964, 9002.099790021208, 9063.501507416891, 9132.49771262587, 9165.312601554777, 8819.955900220459, 8855.73432797017, 8930.508822014852, 8939.240164586083, 9003.099690030944, 6673.165854268216, 7886.960565197137, 8020.318272946864, 8042.557659328793, 8056.27493525562, 5895.115732640138, 5912.46787789101, 6007.399260074132, 6099.908501372572, 6138.416850399205, 5921.851953701192, 5932.406759324205, 6065.60573562717, 6123.418275263843, 6238.095476156022], "value": 5314.047056266857, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.2361720807726, 394.73355485047597, 402.65975250913004, 407.9653229475496, 409.1918461039447, 4540.9318860217045, 5788.942110578893, 5932.347441781406, 5932.881342373155, 5986.7305971231235, 4747.406574178228, 5594.944050559493, 5637.802676906309, 5680.431956804317, 5782.074868021107, 4442.378067070605, 4515.503294637587, 4533.5693109154745, 4549.7725113744345, 4552.4764652065105, 3310.0, 3672.4858519807117, 3805.429185622151, 4302.01053757636, 4475.412701980464, 3665.7433979621437, 4448.555144485558, 4452.688311818174, 4469.854469854472, 4499.1901457737595, 4433.467983841943, 4435.7338559686195, 4443.688941774077, 4467.151241264182, 4470.552944705503, 3341.8830340938193, 4027.677785777131, 4029.2747305485, 4032.1532478179615, 4073.144639625682, 4893.0, 5454.809081682161, 5630.380658127644, 5725.341585717654, 5771.229809691372, 4956.603471722254, 5350.946490535084, 5388.676679399209, 5409.161579955114, 5441.619086663935, 5888.556249156595, 6143.0, 6297.527685423612, 6305.495560355161, 6310.747570097191, 4519.796609152563, 4531.957649740578, 4538.071319689119, 4539.909201815978, 4552.453705555321, 6572.14562106923, 6575.56704019511, 6658.400743933069, 6659.3007734187695, 6662.733490660319, 3910.276598829226, 4418.270985287391, 4494.820207191741, 4648.581627653527, 4670.906581868344, 4536.682432229778, 4773.904521909542, 4786.593139583105, 4794.472608013186, 4801.807927682854, 5397.515683187076, 5417.3770016447825, 5434.755436005389, 5438.320209973754, 5441.863953401196, 5197.506236907488, 5223.451537588575, 5955.970220148958, 6256.718447669866, 6285.748570057147, 1451.3178805961181, 1573.7875386822861, 1574.740167872311, 1591.9442819501262, 1619.627485678277, 953.6948176583566, 1000.3997601439079, 1033.5555711044324, 1101.7410908436511, 1141.8058929981923, 4943.01139772047, 5144.6655967362, 5855.3851845556455, 5879.735411906475, 5888.970555147197, 6007.0, 6291.307956124822, 6325.430711236011, 6340.239171299474, 6446.871062578723, 4902.41171059468, 5637.295338082739, 5811.27359080115, 5847.9415205848245, 5988.461038506468, 2956.704329567026, 3319.8008119512906, 3346.1300061983575, 3348.179695974502, 3370.3090866372827, 5794.913076303858, 5998.5003749062735, 6663.86672266552, 6673.564149085549, 6683.832904177434, 6220.040687183523, 6490.902636460457, 6535.248446428626, 6556.27880933097, 6557.0, 6129.325774164839, 6435.002574600944, 6650.833729156713, 6667.766628168088, 6714.462842972551, 5338.946610533845, 6414.326495718069, 6442.420182183626, 6454.0, 6493.480521558169, 4984.476629953948, 6352.968235158794, 6381.840453988688, 6390.028636683965, 6390.265119511316, 4941.604671626189, 5757.5393968481585, 6133.38666133401, 6587.341265873374, 6589.6705164740615, 4294.29144191205, 4318.611324980767, 4326.2645350289895, 4345.782710864507, 4353.869383918487, 5869.73800632866, 5893.230181814541, 6012.218411606463, 6128.295246046761, 6355.809325720235, 5330.4957311072085, 5571.526420254324, 6183.721732521957, 6185.505159587312, 6198.132261483486, 5409.810656626999, 6166.475849552839, 6180.721867516063, 6189.288231853395, 6192.969035154795, 5180.6891586503425, 5842.211301474246, 5949.434803693643, 6112.266528016667, 6113.23584551931, 5172.767225474788, 6264.31092579825, 6267.843303917256, 6278.623282603058, 6311.526635502264, 4985.8005679772405, 5264.605154613496, 5656.632318899258, 5794.652320860761, 6133.9079913802225], "value": 4590.319123551245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.154023631406, 852.7953291210109, 858.3219256787138, 859.0078459379415, 872.9258013068891, 12855.614331570056, 17516.386926457562, 17520.211590478426, 18050.63898722028, 18147.27410903564, 16663.0, 16814.747778783327, 17126.0, 17197.82802171978, 17219.483415497525, 896.995515022424, 913.2511340700628, 915.0437792506847, 916.3173435790312, 916.4363916191561, 644.9258335291455, 660.1517050589993, 946.9952650236739, 970.9708708738714, 974.3861367338602, 1009.7021378693303, 1010.5705075342987, 1010.9949450252739, 1012.25093430861, 1016.019541142797, 1008.9394636321845, 1008.9798204035878, 1009.1220638044912, 1011.3072545306416, 1017.8015287019034, 494.1327969413692, 502.6431233823989, 704.5385272646373, 720.4416577152696, 729.7117638532803, 15689.68620627581, 15710.214489275604, 15759.369625214978, 15770.369185232577, 15830.920845395814, 12192.81710774339, 12591.748165036648, 12842.229466232056, 12869.67825804353, 12897.67755806103, 13931.721365572632, 14368.06607570515, 14499.275036248146, 14558.670612701917, 15232.0, 3561.269939662363, 3583.104223944014, 3595.6404359564094, 3598.748087633867, 3600.981995090034, 106349.46825265902, 109923.0, 110482.34276485779, 112488.31267530912, 112974.0, 11080.5567777288, 11253.381064041556, 12547.749045019049, 13008.739825203444, 13021.869781302255, 17770.822291777175, 19618.509537261398, 24762.804105265917, 24816.255512334657, 24981.25056248279, 7296.343329100407, 7500.137484189279, 7612.276833700789, 7621.695132194761, 7626.122995855437, 3676.963230367662, 3738.420544815558, 3743.2513497300647, 3743.288775132716, 3752.6810221130963, 4270.7864606769535, 4632.444106707217, 4730.716157030521, 4791.856244312607, 4794.184988551954, 825.3727167352855, 940.351157701184, 962.2013728605241, 971.3394891473865, 978.2320878110648, 646.9256035555877, 655.803259022301, 658.7529676371361, 665.3679004945321, 674.9426298764562, 9660.516974151406, 9863.753406164904, 10335.63825266127, 10952.406939765706, 11969.581064662694, 629.263761399155, 641.9646919419383, 646.5312648330017, 655.0436362910204, 664.8703502817001, 5252.527272545489, 5341.679499230058, 5387.838364849061, 5411.369968344694, 5661.971690141523, 99477.00522994678, 100461.0, 101265.4810177848, 102144.48927755313, 105376.0, 72447.0, 91107.72230694153, 92062.53968730247, 92878.0, 94552.05447945432, 59001.0, 72189.0, 72906.0, 74464.62767686127, 81975.0, 11857.229280096766, 12039.819402709141, 12237.143399961917, 12289.631311060682, 12290.0, 37380.50477980959, 38147.80926095463, 38367.61632383752, 39604.0, 40003.79998099991, 66463.33536664571, 68384.97422538567, 70528.64735676289, 70937.0, 72793.63603181951, 15772.290246939145, 16136.515904522883, 16177.838221617632, 16470.83529164741, 16610.584735381228, 17957.910210449387, 18129.637407251517, 18331.478758494806, 18430.078496074875, 18468.0, 16398.344066237216, 16518.587035324214, 16714.247858846138, 16729.0, 16821.495355139366, 16286.267117979482, 16415.589610259838, 16666.916665416597, 16809.663806724042, 16825.074620895968, 15974.60063498422, 16173.191340433166, 16382.197958224824, 16724.247408866875, 16932.492025239262, 11720.70698232551, 11838.348890810743, 12051.638450846489, 12066.0, 12179.147459677737, 12701.872981270439, 13469.461221551028, 13605.523806666719, 13644.317784110557, 13872.514461993782], "value": 8101.089684179378, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 90.0, 165.0, 167.0, 163.0, 112.0, 112.0, 112.0, 111.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 107.0, 163.0, 144.0, 143.0, 90.0, 137.0, 160.0, 144.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 184.0, 188.0, 185.0, 183.0, 184.0, 183.0, 263.0, 219.0], "value": 195.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 60.0, 90.0, 59.0, 63.0, 59.0, 59.0, 86.0, 60.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 86.0, 68.0, 68.0, 68.0, 90.0, 69.0, 93.0, 117.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 89.0, 87.0, 87.0, 88.0, 88.0, 89.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 86.0, 94.0, 84.0, 87.0, 85.0, 85.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 49.0, 48.0, 47.0, 50.0, 49.0, 50.0, 49.0, 49.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 64.0, 67.0, 64.0, 65.0, 58.0, 57.0, 56.0, 57.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 83.0, 80.0, 83.0, 82.0, 83.0, 80.0, 83.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 128.0, 136.0, 131.0, 145.0, 138.0, 148.0, 146.0, 178.0, 150.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 186.0, 188.0, 184.0, 184.0, 187.0, 183.0, 184.0, 183.0, 216.0], "value": 188.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 66.0, 61.0, 67.0, 67.0, 68.0, 68.0, 69.0, 67.0, 66.0], "value": 65.7, "unit": "score"}]}]} 13:08:21 INFO - Return code: 0 13:08:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:08:21 ERROR - # TBPL SUCCESS # 13:08:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:08:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:08:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:08:22 INFO - 2017-04-21 13:08:22.008 screenresolution[1648:9784] starting screenresolution argv=screenresolution get 13:08:22 INFO - 2017-04-21 13:08:22.010 screenresolution[1648:9784] Display 0: 1600x1200x32@60 13:08:22 INFO - 2017-04-21 13:08:22.016 screenresolution[1649:9787] starting screenresolution argv=screenresolution list 13:08:22 INFO - Available Modes on Display 0 13:08:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:08:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:08:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:08:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:08:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:08:22 INFO - Intel Iris: 13:08:22 INFO - Chipset Model: Intel Iris 13:08:22 INFO - Type: GPU 13:08:22 INFO - Bus: Built-In 13:08:22 INFO - VRAM (Dynamic, Max): 1536 MB 13:08:22 INFO - Vendor: Intel (0x8086) 13:08:22 INFO - Device ID: 0x0a2e 13:08:22 INFO - Revision ID: 0x0009 13:08:22 INFO - Displays: 13:08:22 INFO - Display: 13:08:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:08:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:08:22 INFO - Display Serial Number: 1600x1200 60 13:08:22 INFO - Main Display: Yes 13:08:22 INFO - Mirror: Off 13:08:22 INFO - Online: Yes 13:08:22 INFO - Rotation: Supported 13:08:22 INFO - Return code: 0 13:08:22 INFO - Running post-action listener: _resource_record_post_action 13:08:22 INFO - [mozharness: 2017-04-21 20:08:22.256910Z] Finished run-tests step (success) 13:08:22 INFO - Running post-run listener: _resource_record_post_run 13:08:22 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 36975616; Write bytes: 517128192; Read time: 383; Write time: 1831 13:08:22 INFO - TinderboxPrint: CPU usage
53.1% 13:08:22 INFO - TinderboxPrint: I/O read bytes / time
36,975,616 / 383 13:08:22 INFO - TinderboxPrint: I/O write bytes / time
517,128,192 / 1,831 13:08:22 INFO - TinderboxPrint: CPU idle
2,253.9 (46.9%) 13:08:22 INFO - TinderboxPrint: CPU system
953.4 (19.8%) 13:08:22 INFO - TinderboxPrint: CPU user
1,602.3 (33.3%) 13:08:22 INFO - TinderboxPrint: Swap in / out
244,506,624 / 0 13:08:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205527552; Write bytes: 206383104; Read time: 15694; Write time: 448 13:08:22 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 34878464; Write bytes: 303691776; Read time: 359; Write time: 1339 13:08:22 INFO - Running post-run listener: _upload_blobber_files 13:08:22 INFO - Blob upload gear active. 13:08:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:08:22 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 13:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:08:23 INFO - (blobuploader) - INFO - Open directory for files ... 13:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:08:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:24 INFO - (blobuploader) - INFO - Done attempting. 13:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:08:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:25 INFO - (blobuploader) - INFO - Done attempting. 13:08:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:08:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:08:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:26 INFO - (blobuploader) - INFO - Done attempting. 13:08:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:08:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:28 INFO - (blobuploader) - INFO - Done attempting. 13:08:28 INFO - (blobuploader) - INFO - Iteration through files over. 13:08:28 INFO - Return code: 0 13:08:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:08:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:08:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c788a297da1658f4bd410bfa346bb407ed44284061be53686f58ac6112d33d578fc4ecfcacbf40d0bf13e3f4f99aff2842df61217fb409bdcfc9092fa80b58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/149797a0015f1abbdd3a52d7fa0b943fd823cd11e91a366933673bb8c78bd2c9ead9b68dbfbf83b150aede0eaa271d7784c23176aa46fe0f75dde1d7356867bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83fad377cc52ff69e5bd8af2602bf68f43ee3182645e6d1e741bb04cff07c58dfff0a956c35afcfb1b56add986ec8a22e59bea365775c8cbc86f13bbb63a5d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d505905566124688194c224c0752f87b3f4728c2b91fb11c0d49ed3cc3c4f630a5333f5e31b07ac67cc9177398ed95a730566c3c74b9cd48c6f52efd1d303f4"} 13:08:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:08:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:08:28 INFO - Contents: 13:08:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c788a297da1658f4bd410bfa346bb407ed44284061be53686f58ac6112d33d578fc4ecfcacbf40d0bf13e3f4f99aff2842df61217fb409bdcfc9092fa80b58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/149797a0015f1abbdd3a52d7fa0b943fd823cd11e91a366933673bb8c78bd2c9ead9b68dbfbf83b150aede0eaa271d7784c23176aa46fe0f75dde1d7356867bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83fad377cc52ff69e5bd8af2602bf68f43ee3182645e6d1e741bb04cff07c58dfff0a956c35afcfb1b56add986ec8a22e59bea365775c8cbc86f13bbb63a5d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d505905566124688194c224c0752f87b3f4728c2b91fb11c0d49ed3cc3c4f630a5333f5e31b07ac67cc9177398ed95a730566c3c74b9cd48c6f52efd1d303f4"} 13:08:28 INFO - Running post-run listener: copy_logs_to_upload_dir 13:08:28 INFO - Copying logs to upload dir... 13:08:28 INFO - mkdir: /builds/slave/test/build/upload/logs 13:08:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.433949 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-21 13:08:29.008120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 13:08:29.011574) ========= 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.PdABtlJtrg/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.bmqcltvmzQ/Listeners TMPDIR=/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c788a297da1658f4bd410bfa346bb407ed44284061be53686f58ac6112d33d578fc4ecfcacbf40d0bf13e3f4f99aff2842df61217fb409bdcfc9092fa80b58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/149797a0015f1abbdd3a52d7fa0b943fd823cd11e91a366933673bb8c78bd2c9ead9b68dbfbf83b150aede0eaa271d7784c23176aa46fe0f75dde1d7356867bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83fad377cc52ff69e5bd8af2602bf68f43ee3182645e6d1e741bb04cff07c58dfff0a956c35afcfb1b56add986ec8a22e59bea365775c8cbc86f13bbb63a5d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d505905566124688194c224c0752f87b3f4728c2b91fb11c0d49ed3cc3c4f630a5333f5e31b07ac67cc9177398ed95a730566c3c74b9cd48c6f52efd1d303f4"} build_url:https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010996 build_url: 'https://queue.taskcluster.net/v1/task/WN2eiFc7QxeSD7cCLoyONg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c788a297da1658f4bd410bfa346bb407ed44284061be53686f58ac6112d33d578fc4ecfcacbf40d0bf13e3f4f99aff2842df61217fb409bdcfc9092fa80b58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/149797a0015f1abbdd3a52d7fa0b943fd823cd11e91a366933673bb8c78bd2c9ead9b68dbfbf83b150aede0eaa271d7784c23176aa46fe0f75dde1d7356867bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83fad377cc52ff69e5bd8af2602bf68f43ee3182645e6d1e741bb04cff07c58dfff0a956c35afcfb1b56add986ec8a22e59bea365775c8cbc86f13bbb63a5d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d505905566124688194c224c0752f87b3f4728c2b91fb11c0d49ed3cc3c4f630a5333f5e31b07ac67cc9177398ed95a730566c3c74b9cd48c6f52efd1d303f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 13:08:29.047386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 13:08:29.047715) ========= 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.PdABtlJtrg/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.bmqcltvmzQ/Listeners TMPDIR=/var/folders/fp/_7br9k0s4j30pf06c5ky859c00000w/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.005175 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 13:08:29.097094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 13:08:29.097401) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 13:08:29.097725) ========= ========= Total master_lag: 0.18 =========