builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0214 starttime: 1485734694.51 results: success (0) buildid: 20170129144543 builduid: 4885a4f59ca648d592146a2207d610db revision: d859e69475796f76214f07c6d133c3a1f325156c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:54.514755) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:54.520343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:54.520625) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:54.545227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:54.545555) ========= 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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-29 16:04:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 171M=0s 2017-01-29 16:04:55 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.730324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:55.299211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:55.299529) ========= 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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.020252 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:55.348730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-29 16:04:55.349127) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d859e69475796f76214f07c6d133c3a1f325156c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d859e69475796f76214f07c6d133c3a1f325156c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VcoEYJZavQ/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.YPNsn5BN2C/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-29 16:04:55,438 truncating revision to first 12 chars 2017-01-29 16:04:55,438 Setting DEBUG logging. 2017-01-29 16:04:55,438 attempt 1/10 2017-01-29 16:04:55,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d859e6947579?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-29 16:04:56,626 unpacking tar archive at: mozilla-aurora-d859e6947579/testing/mozharness/ program finished with exit code 0 elapsedTime=1.445785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-29 16:04:56.818390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:56.818718) ========= script_repo_revision: d859e69475796f76214f07c6d133c3a1f325156c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:56.819167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:56.819457) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-29 16:04:56.839082) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-29 16:04:56.839462) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VcoEYJZavQ/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.YPNsn5BN2C/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:04:57 INFO - MultiFileLogger online at 20170129 16:04:57 in /builds/slave/test 16:04:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:04:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:04:57 INFO - {'append_to_log': False, 16:04:57 INFO - 'base_work_dir': '/builds/slave/test', 16:04:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:04:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:04:57 INFO - 'branch': 'Mozilla-Aurora', 16:04:57 INFO - 'buildbot_json_path': 'buildprops.json', 16:04:57 INFO - 'config_files': ('talos/mac_config.py',), 16:04:57 INFO - 'default_actions': ('clobber', 16:04:57 INFO - 'read-buildbot-config', 16:04:57 INFO - 'download-and-extract', 16:04:57 INFO - 'populate-webroot', 16:04:57 INFO - 'create-virtualenv', 16:04:57 INFO - 'install', 16:04:57 INFO - 'run-tests'), 16:04:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:04:57 INFO - 'download_minidump_stackwalk': True, 16:04:57 INFO - 'download_symbols': 'ondemand', 16:04:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:04:57 INFO - 'tooltool.py': '/tools/tooltool.py', 16:04:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:04:57 INFO - '/tools/misc-python/virtualenv.py')}, 16:04:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:04:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:04:57 INFO - 'installer_path': 'installer.exe', 16:04:57 INFO - 'log_level': 'info', 16:04:57 INFO - 'log_name': 'talos', 16:04:57 INFO - 'log_to_console': True, 16:04:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:04:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:04:57 INFO - 'opt_config_files': (), 16:04:57 INFO - 'pip_index': False, 16:04:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:04:57 INFO - 'cmd': ('bash', 16:04:57 INFO - '-c', 16:04:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:04:57 INFO - 'enabled': True, 16:04:57 INFO - 'halt_on_failure': False, 16:04:57 INFO - 'name': 'check_screen_resolution'},), 16:04:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:04:57 INFO - 'cmd': ('bash', 16:04:57 INFO - '-c', 16:04:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:04:57 INFO - 'enabled': True, 16:04:57 INFO - 'halt_on_failure': False, 16:04:57 INFO - 'name': 'check_screen_resolution'},), 16:04:57 INFO - 'run_cmd_checks_enabled': True, 16:04:57 INFO - 'sps_profile': False, 16:04:57 INFO - 'sps_profile_interval': 0, 16:04:57 INFO - 'suite': 'dromaeojs', 16:04:57 INFO - 'system_bits': '32', 16:04:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:04:57 INFO - 'title': 't-yosemite-r7-0214', 16:04:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:04:57 INFO - 'use_talos_json': True, 16:04:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:04:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:04:57 INFO - 'work_dir': 'build'} 16:04:57 INFO - [mozharness: 2017-01-30 00:04:57.046060Z] Running clobber step. 16:04:57 INFO - Running pre-action listener: _resource_record_pre_action 16:04:57 INFO - Running main action method: clobber 16:04:57 INFO - rmtree: /builds/slave/test/build 16:04:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:04:58 INFO - Running post-action listener: _resource_record_post_action 16:04:58 INFO - [mozharness: 2017-01-30 00:04:58.843293Z] Finished clobber step (success) 16:04:58 INFO - [mozharness: 2017-01-30 00:04:58.843417Z] Running read-buildbot-config step. 16:04:58 INFO - Running pre-action listener: _resource_record_pre_action 16:04:58 INFO - Running main action method: read_buildbot_config 16:04:58 INFO - Using buildbot properties: 16:04:58 INFO - { 16:04:58 INFO - "project": "", 16:04:58 INFO - "product": "firefox", 16:04:58 INFO - "script_repo_revision": "production", 16:04:58 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:04:58 INFO - "repository": "", 16:04:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:04:58 INFO - "buildid": "20170129144543", 16:04:58 INFO - "pgo_build": "False", 16:04:58 INFO - "basedir": "/builds/slave/test", 16:04:58 INFO - "buildnumber": 0, 16:04:58 INFO - "slavename": "t-yosemite-r7-0214", 16:04:58 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:04:58 INFO - "platform": "yosemite_r7", 16:04:58 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:04:58 INFO - "branch": "mozilla-aurora", 16:04:58 INFO - "repo_path": "releases/mozilla-aurora", 16:04:58 INFO - "revision": "d859e69475796f76214f07c6d133c3a1f325156c", 16:04:58 INFO - "stage_platform": "macosx64", 16:04:58 INFO - "builduid": "4885a4f59ca648d592146a2207d610db", 16:04:58 INFO - "slavebuilddir": "test" 16:04:58 INFO - } 16:04:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 16:04:58 INFO - Running post-action listener: _resource_record_post_action 16:04:58 INFO - [mozharness: 2017-01-30 00:04:58.846957Z] Finished read-buildbot-config step (success) 16:04:58 INFO - [mozharness: 2017-01-30 00:04:58.847092Z] Running download-and-extract step. 16:04:58 INFO - Running pre-action listener: _resource_record_pre_action 16:04:58 INFO - Running main action method: download_and_extract 16:04:58 INFO - mkdir: /builds/slave/test/build/tests 16:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:58 INFO - trying https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 16:04:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 16:04:59 INFO - Downloaded 1199 bytes. 16:04:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:04:59 INFO - Using the following test package requirements: 16:04:59 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:04:59 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:04:59 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 16:04:59 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:04:59 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 16:04:59 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:04:59 INFO - u'jsshell-mac.zip'], 16:04:59 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:04:59 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 16:04:59 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:04:59 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:04:59 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 16:04:59 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:04:59 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 16:04:59 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:04:59 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 16:04:59 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:04:59 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 16:04:59 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:04:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:04:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:04:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:05:00 INFO - Expected file size: 16351796 16:05:00 INFO - Obtained file size: 16351796 16:05:07 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:05:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:05:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:05:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:05:07 INFO - Expected file size: 16351796 16:05:07 INFO - Obtained file size: 16351796 16:05:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 16:05:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:05:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 16:05:15 INFO - Expected file size: 14403485 16:05:15 INFO - Obtained file size: 14403485 16:05:15 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')]} 16:05:15 INFO - trying https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:05:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 16:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 16:05:17 INFO - Downloaded 73868571 bytes. 16:05:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:05:17 INFO - mkdir: /builds/slave/test/properties 16:05:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:17 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:17 INFO - Contents: 16:05:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:05:18 INFO - Running post-action listener: _resource_record_post_action 16:05:18 INFO - Running post-action listener: set_extra_try_arguments 16:05:18 INFO - [mozharness: 2017-01-30 00:05:18.537058Z] Finished download-and-extract step (success) 16:05:18 INFO - [mozharness: 2017-01-30 00:05:18.537153Z] Running populate-webroot step. 16:05:18 INFO - Running pre-action listener: _resource_record_pre_action 16:05:18 INFO - Running main action method: populate_webroot 16:05:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:05:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:05:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:05:18 INFO - '--tppagecycles', 16:05:18 INFO - '7'], 16:05:18 INFO - 'tests': ['tsvgm']}}, 16:05:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:05:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:05:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:05:18 INFO - 'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:05:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:05:18 INFO - 'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['damp', 'tps']}, 16:05:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:05:18 INFO - 'tests': ['damp', 'tps']}, 16:05:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['dromaeo_dom']}, 16:05:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['basic_compositor_video']}, 16:05:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:05:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['a11yr', 16:05:18 INFO - 'ts_paint', 16:05:18 INFO - 'tpaint', 16:05:18 INFO - 'sessionrestore', 16:05:18 INFO - 'sessionrestore_no_auto_restore', 16:05:18 INFO - 'tabpaint']}, 16:05:18 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:18 INFO - 'ts_paint', 16:05:18 INFO - 'tpaint', 16:05:18 INFO - 'sessionrestore', 16:05:18 INFO - 'sessionrestore_no_auto_restore', 16:05:18 INFO - 'tabpaint']}, 16:05:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:05:18 INFO - 'ts_paint', 16:05:18 INFO - 'tpaint', 16:05:18 INFO - 'sessionrestore', 16:05:18 INFO - 'sessionrestore_no_auto_restore', 16:05:18 INFO - 'tabpaint']}, 16:05:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:05:18 INFO - 'ts_paint', 16:05:18 INFO - 'tpaint', 16:05:18 INFO - 'sessionrestore', 16:05:18 INFO - 'sessionrestore_no_auto_restore', 16:05:18 INFO - 'tabpaint']}, 16:05:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['a11yr', 16:05:18 INFO - 'ts_paint', 16:05:18 INFO - 'tpaint', 16:05:18 INFO - 'sessionrestore', 16:05:18 INFO - 'sessionrestore_no_auto_restore', 16:05:18 INFO - 'tabpaint']}, 16:05:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['a11yr', 16:05:18 INFO - 'ts_paint', 16:05:18 INFO - 'tpaint', 16:05:18 INFO - 'sessionrestore', 16:05:18 INFO - 'sessionrestore_no_auto_restore', 16:05:18 INFO - 'tabpaint']}, 16:05:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['tsvgx', 16:05:18 INFO - 'tsvgr_opacity', 16:05:18 INFO - 'tart', 16:05:18 INFO - 'tscrollx', 16:05:18 INFO - 'cart', 16:05:18 INFO - 'tsvg_static']}, 16:05:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:18 INFO - 'tsvgr_opacity', 16:05:18 INFO - 'tart', 16:05:18 INFO - 'tscrollx', 16:05:18 INFO - 'cart', 16:05:18 INFO - 'tsvg_static']}, 16:05:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:05:18 INFO - 'talos_options': ['--disable-e10s'], 16:05:18 INFO - 'tests': ['tp5o']}, 16:05:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:05:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:05:18 INFO - 'talos_options': ['--disable-e10s', 16:05:18 INFO - '--xperf_path', 16:05:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:18 INFO - 'tests': ['tp5n']}, 16:05:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:05:18 INFO - 'talos_options': ['--xperf_path', 16:05:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:18 INFO - 'tests': ['tp5n']}}, 16:05:18 INFO - 'talos.zip': {'path': '', 16:05:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:05:18 INFO - Running post-action listener: _resource_record_post_action 16:05:18 INFO - [mozharness: 2017-01-30 00:05:18.555437Z] Finished populate-webroot step (success) 16:05:18 INFO - [mozharness: 2017-01-30 00:05:18.555514Z] Running create-virtualenv step. 16:05:18 INFO - Running pre-action listener: _resource_record_pre_action 16:05:18 INFO - Running main action method: create_virtualenv 16:05:18 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:18 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 16:05:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:05:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:18 INFO - Using real prefix '/tools/python27' 16:05:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:19 INFO - Installing distribute.............................................................................................................................................................................................done. 16:05:22 INFO - Installing pip.................done. 16:05:22 INFO - Return code: 0 16:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:05:22 INFO - Reading from file tmpfile_stdout 16:05:22 INFO - Output received: 16:05:22 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) 16:05:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:22 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 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:22 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 16:05:22 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 16:05:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:22 INFO - 'HOME': '/Users/cltbld', 16:05:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:22 INFO - 'LOGNAME': 'cltbld', 16:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:22 INFO - 'MOZ_NO_REMOTE': '1', 16:05:22 INFO - 'NO_EM_RESTART': '1', 16:05:22 INFO - 'PAGER': '/bin/cat', 16:05:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:22 INFO - 'PWD': '/builds/slave/test', 16:05:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:22 INFO - 'SHELL': '/bin/bash', 16:05:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:22 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:22 INFO - 'USER': 'cltbld', 16:05:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:22 INFO - 'XPC_FLAGS': '0x0', 16:05:22 INFO - 'XPC_SERVICE_NAME': '0', 16:05:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:22 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 16:05:22 INFO - Cleaning up... 16:05:22 INFO - Return code: 0 16:05:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:22 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 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:22 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 16:05:22 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 16:05:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:22 INFO - 'HOME': '/Users/cltbld', 16:05:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:22 INFO - 'LOGNAME': 'cltbld', 16:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:22 INFO - 'MOZ_NO_REMOTE': '1', 16:05:22 INFO - 'NO_EM_RESTART': '1', 16:05:22 INFO - 'PAGER': '/bin/cat', 16:05:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:22 INFO - 'PWD': '/builds/slave/test', 16:05:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:22 INFO - 'SHELL': '/bin/bash', 16:05:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:22 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:22 INFO - 'USER': 'cltbld', 16:05:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:22 INFO - 'XPC_FLAGS': '0x0', 16:05:22 INFO - 'XPC_SERVICE_NAME': '0', 16:05:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:23 INFO - Downloading/unpacking psutil>=3.1.1 16:05:23 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 16:05:23 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 16:05:23 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 16:05:23 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 16:05:23 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 16:05:23 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 16:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:05:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:27 INFO - Installing collected packages: psutil 16:05:27 INFO - Running setup.py install for psutil 16:05:27 INFO - building 'psutil._psutil_osx' extension 16:05:27 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 16:05:27 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 16:05:27 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 16:05:27 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 16:05:27 INFO - building 'psutil._psutil_posix' extension 16:05:27 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 16:05:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:05:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:05:27 INFO - ^ 16:05:27 INFO - 1 warning generated. 16:05:27 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 16:05:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:27 INFO - Successfully installed psutil 16:05:27 INFO - Cleaning up... 16:05:28 INFO - Return code: 0 16:05:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:05:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:28 INFO - 'HOME': '/Users/cltbld', 16:05:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:28 INFO - 'LOGNAME': 'cltbld', 16:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:28 INFO - 'MOZ_NO_REMOTE': '1', 16:05:28 INFO - 'NO_EM_RESTART': '1', 16:05:28 INFO - 'PAGER': '/bin/cat', 16:05:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:28 INFO - 'PWD': '/builds/slave/test', 16:05:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:28 INFO - 'SHELL': '/bin/bash', 16:05:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:28 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:28 INFO - 'USER': 'cltbld', 16:05:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:28 INFO - 'XPC_FLAGS': '0x0', 16:05:28 INFO - 'XPC_SERVICE_NAME': '0', 16:05:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:05:28 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 16:05:28 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 16:05:28 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 16:05:28 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 16:05:28 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 16:05:28 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 16:05:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:05:30 INFO - Installing collected packages: mozsystemmonitor 16:05:30 INFO - Running setup.py install for mozsystemmonitor 16:05:31 INFO - Successfully installed mozsystemmonitor 16:05:31 INFO - Cleaning up... 16:05:31 INFO - Return code: 0 16:05:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:31 INFO - 'HOME': '/Users/cltbld', 16:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:31 INFO - 'LOGNAME': 'cltbld', 16:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:31 INFO - 'MOZ_NO_REMOTE': '1', 16:05:31 INFO - 'NO_EM_RESTART': '1', 16:05:31 INFO - 'PAGER': '/bin/cat', 16:05:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:31 INFO - 'PWD': '/builds/slave/test', 16:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:31 INFO - 'SHELL': '/bin/bash', 16:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:31 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:31 INFO - 'USER': 'cltbld', 16:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:31 INFO - 'XPC_FLAGS': '0x0', 16:05:31 INFO - 'XPC_SERVICE_NAME': '0', 16:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:31 INFO - Downloading/unpacking jsonschema==2.5.1 16:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:05:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:34 INFO - Downloading functools32-3.2.3-2.tar.gz 16:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:05:34 INFO - warning: no files found matching '*.txt' 16:05:34 INFO - no previously-included directories found matching 'build' 16:05:34 INFO - no previously-included directories found matching 'dist' 16:05:34 INFO - no previously-included directories found matching '.git*' 16:05:34 INFO - Installing collected packages: jsonschema, functools32 16:05:34 INFO - Running setup.py install for functools32 16:05:34 INFO - warning: no files found matching '*.txt' 16:05:34 INFO - no previously-included directories found matching 'build' 16:05:34 INFO - no previously-included directories found matching 'dist' 16:05:34 INFO - no previously-included directories found matching '.git*' 16:05:34 INFO - Successfully installed jsonschema functools32 16:05:34 INFO - Cleaning up... 16:05:34 INFO - Return code: 0 16:05:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:05:34 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')]} 16:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:34 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')]} 16:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:34 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 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:34 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 16:05:34 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 16:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:34 INFO - 'HOME': '/Users/cltbld', 16:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:34 INFO - 'LOGNAME': 'cltbld', 16:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:34 INFO - 'MOZ_NO_REMOTE': '1', 16:05:34 INFO - 'NO_EM_RESTART': '1', 16:05:34 INFO - 'PAGER': '/bin/cat', 16:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:34 INFO - 'PWD': '/builds/slave/test', 16:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:34 INFO - 'SHELL': '/bin/bash', 16:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:34 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:34 INFO - 'USER': 'cltbld', 16:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:34 INFO - 'XPC_FLAGS': '0x0', 16:05:34 INFO - 'XPC_SERVICE_NAME': '0', 16:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:05:35 INFO - Cleaning up... 16:05:35 INFO - Return code: 0 16:05:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:05:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:35 INFO - 'HOME': '/Users/cltbld', 16:05:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:35 INFO - 'LOGNAME': 'cltbld', 16:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:35 INFO - 'MOZ_NO_REMOTE': '1', 16:05:35 INFO - 'NO_EM_RESTART': '1', 16:05:35 INFO - 'PAGER': '/bin/cat', 16:05:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:35 INFO - 'PWD': '/builds/slave/test', 16:05:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:35 INFO - 'SHELL': '/bin/bash', 16:05:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:35 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:35 INFO - 'USER': 'cltbld', 16:05:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:35 INFO - 'XPC_FLAGS': '0x0', 16:05:35 INFO - 'XPC_SERVICE_NAME': '0', 16:05:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:35 INFO - Downloading/unpacking blobuploader==1.2.4 16:05:35 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 16:05:35 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 16:05:35 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 16:05:35 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 16:05:35 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 16:05:35 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 16:05:38 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:05:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05:38 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 16:05:38 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 16:05:38 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 16:05:38 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 16:05:38 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 16:05:38 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 16:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:05:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:38 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 16:05:38 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 16:05:38 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 16:05:38 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 16:05:38 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 16:05:38 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 16:05:39 INFO - Downloading docopt-0.6.1.tar.gz 16:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:05:39 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:39 INFO - Running setup.py install for blobuploader 16:05:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:05:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:05:39 INFO - Running setup.py install for requests 16:05:40 INFO - Running setup.py install for docopt 16:05:40 INFO - Successfully installed blobuploader requests docopt 16:05:40 INFO - Cleaning up... 16:05:40 INFO - Return code: 0 16:05:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:40 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 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:40 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 16:05:40 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 16:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:40 INFO - 'HOME': '/Users/cltbld', 16:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:40 INFO - 'LOGNAME': 'cltbld', 16:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:40 INFO - 'MOZ_NO_REMOTE': '1', 16:05:40 INFO - 'NO_EM_RESTART': '1', 16:05:40 INFO - 'PAGER': '/bin/cat', 16:05:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:40 INFO - 'PWD': '/builds/slave/test', 16:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:40 INFO - 'SHELL': '/bin/bash', 16:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:40 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:40 INFO - 'USER': 'cltbld', 16:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:40 INFO - 'XPC_FLAGS': '0x0', 16:05:40 INFO - 'XPC_SERVICE_NAME': '0', 16:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:40 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Tzjloc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:40 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-RHAlI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:40 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-g0IZRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:40 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-d9s0s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-gkLhAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-C0FMIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-elzv0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-U8HV5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Keowc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-knVKPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-OkG0zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-4iN5I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-inobJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:41 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-e82Vsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:42 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-cC6DH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:42 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-jMPNbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:42 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-4HAdM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:05:42 INFO - Running setup.py install for manifestparser 16:05:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:05:42 INFO - Running setup.py install for mozcrash 16:05:42 INFO - Running setup.py install for mozdebug 16:05:42 INFO - Running setup.py install for mozdevice 16:05:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:05:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:05:42 INFO - Running setup.py install for mozfile 16:05:43 INFO - Running setup.py install for mozhttpd 16:05:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:05:43 INFO - Running setup.py install for mozinfo 16:05:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:05:43 INFO - Running setup.py install for mozInstall 16:05:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:05:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:05:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:05:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:05:43 INFO - Running setup.py install for mozleak 16:05:43 INFO - Running setup.py install for mozlog 16:05:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:05:43 INFO - Running setup.py install for moznetwork 16:05:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:05:44 INFO - Running setup.py install for mozprocess 16:05:44 INFO - Running setup.py install for mozprofile 16:05:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:05:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:05:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:05:44 INFO - Running setup.py install for mozrunner 16:05:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:05:44 INFO - Running setup.py install for mozscreenshot 16:05:44 INFO - Running setup.py install for moztest 16:05:44 INFO - Running setup.py install for mozversion 16:05:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:05:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:05:44 INFO - Cleaning up... 16:05:44 INFO - Return code: 0 16:05:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:44 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')]} 16:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:44 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')]} 16:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:44 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 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:44 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 16:05:44 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 16:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:44 INFO - 'HOME': '/Users/cltbld', 16:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:44 INFO - 'LOGNAME': 'cltbld', 16:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:44 INFO - 'MOZ_NO_REMOTE': '1', 16:05:44 INFO - 'NO_EM_RESTART': '1', 16:05:44 INFO - 'PAGER': '/bin/cat', 16:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:44 INFO - 'PWD': '/builds/slave/test', 16:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:44 INFO - 'SHELL': '/bin/bash', 16:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:44 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:44 INFO - 'USER': 'cltbld', 16:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:44 INFO - 'XPC_FLAGS': '0x0', 16:05:44 INFO - 'XPC_SERVICE_NAME': '0', 16:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:45 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-TIWgFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:45 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)) 16:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:45 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-5Npzfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:45 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)) 16:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:45 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-gWc4j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:45 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)) 16:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:45 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-O4LkmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:45 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-i3JGJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:45 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)) 16:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:45 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-PI7p7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:45 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)) 16:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:45 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-DKVQJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:45 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)) 16:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:45 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-TKCTx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:46 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)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-tX36ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:46 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)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-YyNz0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:46 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)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-596FLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:46 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)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-JFUsr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-EJBKxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:46 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)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Lu6im_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:46 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)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-LQtfhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:46 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)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-xmJb4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:46 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)) 16:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:46 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-1qEY6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:47 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)) 16:05:47 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)) 16:05:47 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)) 16:05:47 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)) 16:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:49 INFO - Downloading blessings-1.6.tar.gz 16:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:05:49 INFO - Installing collected packages: blessings 16:05:49 INFO - Running setup.py install for blessings 16:05:49 INFO - Successfully installed blessings 16:05:49 INFO - Cleaning up... 16:05:50 INFO - Return code: 0 16:05:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:50 INFO - Reading from file tmpfile_stdout 16:05:50 INFO - Current package versions: 16:05:50 INFO - blessings == 1.6 16:05:50 INFO - blobuploader == 1.2.4 16:05:50 INFO - docopt == 0.6.1 16:05:50 INFO - functools32 == 3.2.3-2 16:05:50 INFO - jsonschema == 2.5.1 16:05:50 INFO - manifestparser == 1.1 16:05:50 INFO - mozInstall == 1.12 16:05:50 INFO - mozcrash == 1.0 16:05:50 INFO - mozdebug == 0.1 16:05:50 INFO - mozdevice == 0.49 16:05:50 INFO - mozfile == 1.2 16:05:50 INFO - mozhttpd == 0.7 16:05:50 INFO - mozinfo == 0.9 16:05:50 INFO - mozleak == 0.1 16:05:50 INFO - mozlog == 3.4 16:05:50 INFO - moznetwork == 0.27 16:05:50 INFO - mozprocess == 0.24 16:05:50 INFO - mozprofile == 0.28 16:05:50 INFO - mozrunner == 6.13 16:05:50 INFO - mozscreenshot == 0.1 16:05:50 INFO - mozsystemmonitor == 0.3 16:05:50 INFO - moztest == 0.8 16:05:50 INFO - mozversion == 1.4 16:05:50 INFO - psutil == 3.1.1 16:05:50 INFO - requests == 1.2.3 16:05:50 INFO - wsgiref == 0.1.2 16:05:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:50 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 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05:50 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 16:05:50 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 16:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:50 INFO - 'HOME': '/Users/cltbld', 16:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:50 INFO - 'LOGNAME': 'cltbld', 16:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:50 INFO - 'MOZ_NO_REMOTE': '1', 16:05:50 INFO - 'NO_EM_RESTART': '1', 16:05:50 INFO - 'PAGER': '/bin/cat', 16:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:50 INFO - 'PWD': '/builds/slave/test', 16:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:50 INFO - 'SHELL': '/bin/bash', 16:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:50 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:50 INFO - 'USER': 'cltbld', 16:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:50 INFO - 'XPC_FLAGS': '0x0', 16:05:50 INFO - 'XPC_SERVICE_NAME': '0', 16:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 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)) 16:05:50 INFO - Cleaning up... 16:05:50 INFO - Return code: 0 16:05:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103b44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a22578790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, '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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 16:05: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', 'jsonschema'] in /builds/slave/test/build 16:05: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 jsonschema 16:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:50 INFO - 'HOME': '/Users/cltbld', 16:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:50 INFO - 'LOGNAME': 'cltbld', 16:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:50 INFO - 'MOZ_NO_REMOTE': '1', 16:05:50 INFO - 'NO_EM_RESTART': '1', 16:05:50 INFO - 'PAGER': '/bin/cat', 16:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:50 INFO - 'PWD': '/builds/slave/test', 16:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:50 INFO - 'SHELL': '/bin/bash', 16:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:05:50 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:50 INFO - 'USER': 'cltbld', 16:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:50 INFO - 'XPC_FLAGS': '0x0', 16:05:50 INFO - 'XPC_SERVICE_NAME': '0', 16:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:05:50 INFO - Cleaning up... 16:05:50 INFO - Return code: 0 16:05:50 INFO - Running post-action listener: _resource_record_post_action 16:05:50 INFO - Running post-action listener: _start_resource_monitoring 16:05:50 INFO - Starting resource monitoring. 16:05:50 INFO - [mozharness: 2017-01-30 00:05:50.866554Z] Finished create-virtualenv step (success) 16:05:50 INFO - [mozharness: 2017-01-30 00:05:50.867511Z] Running install step. 16:05:50 INFO - Running pre-action listener: _resource_record_pre_action 16:05:50 INFO - Running main action method: install 16:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:51 INFO - Reading from file tmpfile_stdout 16:05:51 INFO - Detecting whether we're running mozinstall >=1.0... 16:05:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:05:51 INFO - Reading from file tmpfile_stdout 16:05:51 INFO - Output received: 16:05:51 INFO - Usage: mozinstall [options] installer 16:05:51 INFO - Options: 16:05:51 INFO - -h, --help show this help message and exit 16:05:51 INFO - -d DEST, --destination=DEST 16:05:51 INFO - Directory to install application into. [default: 16:05:51 INFO - "/builds/slave/test"] 16:05:51 INFO - --app=APP Application being installed. [default: firefox] 16:05:51 INFO - mkdir: /builds/slave/test/build/application 16:05:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:06:11 INFO - Reading from file tmpfile_stdout 16:06:11 INFO - Output received: 16:06:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:06:11 INFO - Running post-action listener: _resource_record_post_action 16:06:11 INFO - [mozharness: 2017-01-30 00:06:11.382238Z] Finished install step (success) 16:06:11 INFO - [mozharness: 2017-01-30 00:06:11.382375Z] Running run-tests step. 16:06:11 INFO - Running pre-action listener: _resource_record_pre_action 16:06:11 INFO - Running main action method: run_tests 16:06:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:06:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:06:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:06:11 INFO - 2017-01-29 16:06:11.397 screenresolution[2227:27511] starting screenresolution argv=screenresolution get 16:06:11 INFO - 2017-01-29 16:06:11.399 screenresolution[2227:27511] Display 0: 1600x1200x32@60 16:06:11 INFO - 2017-01-29 16:06:11.405 screenresolution[2228:27514] starting screenresolution argv=screenresolution list 16:06:11 INFO - Available Modes on Display 0 16:06:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:06:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:06:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:06:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:06:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:06:11 INFO - Intel Iris: 16:06:11 INFO - Chipset Model: Intel Iris 16:06:11 INFO - Type: GPU 16:06:11 INFO - Bus: Built-In 16:06:11 INFO - VRAM (Dynamic, Max): 1536 MB 16:06:11 INFO - Vendor: Intel (0x8086) 16:06:11 INFO - Device ID: 0x0a2e 16:06:11 INFO - Revision ID: 0x0009 16:06:11 INFO - Displays: 16:06:11 INFO - Display: 16:06:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:06:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:06:11 INFO - Display Serial Number: 1600x1200 60 16:06:11 INFO - Main Display: Yes 16:06:11 INFO - Mirror: Off 16:06:11 INFO - Online: Yes 16:06:11 INFO - Rotation: Supported 16:06:11 INFO - Return code: 0 16:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:06:11 INFO - Python 2.7.3 16:06:11 INFO - Return code: 0 16:06:11 INFO - grabbing minidump binary from tooltool 16:06:11 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')]} 16:06:11 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 0x103922d30>, '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 0x103849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103917be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:06:11 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 16:06:11 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 16:06:11 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 16:06:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:06:11 INFO - Return code: 0 16:06:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:06:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:06:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:06:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:06:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 16:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --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 16:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcoEYJZavQ/Render', 16:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:11 INFO - 'HOME': '/Users/cltbld', 16:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:11 INFO - 'LOGNAME': 'cltbld', 16:06:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:11 INFO - 'MOZ_NO_REMOTE': '1', 16:06:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:11 INFO - 'NO_EM_RESTART': '1', 16:06:11 INFO - 'PAGER': '/bin/cat', 16:06:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:11 INFO - 'PWD': '/builds/slave/test', 16:06:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:11 INFO - 'SHELL': '/bin/bash', 16:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPNsn5BN2C/Listeners', 16:06:11 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 16:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:11 INFO - 'USER': 'cltbld', 16:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:11 INFO - 'XPC_FLAGS': '0x0', 16:06:11 INFO - 'XPC_SERVICE_NAME': '0', 16:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 16:06:11 INFO - mozversion application_buildid: 20170129144543 16:06:11 INFO - mozversion application_changeset: d859e69475796f76214f07c6d133c3a1f325156c 16:06:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:06:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:06:11 INFO - mozversion application_name: Firefox 16:06:11 INFO - mozversion application_remotingname: firefox-dev 16:06:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:06:11 INFO - mozversion application_vendor: Mozilla 16:06:11 INFO - mozversion application_version: 53.0a2 16:06:11 INFO - mozversion platform_buildid: 20170129144543 16:06:11 INFO - mozversion platform_changeset: d859e69475796f76214f07c6d133c3a1f325156c 16:06:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:06:11 INFO - mozversion platform_version: 53.0a2 16:06:11 INFO - using testdate: 1485734771 16:06:11 INFO - actual date: 1485734771 16:06:11 INFO - starting webserver on 'localhost:52843' 16:06:11 INFO - SUITE-START | Running 2 tests 16:06:11 INFO - TEST-START | dromaeo_css 16:06:11 INFO - operating with platform_type : mac_ 16:06:11 INFO - Initialising browser for dromaeo_css test... 16:06:11 INFO - TEST-INFO | started process 2238 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpnV9b_l/profile http://localhost:52843/getInfo.html) 16:06:14 INFO - PROCESS | 2238 | __metrics Screen width/height:1600/1200 16:06:14 INFO - PROCESS | 2238 | colorDepth:24 16:06:14 INFO - PROCESS | 2238 | Browser inner width/height: 1024/689 16:06:14 INFO - PROCESS | 2238 | __metrics 16:06:14 INFO - PROCESS | 2238 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:06:14 INFO - PROCESS | 2238 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:06:15 INFO - TEST-INFO | 2238: exit 0 16:06:15 INFO - Browser initialized. 16:06:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:06:15 INFO - TEST-INFO | started process 2240 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpnV9b_l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:27 INFO - PROCESS | 2240 | RSS: Main: 213135360 16:06:27 INFO - PROCESS | 2240 | 16:09:30 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52843/tests/dromaeo/cssquery-ext.html) 16:09:32 INFO - PROCESS | 2240 | RSS: Main: 389828608 16:09:32 INFO - PROCESS | 2240 | 16:11:17 INFO - PROCESS | 2240 | ************************* 16:11:17 INFO - PROCESS | 2240 | A coding exception was thrown and uncaught in a Task. 16:11:17 INFO - PROCESS | 2240 | 16:11:17 ERROR - PROCESS | 2240 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:11:17 INFO - PROCESS | 2240 | Full stack: 16:11:17 INFO - PROCESS | 2240 | ************************* 16:12:35 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52843/tests/dromaeo/cssquery-ext.html (next: http://localhost:52843/tests/dromaeo/cssquery-jquery.html) 16:12:35 INFO - PROCESS | 2240 | RSS: Main: 351195136 16:12:35 INFO - PROCESS | 2240 | 16:15:38 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52843/tests/dromaeo/cssquery-mootools.html) 16:15:38 INFO - PROCESS | 2240 | RSS: Main: 349233152 16:15:38 INFO - PROCESS | 2240 | 16:18:41 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52843/tests/dromaeo/cssquery-prototype.html) 16:18:41 INFO - PROCESS | 2240 | RSS: Main: 322686976 16:18:41 INFO - PROCESS | 2240 | 16:21:45 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52843/tests/dromaeo/cssquery-yui.html) 16:21:46 INFO - PROCESS | 2240 | RSS: Main: 319049728 16:21:46 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52843/tests/dromaeo/cssquery-yui.html (next: http://localhost:52843/tests/dromaeo/cssquery-dojo.html) 16:24:49 INFO - PROCESS | 2240 | RSS: Main: 367529984 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | __start_tp_report 16:24:49 INFO - PROCESS | 2240 | _x_x_mozilla_page_load 16:24:49 INFO - PROCESS | 2240 | _x_x_mozilla_page_load_details 16:24:49 INFO - PROCESS | 2240 | |i|pagename|runs| 16:24:49 INFO - PROCESS | 2240 | |0;dojo.html;3310.2386451116245;3327.0684208421644;3331.1172539277095;3351.6480769519217;3384.4077286474876;4845.273209018645;5845.912311315334;5849.239598852148;5857.26784151981;5912.733926973286;5674.744636491358;5696.9745445819735;5763.164341170528;5768.336641286253;5839.416058394158;5234.973825130869;5261.105612045952;5265.999460102568;5285.2600635911;5306.044911915854;5202.661826981234;5208.322918020652;5210.03614331348;5247.763850626731;5349.679019258838;5271.841844744664;5320.441353657869;5332.493413125747;5362.195670649395;5373.435789242112;5336.4129945705945;5347.866303342409;5356.758945847427;5372.140457526796;5397.109476936301;4068.776217308047;5179.896402071975;5264;5278.47215278473;5307.628466007381;5730.08318669011;5730.140478928194;5744.712764361807;5746.367899531048;5757.107648314518;6144.064619644798;6187.195664563623;6196.659183744892;6295.968520157416;6311.8737625247695;6253.187085678878;6305.842353941142;6312.558120931537;6333.619982801;6343.397377249154;5841.999999999957;5915.674637894871;5932.925644054386;5933.258342707119;5937.70311484424;6227.532935029801;6234.877722010082;6247.375262473716;6279.4662453691035;6305.527085468608;6259.655718935503;6267.4986001119805;6269.467095296951;6274.843128921722;6287.591306565058;6282.874342513124;6305.936940630627;6310.558260921784;6326.4622507087415;6336.904946425807;5114.616403769732;6128.289244084599;6176.320604733476;6190.41191086846;6327.430531252209;5191.32512773337;6283.08895210192;6286.245650521967;6305.432511074026;6325.96837015812;5063.822766203165;5066.645334826527;5071.594272458195;5072.568831649277;5083.923741143812;4406.25093734066;4440.978574927784;4446.910506925824;4457.108578284357;4514.954850451519;5812.070068789058;5815.621984570989;5823.79616713413;5827.825165245049;5841.153032810304;6204.37956204385;6245;6260.812175634738;6263.843403914939;6276.121343011982;5627.380988091307;5748.080307150836;5766.336871259775;5778.075507918713;5809.622374545641;5550.972245138749;5554.972225138848;5560.471755183251;5562.082256427644;5581.804636837773;6381.234251889803;6393.8721225576155;6412.39082287182;6425.710843012076;6426.453751431087;6202;6262.780802671885;6262.906056409249;6263.718132684131;6299.559030867796;6352.968235158794;6367.745290188341;6379.170707808141;6401.807945761635;6420.7431702731365;6236.220472440945;6278.529110316653;6290.433860952537;6304.275008374096;6309.463695585927;6211;6256.5307601930945;6276.435120839146;6309.652969086745;6338.809835704937;5176.249443830548;6129.114290130661;6201.875962480635;6234.719437625408;6239.688015599111;6181;6186.907196391968;6190;6190.442860142429;6198.566100372931;5901.026330655393;5954.7320370582565;6026.698665066817;6076.848078797889;6086.208792857077;6117.204763380732;6121.0262130506535;6136.539759517965;6152.384761523812;6192.969035154795;6073.514118870568;6086.60437071589;6093.6039157454625;6094.360092190256;6107.6640784757265 16:24:49 INFO - PROCESS | 2240 | |1;ext.html;419.6055707634822;454.2074080729127;466.421637169909;494.14019605885767;508.3137764018575;30352.937647182353;31957.201069973235;32055.35889282213;32072.037838864842;32126.35747285053;41821;42512.14975700484;42530.574694253046;44760.776196118975;44850.551494485044;9333.300002499805;9512.239020878347;9518.857217141749;9529.332946693734;9541.666041688508;8449.915500844974;9448.574814133346;9540.093691099335;9540.80918381632;9558.904410955905;8486.74539763808;11131.276467029616;11357.318560886331;11363.375014374205;11535.596254131107;11331.546738130506;11402;11416.828747568794;11422.42887855608;11439.084873210124;8339.12439193882;11262.324260544394;11294.774104517946;11346.149038822121;11349.489272982735;30585.847070764725;38923.805380973194;39324.803375983225;39394.80302598498;41326;4020.075382661975;4052.8784136475656;4064.512258528966;4075.572064933199;4083.203775263825;28578.428431431254;29086.07338009363;29553.556696649568;30879.073627791204;31204;3243.464828303327;3264.4450443424676;3289.0954987378664;3411.3177364526946;3426.5716785401823;492871;496918;497657;497720.5113974443;502311.4884425591;61990;62213.68893155505;62244;62370;62437.375626244066;62997;64530;64595.35404645988;64747.67626161933;64753;15803.841961580238;15927.964682295613;16344.75482867758;16362.918185409235;16425.425110121087;12651.93674031624;12718.809217861739;12749.426275817425;12771.169873958162;12844.48622055126;14277.214753188675;14601.853981460263;16154.111523866066;16450.6709865802;16521.173941302888;5754.6547207167705;5791.160281759121;6290.685465726787;7021.438284937295;7168.53404528704;864.9567521623893;890.3411475508077;891.6210610490516;894.2622336572354;894.4812009034745;28453.146405607866;29618.555721664194;29624.703752962196;30371;30382.69617303843;1071.8285074388061;1089.580511503077;1089.9509522071526;1097.2648325621853;1110.0342701849443;12604.243745375306;15107.697846043018;15368.154751488775;15443.150626715638;15517.827504149429;627899;633417;633812;634265;636018;59549.10676339858;59730.80538389208;59759.80480390368;59817;59955;1433.0624475843088;1442.7619442791822;1457.1330058615108;1482.5996980815335;1494.0811400988314;27662.723372766013;28204.576931345637;29369;30272;30316.696833031387;49478.50521494883;49937.75031124821;49988.50011499984;49999.500004999485;50206.497935021645;541572;544259;544456;544635;544820;38570;39153.41269880897;39367.606323936394;39490.40764388479;39679.40480892731;44547.777261113486;45249.54750452585;45340.54659453495;45887.54112458833;45888;37226.741988740694;37390.626093739804;38322.42516362201;38598.22803543969;39387.40918886162;33595.992120236435;35789.5999880011;37663.62336376711;38201.61798381981;39069.02327441837;36875.81562092173;36893.26213475769;37021.62978370182;38107.618923810405;38148.23703525969;31690.207744806565;33986.980390588324;34303.485447718806;34394.82802585971;34558.96323110311;24597.877010614833;24951.251462456155;25242.776111424526;25277.494450110527;25603 16:24:49 INFO - PROCESS | 2240 | |2;jquery.html;365.2257214704826;387.2777270390722;390.77335145615547;399.15976868691394;421.8502431636769;14291.14253144812;15237.7809775218;18367.357142500034;20697.793022069774;20863.165473381083;21762.673559896575;21921.780782192174;22327;22518.77481225187;22566.323010309716;5779;5827.41725827417;5912.231409916705;5934.851628709273;5995.010823214165;4233.407322974786;5900.468957793798;6007.579469437142;6008.639481631094;6015.819525414245;4462.352958820969;6332.303446620868;6629.138212032429;6634.834129146761;6723.260441351447;6444.677766111676;6603.141591593062;6682.93317066828;6702.4302934250645;6709.261981182066;5774;5839.124131380285;5856.414358564152;5865.88268234633;5870.97064514679;25700.614490782467;26460;26535.73464265371;26538.46923061528;26836.329091772666;2724.4687285979244;2751.2021513760988;2759.862006899647;2761.4891245119716;2797.720227977186;10670.893291067068;14728.821694264434;15324;16011.51965441027;16064;1788.5512734684817;1793.4709260768104;1806.8554515638718;1861.2275905499203;1866.72932424799;117724;119293.40353298179;119899;120221.39889300585;120576.39711801385;9599.760005999906;10398.428086455318;10937.125029997582;11527.8270825936;11739.765204695857;14582.927085364718;14588.270586470846;14616.342264598119;14643.26783660834;14677.48628797987;8605.65577376898;8786.25316848075;8804.955975220082;8949.821003580022;8953.059928707522;6860.588364698134;7547.433942454338;8785.385023048326;8808.955955220183;8934.329925255632;6981.720731170798;7075.115610548682;7086.468514861406;7095.751648692374;7112.431005519649;1860.83252507275;1903.5716963683337;1911.2259534888392;1912.6365990461768;1922.2695375757123;849.5964416901923;883.8421667615445;892.7858112966361;894.6197865907094;915.3089417489753;18272.99498527594;18540.25838966426;20446.897765511374;21722.34832955014;23004.079836806675;815.2621877201143;947.1759569174862;952.9666461673808;962.7388121560778;964.628617982082;8956.820863582692;10514.684559463076;11309.943450282695;12152.149349545447;12241.020718342512;594409;705078.4746076236;726281;739546;754093;96410;127252;129676.70323296834;130489;135364;968.6028728221536;994.174834887042;1008.415119230859;1010.1918465227789;1010.3432768700256;19295.51761205981;19789.802101978796;20033.29883454072;20119.195232191134;20188;44458;56837.43162568322;62408;64742;67407;83196.58401707953;85421.57289213514;85431;85994.57002714946;87519.12480875109;8351.58242087881;8374.069075823656;8531.402801804063;8630.913690863263;8915.153060459246;9504.809903802023;11062.944685276521;11071.778564428827;12780;13504.324783760969;11012.229143959847;11191.2725672831;11550.768984620428;11602.245854019462;11812.586559470377;11262.09903207725;11431.028362589273;11663.533458661897;11854.940725296663;11910.404479776149;11481.827772583585;11608.535658573563;11671.824922626338;12089.516419343128;12159.148859579744;8345.95827020861;8493.405461617875;8564.443311185003;8619.353548483763;8668.393212475066;9772;10713.464326783786;11512.30926144434;11681;11773.234739741889 16:24:49 INFO - PROCESS | 2240 | |3;mootools.html;1432.8548835306494;1441.5675297410774;1443.8700516953472;1454.1129910754441;1463.8335263809554;8299.087100418948;8760;8763.386562940588;8789.252913502352;8793.472391656505;7519.54882707038;7795.025621797276;7820.8044798880055;8271.751847444586;8475.618597163128;2321.9883900580476;2359.0327965534134;2363.692719946413;2364.6807680963107;2367.6685264063044;1977.6835706286997;2335.019291897407;2371.5849726297915;2382.356763673807;2383.0467812874904;2311.641695537194;2313.456337760625;2334.673145759595;2340.3447034830274;2349.0251545608553;2286.965695514577;2292.7477977422554;2302.700648915647;2324.628059510487;2329.3594261578032;2276.943076423086;2341.800946919514;2343.5195784864063;2352.235523454867;2353.5528249632516;8670.176333248332;8721.520316382597;8731.60707768152;8737.257333126692;8749.650013999497;5057.974710126426;5226.817061402832;5230.660007099526;5232.293640358541;5233.319668443078;3316.3201543683726;3419.4357930941364;3516.9120771980647;3523;3551.041218870916;1183.9581168571688;1238.962831115068;1247.1581682364367;1255.773960687076;1268.8033354830015;10763.300385474919;10784.245102842804;10933.234673572853;10962.835557466644;10976.615818446317;4437.356583295404;4687.95312046882;4755.286706993978;4769.284607308862;4772.5227477252;9520.571574279174;9691.2731545133;9782;9815.312928095107;9857.802843943224;5300;5307.57539396855;5308.681479111266;5324.707141107198;5327.254184414185;3930.9803450982563;4230.259704551752;4246.915061698749;4736.621070314367;4809.326694262806;3813.771173729585;3857.5756666766633;3903.7072219583647;3944.723869329177;3956.129651476728;1246.719488115185;1266.6706656269253;1266.8796464335874;1271.853736820259;1280.5774094548776;805.090248019734;880.9515476648846;908.795521007768;914.5792935249726;921.7234829551107;5690.9146362804595;5799.710014499258;5888.381719919346;5903.937291287523;6011.939880601226;862.4782006885869;1003.117256813999;1007.315025782475;1015.619142821442;1047.2145890582065;3866.4007078902814;3872.4191371294532;3884.3008258513173;3903.5706072332023;4036.273470775289;10044.347117437343;10078.395296282246;10416.843747343795;10476.319039262424;10484.370937743759;9956.651517197008;10024.849627255597;10401.68794936153;10422.791544169075;10447.582096716198;7964.123946365895;8054.355651547862;8103.959480202561;8133.552654604054;8144.511329320259;5456.48163424474;5599.8880022400135;5605;5808.36108028125;5823.592348535732;9440.433573985583;9504.85742713846;9551.188149007412;9592.568334425107;9606.615735370508;9313.580888859882;9559.235261179228;9562.713118606453;9800.11798938099;9811.215102791617;6750.729970801113;6969.54697944632;6978.197507286727;7065.399441047569;7310.853782924418;7559.886601700869;7692;7694.653740581799;7713.112992005991;7888.921110788819;7059.188193357624;7305.232950540117;7386.298301661333;7410.11078670563;7508.474406791473;5871.383504732113;6954.374106330454;7027.754028608974;7032.1912980007955;7057.0472986146215;6277.623342599459;6489.935100648933;6572.8356791080605;6620.5034622402545;6631.635260060743;5047.41954675217;5061.063703214917;5091.1854103343285;5109.821156259513;5145.228215767665;4949.678270912379;4977.411586761387;5106.595686186329;5250.684958902478;5329.907368989426 16:24:49 INFO - PROCESS | 2240 | |4;prototype.html;314.96535381108083;363.94540818877164;365.5503730411594;371.9293334266487;374.0648379052369;5246.081935661258;5247;5258.0272649559765;5260.237820330184;5315.548178404831;4903.141950158726;4921.188003979348;5194.948050519493;5199.68801871888;5235.397929238139;3401.217719924419;3449.8965031048983;3558.7153027757845;3918.686505079601;3997.8800635980892;4076.3274059780247;4079.9188215122867;4080.8979775505554;4097.426360309559;4114.835406583733;3341.5154802553616;4026.11425486394;4066.373450619746;4077.5932303355444;4100.36444351126;3813.713971452138;3906.9804650976707;4026.993251687078;4090.6931980101613;4104.630583247492;2980.1820889257538;3134.714766945541;3578.785272883635;3594.155373487228;3608.0979755061235;5045.318881950926;5062.367204099488;5073.315102461157;5085;5119.385673719177;3816.3971132124575;4502.549745025504;4615.423072115986;4646.210144275481;4668.451976497852;5492.588055895823;5506.972465137648;5516.834494965157;5533.624489061669;5541.612087153901;3394.8981530554124;3727.9189035179766;4011.117554138085;4048.1903619276263;4061.3907913813164;4881.072596206709;5427.929053210092;5508.586855985777;5702.857428564236;5858.150568167634;3097.4424603571124;3829.476881269239;3833.463315135883;3922.9607703922597;4082.7142100053306;3473.7394695397948;3754.9812250939117;4172.749635021908;4172.7704976226;4193.574184777191;3539.6549311261556;4634.443866736014;4717.4525756091325;4736.384270044941;4785.444730462614;5533.3083364579425;5536.584756143306;5558.583106267046;5599.440055994368;5606.271184746039;1180.226951346869;1253.6489782860813;1282.5126451948386;1326.2374134872487;1369.5343583181766;862.7368652561029;874.3879284500874;905.7780843693206;920.5593246569098;971.5142428785607;4736.384270044872;4742.288656701522;5109.540141387293;5142.871428214325;5164.586833053347;5175;5496.047499912614;5668.206451096849;5695.430456954271;5709.942900571024;4777.331173635694;4882.584980276716;4973.42805577356;5123.667846359973;5130.563902068366;2395.47299594089;2694.8248363856287;2767.861606919646;2899.289674029876;2899.942001159965;5311.336082989626;5368.302120724281;5431.565474762009;5746.310442746897;5749.8275051748515;4685.882852928704;4702.717836929795;5457.945420545744;5656;5699.829005129853;4712.151812673752;4923.0153969205585;5095.898082038412;5116.923246151311;5606.579506537026;4565.908681826279;4930.359053323045;5009.7244651544515;5148.198130654241;5438.757768940233;4545.568171023748;5276.788928442819;5307.310049693515;5388.676679399248;5398.757055932414;5447.400785913467;5665.915011274752;5699.430056994267;5709;5721.22763426932;3675.4486826976167;3689.1883785567134;3694.2057457646733;3702.7593206441493;3703.9814800925824;4988.678000329843;5248.475152484721;5500.58745594074;5521.613487056028;5602.85992850182;4673.532646735299;4807.687500312469;4852.660313778002;5312.831177141023;5342.599305052215;4586.628827811623;4965.28003439492;5146.536811686966;5299.364076310867;5336.399080275979;4494.842680506166;4509;5265.5252031545115;5306.973465132804;5415.945840541702;4708.327504546459;5083.822066227664;5173.844784656466;5213.348331458567;5432.9185062223305;5099.592032637454;5313.574914006793;5396.973015135056;5402.621816472809;5421.430749771375 16:24:49 INFO - PROCESS | 2240 | |5;yui.html;691.6472598974522;751.6467260387616;780.3601047141346;798.5887268056949;823.1644880446348;14941.850581494182;15114.924425377885;15650.530484085495;15778.842211577896;15781.132037737934;13428.261445620486;13608.455661773518;14182;14331.498397556088;14657;846.7205822078699;854.3506934729588;857.2798848966867;857.5669287010052;860.8794768732382;868.9087645797196;869.2871845087031;869.3479890082439;871.7646235516406;873.3973558244822;925.6713866577369;925.9722208333761;928.0163027191165;928.4429342394577;929.1544694328163;878.0736323179044;878.7627340618061;891.781513529183;922.921551668109;923.7413524213231;686.1526015371013;686.4679873098339;687.4363022321699;687.8761822871882;688.3735800421642;13481.932590337083;13673.521426750116;13821.239831809247;13842.930785346109;14024.158550487004;10980.450977451095;11218.214724969255;11258.324500529994;11320.716982075513;11604.245724027996;10714.624988125379;10714.624988125455;11042.723931901686;11502.539898404053;11551.53793848245;4523.547645235483;4573.291139873325;4573.382593349888;4644.233701439259;4730.5032971538185;101119.49440252752;103143;105046;105159;105551;10769.138468922467;10995.120390368911;11045.83431248532;11081.445927703582;11409.03023243017;21170;21395.786042139378;21565.24521641735;21587;21625.783742162377;7426.2945020223;7569.810754731066;7582.900559238881;7663.9616801916745;7725.575093369806;4224.683148763855;4290.957090429119;4355.60799528044;4381.6494680425485;4382.452193475816;3462.307538492312;3526.2771131917893;3530.505729197914;3539.9292014159573;3563.6436356364156;642.3512252624882;647.3106141958799;652.7356420649644;652.8792173447832;653.5621133840339;485.87367284505575;490.50214032756065;516.7003138179922;556.4935908323406;594.649156997365;9458.243340532741;9883.11052005323;10041.648542300984;10046.648367307109;10059.949700251453;514.8661348049534;537.4437457231746;539.6438350688527;539.9946000539944;546.7375659683374;4436.378906953029;4457.153140903218;4790.305405716152;4799.9760001199775;4813.518648135158;93816.53091734498;93936.53031734798;98004.50997744966;99117.5132373015;101109;51674.74162629238;58161.70919145462;76199;85270;88881.66677499843;70869;71562.2109447268;72417;73595.63202183954;75167.62416187994;10594.31136976094;10843.132549396187;11308.604198853001;11438.599649012245;11526;46000.30999535076;46252.768736156104;47156.7642161787;47635;51970;54011.45988540064;68651.65674171597;69600.65199674171;72235.63882180555;72341.27658723346;12501.187422817487;12840.486380544673;12893.806592900926;13222.272774997467;13747.312634368041;14110.78833817473;14742;14931.776023359875;15135.318910649268;15556.299966501309;13402.144024229849;13655.112417693215;14077.577672669837;14191.716165676835;14718.705625887636;13466.865331346562;13678.537863184325;13721.656958575717;13752.587422377344;14215.573532794033;13043.934780326417;13289.933550332187;13855.653608659864;14000.299985000913;14093.436262549383;10955.56177752881;11328.376939268419;11619.883801161881;11777.52889884395;12039.277643341427;11093.5562577496;11289.322640641587;11323.547058117912;11354.375509346735;11361.261518001304 16:24:49 INFO - PROCESS | 2240 | __end_tp_report 16:24:49 INFO - PROCESS | 2240 | __start_cc_report 16:24:49 INFO - PROCESS | 2240 | _x_x_mozilla_cycle_collect,1917 16:24:49 INFO - PROCESS | 2240 | __end_cc_report 16:24:49 INFO - PROCESS | 2240 | __startTimestamp1485735889259__endTimestamp 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | ------- Summary: start ------- 16:24:49 INFO - PROCESS | 2240 | Number of tests: 6 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | [#0] dojo.html Cycles:165 Average:5788.78 Median:6076.85 stddev:661.65 (10.9%) stddev-sans-first:634.47 16:24:49 INFO - PROCESS | 2240 | Values: 3310.2 3327.1 3331.1 3351.6 3384.4 4845.3 5845.9 5849.2 5857.3 5912.7 5674.7 5697.0 5763.2 5768.3 5839.4 5235.0 5261.1 5266.0 5285.3 5306.0 5202.7 5208.3 5210.0 5247.8 5349.7 5271.8 5320.4 5332.5 5362.2 5373.4 5336.4 5347.9 5356.8 5372.1 5397.1 4068.8 5179.9 5264.0 5278.5 5307.6 5730.1 5730.1 5744.7 5746.4 5757.1 6144.1 6187.2 6196.7 6296.0 6311.9 6253.2 6305.8 6312.6 6333.6 6343.4 5842.0 5915.7 5932.9 5933.3 5937.7 6227.5 6234.9 6247.4 6279.5 6305.5 6259.7 6267.5 6269.5 6274.8 6287.6 6282.9 6305.9 6310.6 6326.5 6336.9 5114.6 6128.3 6176.3 6190.4 6327.4 5191.3 6283.1 6286.2 6305.4 6326.0 5063.8 5066.6 5071.6 5072.6 5083.9 4406.3 4441.0 4446.9 4457.1 4515.0 5812.1 5815.6 5823.8 5827.8 5841.2 6204.4 6245.0 6260.8 6263.8 6276.1 5627.4 5748.1 5766.3 5778.1 5809.6 5551.0 5555.0 5560.5 5562.1 5581.8 6381.2 6393.9 6412.4 6425.7 6426.5 6202.0 6262.8 6262.9 6263.7 6299.6 6353.0 6367.7 6379.2 6401.8 6420.7 6236.2 6278.5 6290.4 6304.3 6309.5 6211.0 6256.5 6276.4 6309.7 6338.8 5176.2 6129.1 6201.9 6234.7 6239.7 6181.0 6186.9 6190.0 6190.4 6198.6 5901.0 5954.7 6026.7 6076.8 6086.2 6117.2 6121.0 6136.5 6152.4 6193.0 6073.5 6086.6 6093.6 6094.4 6107.7 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | [#1] ext.html Cycles:180 Average:69365.43 Median:38446.21 stddev:149777.58 (389.6%) stddev-sans-first:150108.29 16:24:49 INFO - PROCESS | 2240 | Values: 419.6 454.2 466.4 494.1 508.3 30352.9 31957.2 32055.4 32072.0 32126.4 41821.0 42512.1 42530.6 44760.8 44850.6 9333.3 9512.2 9518.9 9529.3 9541.7 8449.9 9448.6 9540.1 9540.8 9558.9 8486.7 11131.3 11357.3 11363.4 11535.6 11331.5 11402.0 11416.8 11422.4 11439.1 8339.1 11262.3 11294.8 11346.1 11349.5 30585.8 38923.8 39324.8 39394.8 41326.0 4020.1 4052.9 4064.5 4075.6 4083.2 28578.4 29086.1 29553.6 30879.1 31204.0 3243.5 3264.4 3289.1 3411.3 3426.6 492871.0 496918.0 497657.0 497720.5 502311.5 61990.0 62213.7 62244.0 62370.0 62437.4 62997.0 64530.0 64595.4 64747.7 64753.0 15803.8 15928.0 16344.8 16362.9 16425.4 12651.9 12718.8 12749.4 12771.2 12844.5 14277.2 14601.9 16154.1 16450.7 16521.2 5754.7 5791.2 6290.7 7021.4 7168.5 865.0 890.3 891.6 894.3 894.5 28453.1 29618.6 29624.7 30371.0 30382.7 1071.8 1089.6 1090.0 1097.3 1110.0 12604.2 15107.7 15368.2 15443.2 15517.8 627899.0 633417.0 633812.0 634265.0 636018.0 59549.1 59730.8 59759.8 59817.0 59955.0 1433.1 1442.8 1457.1 1482.6 1494.1 27662.7 28204.6 29369.0 30272.0 30316.7 49478.5 49937.8 49988.5 49999.5 50206.5 541572.0 544259.0 544456.0 544635.0 544820.0 38570.0 39153.4 39367.6 39490.4 39679.4 44547.8 45249.5 45340.5 45887.5 45888.0 37226.7 37390.6 38322.4 38598.2 39387.4 33596.0 35789.6 37663.6 38201.6 39069.0 36875.8 36893.3 37021.6 38107.6 38148.2 31690.2 33987.0 34303.5 34394.8 34559.0 24597.9 24951.3 25242.8 25277.5 25603.0 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | [#2] jquery.html Cycles:180 Average:38565.63 Median:2760.68 stddev:117001.58 (4238.2%) stddev-sans-first:117294.64 16:24:49 INFO - PROCESS | 2240 | Values: 365.2 387.3 390.8 399.2 421.9 14291.1 15237.8 18367.4 20697.8 20863.2 21762.7 21921.8 22327.0 22518.8 22566.3 5779.0 5827.4 5912.2 5934.9 5995.0 4233.4 5900.5 6007.6 6008.6 6015.8 4462.4 6332.3 6629.1 6634.8 6723.3 6444.7 6603.1 6682.9 6702.4 6709.3 5774.0 5839.1 5856.4 5865.9 5871.0 25700.6 26460.0 26535.7 26538.5 26836.3 2724.5 2751.2 2759.9 2761.5 2797.7 10670.9 14728.8 15324.0 16011.5 16064.0 1788.6 1793.5 1806.9 1861.2 1866.7 117724.0 119293.4 119899.0 120221.4 120576.4 9599.8 10398.4 10937.1 11527.8 11739.8 14582.9 14588.3 14616.3 14643.3 14677.5 8605.7 8786.3 8805.0 8949.8 8953.1 6860.6 7547.4 8785.4 8809.0 8934.3 6981.7 7075.1 7086.5 7095.8 7112.4 1860.8 1903.6 1911.2 1912.6 1922.3 849.6 883.8 892.8 894.6 915.3 18273.0 18540.3 20446.9 21722.3 23004.1 815.3 947.2 953.0 962.7 964.6 8956.8 10514.7 11309.9 12152.1 12241.0 594409.0 705078.5 726281.0 739546.0 754093.0 96410.0 127252.0 129676.7 130489.0 135364.0 968.6 994.2 1008.4 1010.2 1010.3 19295.5 19789.8 20033.3 20119.2 20188.0 44458.0 56837.4 62408.0 64742.0 67407.0 83196.6 85421.6 85431.0 85994.6 87519.1 8351.6 8374.1 8531.4 8630.9 8915.2 9504.8 11062.9 11071.8 12780.0 13504.3 11012.2 11191.3 11550.8 11602.2 11812.6 11262.1 11431.0 11663.5 11854.9 11910.4 11481.8 11608.5 11671.8 12089.5 12159.1 8346.0 8493.4 8564.4 8619.4 8668.4 9772.0 10713.5 11512.3 11681.0 11773.2 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | [#3] mootools.html Cycles:180 Average:5532.61 Median:5127.52 stddev:3033.28 (59.2%) stddev-sans-first:3026.14 16:24:49 INFO - PROCESS | 2240 | Values: 1432.9 1441.6 1443.9 1454.1 1463.8 8299.1 8760.0 8763.4 8789.3 8793.5 7519.5 7795.0 7820.8 8271.8 8475.6 2322.0 2359.0 2363.7 2364.7 2367.7 1977.7 2335.0 2371.6 2382.4 2383.0 2311.6 2313.5 2334.7 2340.3 2349.0 2287.0 2292.7 2302.7 2324.6 2329.4 2276.9 2341.8 2343.5 2352.2 2353.6 8670.2 8721.5 8731.6 8737.3 8749.7 5058.0 5226.8 5230.7 5232.3 5233.3 3316.3 3419.4 3516.9 3523.0 3551.0 1184.0 1239.0 1247.2 1255.8 1268.8 10763.3 10784.2 10933.2 10962.8 10976.6 4437.4 4688.0 4755.3 4769.3 4772.5 9520.6 9691.3 9782.0 9815.3 9857.8 5300.0 5307.6 5308.7 5324.7 5327.3 3931.0 4230.3 4246.9 4736.6 4809.3 3813.8 3857.6 3903.7 3944.7 3956.1 1246.7 1266.7 1266.9 1271.9 1280.6 805.1 881.0 908.8 914.6 921.7 5690.9 5799.7 5888.4 5903.9 6011.9 862.5 1003.1 1007.3 1015.6 1047.2 3866.4 3872.4 3884.3 3903.6 4036.3 10044.3 10078.4 10416.8 10476.3 10484.4 9956.7 10024.8 10401.7 10422.8 10447.6 7964.1 8054.4 8104.0 8133.6 8144.5 5456.5 5599.9 5605.0 5808.4 5823.6 9440.4 9504.9 9551.2 9592.6 9606.6 9313.6 9559.2 9562.7 9800.1 9811.2 6750.7 6969.5 6978.2 7065.4 7310.9 7559.9 7692.0 7694.7 7713.1 7888.9 7059.2 7305.2 7386.3 7410.1 7508.5 5871.4 6954.4 7027.8 7032.2 7057.0 6277.6 6489.9 6572.8 6620.5 6631.6 5047.4 5061.1 5091.2 5109.8 5145.2 4949.7 4977.4 5106.6 5250.7 5329.9 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | [#4] prototype.html Cycles:180 Average:4405.38 Median:4947.82 stddev:1321.66 (26.7%) stddev-sans-first:1289.22 16:24:49 INFO - PROCESS | 2240 | Values: 315.0 363.9 365.6 371.9 374.1 5246.1 5247.0 5258.0 5260.2 5315.5 4903.1 4921.2 5194.9 5199.7 5235.4 3401.2 3449.9 3558.7 3918.7 3997.9 4076.3 4079.9 4080.9 4097.4 4114.8 3341.5 4026.1 4066.4 4077.6 4100.4 3813.7 3907.0 4027.0 4090.7 4104.6 2980.2 3134.7 3578.8 3594.2 3608.1 5045.3 5062.4 5073.3 5085.0 5119.4 3816.4 4502.5 4615.4 4646.2 4668.5 5492.6 5507.0 5516.8 5533.6 5541.6 3394.9 3727.9 4011.1 4048.2 4061.4 4881.1 5427.9 5508.6 5702.9 5858.2 3097.4 3829.5 3833.5 3923.0 4082.7 3473.7 3755.0 4172.7 4172.8 4193.6 3539.7 4634.4 4717.5 4736.4 4785.4 5533.3 5536.6 5558.6 5599.4 5606.3 1180.2 1253.6 1282.5 1326.2 1369.5 862.7 874.4 905.8 920.6 971.5 4736.4 4742.3 5109.5 5142.9 5164.6 5175.0 5496.0 5668.2 5695.4 5709.9 4777.3 4882.6 4973.4 5123.7 5130.6 2395.5 2694.8 2767.9 2899.3 2899.9 5311.3 5368.3 5431.6 5746.3 5749.8 4685.9 4702.7 5457.9 5656.0 5699.8 4712.2 4923.0 5095.9 5116.9 5606.6 4565.9 4930.4 5009.7 5148.2 5438.8 4545.6 5276.8 5307.3 5388.7 5398.8 5447.4 5665.9 5699.4 5709.0 5721.2 3675.4 3689.2 3694.2 3702.8 3704.0 4988.7 5248.5 5500.6 5521.6 5602.9 4673.5 4807.7 4852.7 5312.8 5342.6 4586.6 4965.3 5146.5 5299.4 5336.4 4494.8 4509.0 5265.5 5307.0 5415.9 4708.3 5083.8 5173.8 5213.3 5432.9 5099.6 5313.6 5397.0 5402.6 5421.4 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - PROCESS | 2240 | [#5] yui.html Cycles:180 Average:19555.00 Median:4323.28 stddev:27526.37 (636.7%) stddev-sans-first:27567.14 16:24:49 INFO - PROCESS | 2240 | Values: 691.6 751.6 780.4 798.6 823.2 14941.9 15114.9 15650.5 15778.8 15781.1 13428.3 13608.5 14182.0 14331.5 14657.0 846.7 854.4 857.3 857.6 860.9 868.9 869.3 869.3 871.8 873.4 925.7 926.0 928.0 928.4 929.2 878.1 878.8 891.8 922.9 923.7 686.2 686.5 687.4 687.9 688.4 13481.9 13673.5 13821.2 13842.9 14024.2 10980.5 11218.2 11258.3 11320.7 11604.2 10714.6 10714.6 11042.7 11502.5 11551.5 4523.5 4573.3 4573.4 4644.2 4730.5 101119.5 103143.0 105046.0 105159.0 105551.0 10769.1 10995.1 11045.8 11081.4 11409.0 21170.0 21395.8 21565.2 21587.0 21625.8 7426.3 7569.8 7582.9 7664.0 7725.6 4224.7 4291.0 4355.6 4381.6 4382.5 3462.3 3526.3 3530.5 3539.9 3563.6 642.4 647.3 652.7 652.9 653.6 485.9 490.5 516.7 556.5 594.6 9458.2 9883.1 10041.6 10046.6 10059.9 514.9 537.4 539.6 540.0 546.7 4436.4 4457.2 4790.3 4800.0 4813.5 93816.5 93936.5 98004.5 99117.5 101109.0 51674.7 58161.7 76199.0 85270.0 88881.7 70869.0 71562.2 72417.0 73595.6 75167.6 10594.3 10843.1 11308.6 11438.6 11526.0 46000.3 46252.8 47156.8 47635.0 51970.0 54011.5 68651.7 69600.7 72235.6 72341.3 12501.2 12840.5 12893.8 13222.3 13747.3 14110.8 14742.0 14931.8 15135.3 15556.3 13402.1 13655.1 14077.6 14191.7 14718.7 13466.9 13678.5 13721.7 13752.6 14215.6 13043.9 13289.9 13855.7 14000.3 14093.4 10955.6 11328.4 11619.9 11777.5 12039.3 11093.6 11289.3 11323.5 11354.4 11361.3 16:24:49 INFO - PROCESS | 2240 | -------- Summary: end -------- 16:24:49 INFO - PROCESS | 2240 | 16:24:49 INFO - TEST-INFO | 2240: exit 0 16:24:49 INFO - TEST-OK | dromaeo_css | took 1117927ms 16:24:49 INFO - TEST-START | kraken 16:24:49 INFO - operating with platform_type : mac_ 16:24:49 INFO - Initialising browser for kraken test... 16:24:49 INFO - TEST-INFO | started process 2243 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpHg9rLj/profile http://localhost:52843/getInfo.html) 16:24:52 INFO - PROCESS | 2243 | __metrics Screen width/height:1600/1200 16:24:52 INFO - PROCESS | 2243 | colorDepth:24 16:24:52 INFO - PROCESS | 2243 | Browser inner width/height: 1024/689 16:24:52 INFO - PROCESS | 2243 | __metrics 16:24:52 INFO - PROCESS | 2243 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:24:52 INFO - PROCESS | 2243 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:24:53 INFO - TEST-INFO | 2243: exit 0 16:24:53 INFO - Browser initialized. 16:24:53 INFO - Running cycle 1/1 for kraken test... 16:24:53 INFO - TEST-INFO | started process 2244 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpHg9rLj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:05 INFO - PROCESS | 2244 | RSS: Main: 212492288 16:25:05 INFO - PROCESS | 2244 | 16:25:07 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52843/tests/kraken/driver.html?testName=audio-beat-detection) 16:25:08 INFO - PROCESS | 2244 | RSS: Main: 263729152 16:25:08 INFO - PROCESS | 2244 | 16:25:11 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52843/tests/kraken/driver.html?testName=audio-dft) 16:25:12 INFO - PROCESS | 2244 | RSS: Main: 276385792 16:25:12 INFO - PROCESS | 2244 | 16:25:15 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52843/tests/kraken/driver.html?testName=audio-fft) 16:25:15 INFO - PROCESS | 2244 | RSS: Main: 374693888 16:25:15 INFO - PROCESS | 2244 | 16:25:18 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52843/tests/kraken/driver.html?testName=audio-oscillator) 16:25:18 INFO - PROCESS | 2244 | RSS: Main: 278323200 16:25:18 INFO - PROCESS | 2244 | 16:25:20 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:21 INFO - PROCESS | 2244 | RSS: Main: 279298048 16:25:21 INFO - PROCESS | 2244 | 16:25:24 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52843/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:24 INFO - PROCESS | 2244 | RSS: Main: 320393216 16:25:24 INFO - PROCESS | 2244 | 16:25:27 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52843/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:28 INFO - PROCESS | 2244 | RSS: Main: 318889984 16:25:28 INFO - PROCESS | 2244 | 16:25:31 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52843/tests/kraken/driver.html?testName=json-parse-financial) 16:25:32 INFO - PROCESS | 2244 | RSS: Main: 319377408 16:25:32 INFO - PROCESS | 2244 | 16:25:33 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:34 INFO - PROCESS | 2244 | RSS: Main: 294039552 16:25:34 INFO - PROCESS | 2244 | 16:25:36 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52843/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:36 INFO - PROCESS | 2244 | RSS: Main: 297615360 16:25:36 INFO - PROCESS | 2244 | 16:25:39 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:39 INFO - PROCESS | 2244 | RSS: Main: 300015616 16:25:39 INFO - PROCESS | 2244 | 16:25:42 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:25:43 INFO - PROCESS | 2244 | RSS: Main: 317984768 16:25:43 INFO - PROCESS | 2244 | 16:25:46 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:25:46 INFO - PROCESS | 2244 | RSS: Main: 311234560 16:25:46 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:52843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52843/tests/kraken/driver.html?testName=ai-astar) 16:25:48 INFO - PROCESS | 2244 | RSS: Main: 355684352 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | __start_tp_report 16:25:48 INFO - PROCESS | 2244 | _x_x_mozilla_page_load 16:25:48 INFO - PROCESS | 2244 | _x_x_mozilla_page_load_details 16:25:48 INFO - PROCESS | 2244 | |i|pagename|runs| 16:25:48 INFO - PROCESS | 2244 | |0;ai-astar;114;114;112;112;114;113;113;114;113;113 16:25:48 INFO - PROCESS | 2244 | |1;audio-beat-detection;142;110;107;141;114;109;106;108;128;109 16:25:48 INFO - PROCESS | 2244 | |2;audio-dft;259;229;186;182;184;186;195;223;186;184 16:25:48 INFO - PROCESS | 2244 | |3;audio-fft;84;59;62;105;85;73;60;59;76;58 16:25:48 INFO - PROCESS | 2244 | |4;audio-oscillator;90;69;84;70;70;89;116;98;68;79 16:25:48 INFO - PROCESS | 2244 | |5;imaging-gaussian-blur;87;85;87;85;87;85;90;122;89;84 16:25:48 INFO - PROCESS | 2244 | |6;imaging-darkroom;132;153;97;102;134;95;94;94;94;95 16:25:48 INFO - PROCESS | 2244 | |7;imaging-desaturate;86;112;70;112;139;142;88;85;87;87 16:25:48 INFO - PROCESS | 2244 | |8;json-parse-financial;56;55;54;56;59;58;58;57;57;57 16:25:48 INFO - PROCESS | 2244 | |9;json-stringify-tinderbox;74;72;66;79;76;74;76;74;75;75 16:25:48 INFO - PROCESS | 2244 | |10;stanford-crypto-aes;83;84;84;84;85;83;88;90;87;84 16:25:48 INFO - PROCESS | 2244 | |11;stanford-crypto-ccm;138;139;139;135;140;141;141;143;197;155 16:25:48 INFO - PROCESS | 2244 | |12;stanford-crypto-pbkdf2;172;169;168;169;168;167;167;170;165;169 16:25:48 INFO - PROCESS | 2244 | |13;stanford-crypto-sha256-iterative;67;67;64;63;67;70;82;88;84;74 16:25:48 INFO - PROCESS | 2244 | __end_tp_report 16:25:48 INFO - PROCESS | 2244 | __start_cc_report 16:25:48 INFO - PROCESS | 2244 | _x_x_mozilla_cycle_collect,2000 16:25:48 INFO - PROCESS | 2244 | __end_cc_report 16:25:48 INFO - PROCESS | 2244 | __startTimestamp1485735948952__endTimestamp 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | ------- Summary: start ------- 16:25:48 INFO - PROCESS | 2244 | Number of tests: 14 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 16:25:48 INFO - PROCESS | 2244 | Values: 114.0 114.0 112.0 112.0 114.0 113.0 113.0 114.0 113.0 113.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:112.00 stddev:14.18 (12.7%) stddev-sans-first:11.92 16:25:48 INFO - PROCESS | 2244 | Values: 142.0 110.0 107.0 141.0 114.0 109.0 106.0 108.0 128.0 109.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#2] audio-dft Cycles:10 Average:201.40 Median:190.50 stddev:26.42 (13.9%) stddev-sans-first:18.01 16:25:48 INFO - PROCESS | 2244 | Values: 259.0 229.0 186.0 182.0 184.0 186.0 195.0 223.0 186.0 184.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#3] audio-fft Cycles:10 Average:72.10 Median:67.50 stddev:15.62 (23.1%) stddev-sans-first:15.97 16:25:48 INFO - PROCESS | 2244 | Values: 84.0 59.0 62.0 105.0 85.0 73.0 60.0 59.0 76.0 58.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:81.50 stddev:15.54 (19.1%) stddev-sans-first:16.30 16:25:48 INFO - PROCESS | 2244 | Values: 90.0 69.0 84.0 70.0 70.0 89.0 116.0 98.0 68.0 79.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:87.00 stddev:11.37 (13.1%) stddev-sans-first:12.00 16:25:48 INFO - PROCESS | 2244 | Values: 87.0 85.0 87.0 85.0 87.0 85.0 90.0 122.0 89.0 84.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:94.00 stddev:21.98 (23.4%) stddev-sans-first:21.69 16:25:48 INFO - PROCESS | 2244 | Values: 132.0 153.0 97.0 102.0 134.0 95.0 94.0 94.0 94.0 95.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#7] imaging-desaturate Cycles:10 Average:100.80 Median:85.50 stddev:24.43 (28.6%) stddev-sans-first:25.31 16:25:48 INFO - PROCESS | 2244 | Values: 86.0 112.0 70.0 112.0 139.0 142.0 88.0 85.0 87.0 87.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.49 (2.6%) stddev-sans-first:1.56 16:25:48 INFO - PROCESS | 2244 | Values: 56.0 55.0 54.0 56.0 59.0 58.0 58.0 57.0 57.0 57.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#9] json-stringify-tinderbox Cycles:10 Average:74.10 Median:75.00 stddev:3.38 (4.5%) stddev-sans-first:3.59 16:25:48 INFO - PROCESS | 2244 | Values: 74.0 72.0 66.0 79.0 76.0 74.0 76.0 74.0 75.0 75.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:2.35 (2.8%) stddev-sans-first:2.35 16:25:48 INFO - PROCESS | 2244 | Values: 83.0 84.0 84.0 84.0 85.0 83.0 88.0 90.0 87.0 84.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:141.00 stddev:18.42 (13.1%) stddev-sans-first:19.26 16:25:48 INFO - PROCESS | 2244 | Values: 138.0 139.0 139.0 135.0 140.0 141.0 141.0 143.0 197.0 155.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.00 stddev:1.90 (1.1%) stddev-sans-first:1.50 16:25:48 INFO - PROCESS | 2244 | Values: 172.0 169.0 168.0 169.0 168.0 167.0 167.0 170.0 165.0 169.0 16:25:48 INFO - PROCESS | 2244 | 16:25:48 INFO - PROCESS | 2244 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:72.00 stddev:8.97 (12.5%) stddev-sans-first:9.28 16:25:48 INFO - PROCESS | 2244 | Values: 67.0 67.0 64.0 63.0 67.0 70.0 82.0 88.0 84.0 74.0 16:25:48 INFO - PROCESS | 2244 | -------- Summary: end -------- 16:25:48 INFO - PROCESS | 2244 | 16:25:49 INFO - TEST-INFO | 2244: exit 0 16:25:49 INFO - TEST-OK | kraken | took 59938ms 16:25:49 INFO - SUITE-END | took 1177s 16:25:50 INFO - Completed test suite (00:19:38) 16:25:50 INFO - javascript benchmark 16:25:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.2386451116245, 3327.0684208421644, 3331.1172539277095, 3351.6480769519217, 3384.4077286474876, 4845.273209018645, 5845.912311315334, 5849.239598852148, 5857.26784151981, 5912.733926973286, 5674.744636491358, 5696.9745445819735, 5763.164341170528, 5768.336641286253, 5839.416058394158, 5234.973825130869, 5261.105612045952, 5265.999460102568, 5285.2600635911, 5306.044911915854, 5202.661826981234, 5208.322918020652, 5210.03614331348, 5247.763850626731, 5349.679019258838, 5271.841844744664, 5320.441353657869, 5332.493413125747, 5362.195670649395, 5373.435789242112, 5336.4129945705945, 5347.866303342409, 5356.758945847427, 5372.140457526796, 5397.109476936301, 4068.776217308047, 5179.896402071975, 5264.0, 5278.47215278473, 5307.628466007381, 5730.08318669011, 5730.140478928194, 5744.712764361807, 5746.367899531048, 5757.107648314518, 6144.064619644798, 6187.195664563623, 6196.659183744892, 6295.968520157416, 6311.8737625247695, 6253.187085678878, 6305.842353941142, 6312.558120931537, 6333.619982801, 6343.397377249154, 5841.999999999957, 5915.674637894871, 5932.925644054386, 5933.258342707119, 5937.70311484424, 6227.532935029801, 6234.877722010082, 6247.375262473716, 6279.4662453691035, 6305.527085468608, 6259.655718935503, 6267.4986001119805, 6269.467095296951, 6274.843128921722, 6287.591306565058, 6282.874342513124, 6305.936940630627, 6310.558260921784, 6326.4622507087415, 6336.904946425807, 5114.616403769732, 6128.289244084599, 6176.320604733476, 6190.41191086846, 6327.430531252209, 5191.32512773337, 6283.08895210192, 6286.245650521967, 6305.432511074026, 6325.96837015812, 5063.822766203165, 5066.645334826527, 5071.594272458195, 5072.568831649277, 5083.923741143812, 4406.25093734066, 4440.978574927784, 4446.910506925824, 4457.108578284357, 4514.954850451519, 5812.070068789058, 5815.621984570989, 5823.79616713413, 5827.825165245049, 5841.153032810304, 6204.37956204385, 6245.0, 6260.812175634738, 6263.843403914939, 6276.121343011982, 5627.380988091307, 5748.080307150836, 5766.336871259775, 5778.075507918713, 5809.622374545641, 5550.972245138749, 5554.972225138848, 5560.471755183251, 5562.082256427644, 5581.804636837773, 6381.234251889803, 6393.8721225576155, 6412.39082287182, 6425.710843012076, 6426.453751431087, 6202.0, 6262.780802671885, 6262.906056409249, 6263.718132684131, 6299.559030867796, 6352.968235158794, 6367.745290188341, 6379.170707808141, 6401.807945761635, 6420.7431702731365, 6236.220472440945, 6278.529110316653, 6290.433860952537, 6304.275008374096, 6309.463695585927, 6211.0, 6256.5307601930945, 6276.435120839146, 6309.652969086745, 6338.809835704937, 5176.249443830548, 6129.114290130661, 6201.875962480635, 6234.719437625408, 6239.688015599111, 6181.0, 6186.907196391968, 6190.0, 6190.442860142429, 6198.566100372931, 5901.026330655393, 5954.7320370582565, 6026.698665066817, 6076.848078797889, 6086.208792857077, 6117.204763380732, 6121.0262130506535, 6136.539759517965, 6152.384761523812, 6192.969035154795, 6073.514118870568, 6086.60437071589, 6093.6039157454625, 6094.360092190256, 6107.6640784757265], "value": 5746.557854545152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.6055707634822, 454.2074080729127, 466.421637169909, 494.14019605885767, 508.3137764018575, 30352.937647182353, 31957.201069973235, 32055.35889282213, 32072.037838864842, 32126.35747285053, 41821.0, 42512.14975700484, 42530.574694253046, 44760.776196118975, 44850.551494485044, 9333.300002499805, 9512.239020878347, 9518.857217141749, 9529.332946693734, 9541.666041688508, 8449.915500844974, 9448.574814133346, 9540.093691099335, 9540.80918381632, 9558.904410955905, 8486.74539763808, 11131.276467029616, 11357.318560886331, 11363.375014374205, 11535.596254131107, 11331.546738130506, 11402.0, 11416.828747568794, 11422.42887855608, 11439.084873210124, 8339.12439193882, 11262.324260544394, 11294.774104517946, 11346.149038822121, 11349.489272982735, 30585.847070764725, 38923.805380973194, 39324.803375983225, 39394.80302598498, 41326.0, 4020.075382661975, 4052.8784136475656, 4064.512258528966, 4075.572064933199, 4083.203775263825, 28578.428431431254, 29086.07338009363, 29553.556696649568, 30879.073627791204, 31204.0, 3243.464828303327, 3264.4450443424676, 3289.0954987378664, 3411.3177364526946, 3426.5716785401823, 492871.0, 496918.0, 497657.0, 497720.5113974443, 502311.4884425591, 61990.0, 62213.68893155505, 62244.0, 62370.0, 62437.375626244066, 62997.0, 64530.0, 64595.35404645988, 64747.67626161933, 64753.0, 15803.841961580238, 15927.964682295613, 16344.75482867758, 16362.918185409235, 16425.425110121087, 12651.93674031624, 12718.809217861739, 12749.426275817425, 12771.169873958162, 12844.48622055126, 14277.214753188675, 14601.853981460263, 16154.111523866066, 16450.6709865802, 16521.173941302888, 5754.6547207167705, 5791.160281759121, 6290.685465726787, 7021.438284937295, 7168.53404528704, 864.9567521623893, 890.3411475508077, 891.6210610490516, 894.2622336572354, 894.4812009034745, 28453.146405607866, 29618.555721664194, 29624.703752962196, 30371.0, 30382.69617303843, 1071.8285074388061, 1089.580511503077, 1089.9509522071526, 1097.2648325621853, 1110.0342701849443, 12604.243745375306, 15107.697846043018, 15368.154751488775, 15443.150626715638, 15517.827504149429, 627899.0, 633417.0, 633812.0, 634265.0, 636018.0, 59549.10676339858, 59730.80538389208, 59759.80480390368, 59817.0, 59955.0, 1433.0624475843088, 1442.7619442791822, 1457.1330058615108, 1482.5996980815335, 1494.0811400988314, 27662.723372766013, 28204.576931345637, 29369.0, 30272.0, 30316.696833031387, 49478.50521494883, 49937.75031124821, 49988.50011499984, 49999.500004999485, 50206.497935021645, 541572.0, 544259.0, 544456.0, 544635.0, 544820.0, 38570.0, 39153.41269880897, 39367.606323936394, 39490.40764388479, 39679.40480892731, 44547.777261113486, 45249.54750452585, 45340.54659453495, 45887.54112458833, 45888.0, 37226.741988740694, 37390.626093739804, 38322.42516362201, 38598.22803543969, 39387.40918886162, 33595.992120236435, 35789.5999880011, 37663.62336376711, 38201.61798381981, 39069.02327441837, 36875.81562092173, 36893.26213475769, 37021.62978370182, 38107.618923810405, 38148.23703525969, 31690.207744806565, 33986.980390588324, 34303.485447718806, 34394.82802585971, 34558.96323110311, 24597.877010614833, 24951.251462456155, 25242.776111424526, 25277.494450110527, 25603.0], "value": 20010.953698048197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.2257214704826, 387.2777270390722, 390.77335145615547, 399.15976868691394, 421.8502431636769, 14291.14253144812, 15237.7809775218, 18367.357142500034, 20697.793022069774, 20863.165473381083, 21762.673559896575, 21921.780782192174, 22327.0, 22518.77481225187, 22566.323010309716, 5779.0, 5827.41725827417, 5912.231409916705, 5934.851628709273, 5995.010823214165, 4233.407322974786, 5900.468957793798, 6007.579469437142, 6008.639481631094, 6015.819525414245, 4462.352958820969, 6332.303446620868, 6629.138212032429, 6634.834129146761, 6723.260441351447, 6444.677766111676, 6603.141591593062, 6682.93317066828, 6702.4302934250645, 6709.261981182066, 5774.0, 5839.124131380285, 5856.414358564152, 5865.88268234633, 5870.97064514679, 25700.614490782467, 26460.0, 26535.73464265371, 26538.46923061528, 26836.329091772666, 2724.4687285979244, 2751.2021513760988, 2759.862006899647, 2761.4891245119716, 2797.720227977186, 10670.893291067068, 14728.821694264434, 15324.0, 16011.51965441027, 16064.0, 1788.5512734684817, 1793.4709260768104, 1806.8554515638718, 1861.2275905499203, 1866.72932424799, 117724.0, 119293.40353298179, 119899.0, 120221.39889300585, 120576.39711801385, 9599.760005999906, 10398.428086455318, 10937.125029997582, 11527.8270825936, 11739.765204695857, 14582.927085364718, 14588.270586470846, 14616.342264598119, 14643.26783660834, 14677.48628797987, 8605.65577376898, 8786.25316848075, 8804.955975220082, 8949.821003580022, 8953.059928707522, 6860.588364698134, 7547.433942454338, 8785.385023048326, 8808.955955220183, 8934.329925255632, 6981.720731170798, 7075.115610548682, 7086.468514861406, 7095.751648692374, 7112.431005519649, 1860.83252507275, 1903.5716963683337, 1911.2259534888392, 1912.6365990461768, 1922.2695375757123, 849.5964416901923, 883.8421667615445, 892.7858112966361, 894.6197865907094, 915.3089417489753, 18272.99498527594, 18540.25838966426, 20446.897765511374, 21722.34832955014, 23004.079836806675, 815.2621877201143, 947.1759569174862, 952.9666461673808, 962.7388121560778, 964.628617982082, 8956.820863582692, 10514.684559463076, 11309.943450282695, 12152.149349545447, 12241.020718342512, 594409.0, 705078.4746076236, 726281.0, 739546.0, 754093.0, 96410.0, 127252.0, 129676.70323296834, 130489.0, 135364.0, 968.6028728221536, 994.174834887042, 1008.415119230859, 1010.1918465227789, 1010.3432768700256, 19295.51761205981, 19789.802101978796, 20033.29883454072, 20119.195232191134, 20188.0, 44458.0, 56837.43162568322, 62408.0, 64742.0, 67407.0, 83196.58401707953, 85421.57289213514, 85431.0, 85994.57002714946, 87519.12480875109, 8351.58242087881, 8374.069075823656, 8531.402801804063, 8630.913690863263, 8915.153060459246, 9504.809903802023, 11062.944685276521, 11071.778564428827, 12780.0, 13504.324783760969, 11012.229143959847, 11191.2725672831, 11550.768984620428, 11602.245854019462, 11812.586559470377, 11262.09903207725, 11431.028362589273, 11663.533458661897, 11854.940725296663, 11910.404479776149, 11481.827772583585, 11608.535658573563, 11671.824922626338, 12089.516419343128, 12159.148859579744, 8345.95827020861, 8493.405461617875, 8564.443311185003, 8619.353548483763, 8668.393212475066, 9772.0, 10713.464326783786, 11512.30926144434, 11681.0, 11773.234739741889], "value": 10015.702408162742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.8548835306494, 1441.5675297410774, 1443.8700516953472, 1454.1129910754441, 1463.8335263809554, 8299.087100418948, 8760.0, 8763.386562940588, 8789.252913502352, 8793.472391656505, 7519.54882707038, 7795.025621797276, 7820.8044798880055, 8271.751847444586, 8475.618597163128, 2321.9883900580476, 2359.0327965534134, 2363.692719946413, 2364.6807680963107, 2367.6685264063044, 1977.6835706286997, 2335.019291897407, 2371.5849726297915, 2382.356763673807, 2383.0467812874904, 2311.641695537194, 2313.456337760625, 2334.673145759595, 2340.3447034830274, 2349.0251545608553, 2286.965695514577, 2292.7477977422554, 2302.700648915647, 2324.628059510487, 2329.3594261578032, 2276.943076423086, 2341.800946919514, 2343.5195784864063, 2352.235523454867, 2353.5528249632516, 8670.176333248332, 8721.520316382597, 8731.60707768152, 8737.257333126692, 8749.650013999497, 5057.974710126426, 5226.817061402832, 5230.660007099526, 5232.293640358541, 5233.319668443078, 3316.3201543683726, 3419.4357930941364, 3516.9120771980647, 3523.0, 3551.041218870916, 1183.9581168571688, 1238.962831115068, 1247.1581682364367, 1255.773960687076, 1268.8033354830015, 10763.300385474919, 10784.245102842804, 10933.234673572853, 10962.835557466644, 10976.615818446317, 4437.356583295404, 4687.95312046882, 4755.286706993978, 4769.284607308862, 4772.5227477252, 9520.571574279174, 9691.2731545133, 9782.0, 9815.312928095107, 9857.802843943224, 5300.0, 5307.57539396855, 5308.681479111266, 5324.707141107198, 5327.254184414185, 3930.9803450982563, 4230.259704551752, 4246.915061698749, 4736.621070314367, 4809.326694262806, 3813.771173729585, 3857.5756666766633, 3903.7072219583647, 3944.723869329177, 3956.129651476728, 1246.719488115185, 1266.6706656269253, 1266.8796464335874, 1271.853736820259, 1280.5774094548776, 805.090248019734, 880.9515476648846, 908.795521007768, 914.5792935249726, 921.7234829551107, 5690.9146362804595, 5799.710014499258, 5888.381719919346, 5903.937291287523, 6011.939880601226, 862.4782006885869, 1003.117256813999, 1007.315025782475, 1015.619142821442, 1047.2145890582065, 3866.4007078902814, 3872.4191371294532, 3884.3008258513173, 3903.5706072332023, 4036.273470775289, 10044.347117437343, 10078.395296282246, 10416.843747343795, 10476.319039262424, 10484.370937743759, 9956.651517197008, 10024.849627255597, 10401.68794936153, 10422.791544169075, 10447.582096716198, 7964.123946365895, 8054.355651547862, 8103.959480202561, 8133.552654604054, 8144.511329320259, 5456.48163424474, 5599.8880022400135, 5605.0, 5808.36108028125, 5823.592348535732, 9440.433573985583, 9504.85742713846, 9551.188149007412, 9592.568334425107, 9606.615735370508, 9313.580888859882, 9559.235261179228, 9562.713118606453, 9800.11798938099, 9811.215102791617, 6750.729970801113, 6969.54697944632, 6978.197507286727, 7065.399441047569, 7310.853782924418, 7559.886601700869, 7692.0, 7694.653740581799, 7713.112992005991, 7888.921110788819, 7059.188193357624, 7305.232950540117, 7386.298301661333, 7410.11078670563, 7508.474406791473, 5871.383504732113, 6954.374106330454, 7027.754028608974, 7032.1912980007955, 7057.0472986146215, 6277.623342599459, 6489.935100648933, 6572.8356791080605, 6620.5034622402545, 6631.635260060743, 5047.41954675217, 5061.063703214917, 5091.1854103343285, 5109.821156259513, 5145.228215767665, 4949.678270912379, 4977.411586761387, 5106.595686186329, 5250.684958902478, 5329.907368989426], "value": 4491.796991443432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.96535381108083, 363.94540818877164, 365.5503730411594, 371.9293334266487, 374.0648379052369, 5246.081935661258, 5247.0, 5258.0272649559765, 5260.237820330184, 5315.548178404831, 4903.141950158726, 4921.188003979348, 5194.948050519493, 5199.68801871888, 5235.397929238139, 3401.217719924419, 3449.8965031048983, 3558.7153027757845, 3918.686505079601, 3997.8800635980892, 4076.3274059780247, 4079.9188215122867, 4080.8979775505554, 4097.426360309559, 4114.835406583733, 3341.5154802553616, 4026.11425486394, 4066.373450619746, 4077.5932303355444, 4100.36444351126, 3813.713971452138, 3906.9804650976707, 4026.993251687078, 4090.6931980101613, 4104.630583247492, 2980.1820889257538, 3134.714766945541, 3578.785272883635, 3594.155373487228, 3608.0979755061235, 5045.318881950926, 5062.367204099488, 5073.315102461157, 5085.0, 5119.385673719177, 3816.3971132124575, 4502.549745025504, 4615.423072115986, 4646.210144275481, 4668.451976497852, 5492.588055895823, 5506.972465137648, 5516.834494965157, 5533.624489061669, 5541.612087153901, 3394.8981530554124, 3727.9189035179766, 4011.117554138085, 4048.1903619276263, 4061.3907913813164, 4881.072596206709, 5427.929053210092, 5508.586855985777, 5702.857428564236, 5858.150568167634, 3097.4424603571124, 3829.476881269239, 3833.463315135883, 3922.9607703922597, 4082.7142100053306, 3473.7394695397948, 3754.9812250939117, 4172.749635021908, 4172.7704976226, 4193.574184777191, 3539.6549311261556, 4634.443866736014, 4717.4525756091325, 4736.384270044941, 4785.444730462614, 5533.3083364579425, 5536.584756143306, 5558.583106267046, 5599.440055994368, 5606.271184746039, 1180.226951346869, 1253.6489782860813, 1282.5126451948386, 1326.2374134872487, 1369.5343583181766, 862.7368652561029, 874.3879284500874, 905.7780843693206, 920.5593246569098, 971.5142428785607, 4736.384270044872, 4742.288656701522, 5109.540141387293, 5142.871428214325, 5164.586833053347, 5175.0, 5496.047499912614, 5668.206451096849, 5695.430456954271, 5709.942900571024, 4777.331173635694, 4882.584980276716, 4973.42805577356, 5123.667846359973, 5130.563902068366, 2395.47299594089, 2694.8248363856287, 2767.861606919646, 2899.289674029876, 2899.942001159965, 5311.336082989626, 5368.302120724281, 5431.565474762009, 5746.310442746897, 5749.8275051748515, 4685.882852928704, 4702.717836929795, 5457.945420545744, 5656.0, 5699.829005129853, 4712.151812673752, 4923.0153969205585, 5095.898082038412, 5116.923246151311, 5606.579506537026, 4565.908681826279, 4930.359053323045, 5009.7244651544515, 5148.198130654241, 5438.757768940233, 4545.568171023748, 5276.788928442819, 5307.310049693515, 5388.676679399248, 5398.757055932414, 5447.400785913467, 5665.915011274752, 5699.430056994267, 5709.0, 5721.22763426932, 3675.4486826976167, 3689.1883785567134, 3694.2057457646733, 3702.7593206441493, 3703.9814800925824, 4988.678000329843, 5248.475152484721, 5500.58745594074, 5521.613487056028, 5602.85992850182, 4673.532646735299, 4807.687500312469, 4852.660313778002, 5312.831177141023, 5342.599305052215, 4586.628827811623, 4965.28003439492, 5146.536811686966, 5299.364076310867, 5336.399080275979, 4494.842680506166, 4509.0, 5265.5252031545115, 5306.973465132804, 5415.945840541702, 4708.327504546459, 5083.822066227664, 5173.844784656466, 5213.348331458567, 5432.9185062223305, 5099.592032637454, 5313.574914006793, 5396.973015135056, 5402.621816472809, 5421.430749771375], "value": 4002.047647159239, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.6472598974522, 751.6467260387616, 780.3601047141346, 798.5887268056949, 823.1644880446348, 14941.850581494182, 15114.924425377885, 15650.530484085495, 15778.842211577896, 15781.132037737934, 13428.261445620486, 13608.455661773518, 14182.0, 14331.498397556088, 14657.0, 846.7205822078699, 854.3506934729588, 857.2798848966867, 857.5669287010052, 860.8794768732382, 868.9087645797196, 869.2871845087031, 869.3479890082439, 871.7646235516406, 873.3973558244822, 925.6713866577369, 925.9722208333761, 928.0163027191165, 928.4429342394577, 929.1544694328163, 878.0736323179044, 878.7627340618061, 891.781513529183, 922.921551668109, 923.7413524213231, 686.1526015371013, 686.4679873098339, 687.4363022321699, 687.8761822871882, 688.3735800421642, 13481.932590337083, 13673.521426750116, 13821.239831809247, 13842.930785346109, 14024.158550487004, 10980.450977451095, 11218.214724969255, 11258.324500529994, 11320.716982075513, 11604.245724027996, 10714.624988125379, 10714.624988125455, 11042.723931901686, 11502.539898404053, 11551.53793848245, 4523.547645235483, 4573.291139873325, 4573.382593349888, 4644.233701439259, 4730.5032971538185, 101119.49440252752, 103143.0, 105046.0, 105159.0, 105551.0, 10769.138468922467, 10995.120390368911, 11045.83431248532, 11081.445927703582, 11409.03023243017, 21170.0, 21395.786042139378, 21565.24521641735, 21587.0, 21625.783742162377, 7426.2945020223, 7569.810754731066, 7582.900559238881, 7663.9616801916745, 7725.575093369806, 4224.683148763855, 4290.957090429119, 4355.60799528044, 4381.6494680425485, 4382.452193475816, 3462.307538492312, 3526.2771131917893, 3530.505729197914, 3539.9292014159573, 3563.6436356364156, 642.3512252624882, 647.3106141958799, 652.7356420649644, 652.8792173447832, 653.5621133840339, 485.87367284505575, 490.50214032756065, 516.7003138179922, 556.4935908323406, 594.649156997365, 9458.243340532741, 9883.11052005323, 10041.648542300984, 10046.648367307109, 10059.949700251453, 514.8661348049534, 537.4437457231746, 539.6438350688527, 539.9946000539944, 546.7375659683374, 4436.378906953029, 4457.153140903218, 4790.305405716152, 4799.9760001199775, 4813.518648135158, 93816.53091734498, 93936.53031734798, 98004.50997744966, 99117.5132373015, 101109.0, 51674.74162629238, 58161.70919145462, 76199.0, 85270.0, 88881.66677499843, 70869.0, 71562.2109447268, 72417.0, 73595.63202183954, 75167.62416187994, 10594.31136976094, 10843.132549396187, 11308.604198853001, 11438.599649012245, 11526.0, 46000.30999535076, 46252.768736156104, 47156.7642161787, 47635.0, 51970.0, 54011.45988540064, 68651.65674171597, 69600.65199674171, 72235.63882180555, 72341.27658723346, 12501.187422817487, 12840.486380544673, 12893.806592900926, 13222.272774997467, 13747.312634368041, 14110.78833817473, 14742.0, 14931.776023359875, 15135.318910649268, 15556.299966501309, 13402.144024229849, 13655.112417693215, 14077.577672669837, 14191.716165676835, 14718.705625887636, 13466.865331346562, 13678.537863184325, 13721.656958575717, 13752.587422377344, 14215.573532794033, 13043.934780326417, 13289.933550332187, 13855.653608659864, 14000.299985000913, 14093.436262549383, 10955.56177752881, 11328.376939268419, 11619.883801161881, 11777.52889884395, 12039.277643341427, 11093.5562577496, 11289.322640641587, 11323.547058117912, 11354.375509346735, 11361.261518001304], "value": 7369.586558962169, "unit": "score"}], "name": "dromaeo_css", "value": 7310.130506389085, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 112.0, 112.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 107.0, 141.0, 114.0, 109.0, 106.0, 108.0, 128.0, 109.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [259.0, 229.0, 186.0, 182.0, 184.0, 186.0, 195.0, 223.0, 186.0, 184.0], "value": 201.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 62.0, 105.0, 85.0, 73.0, 60.0, 59.0, 76.0, 58.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 84.0, 70.0, 70.0, 89.0, 116.0, 98.0, 68.0, 79.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 87.0, 85.0, 90.0, 122.0, 89.0, 84.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 153.0, 97.0, 102.0, 134.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 109.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 112.0, 70.0, 112.0, 139.0, 142.0, 88.0, 85.0, 87.0, 87.0], "value": 100.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 56.0, 59.0, 58.0, 58.0, 57.0, 57.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 66.0, 79.0, 76.0, 74.0, 76.0, 74.0, 75.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 84.0, 85.0, 83.0, 88.0, 90.0, 87.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 139.0, 135.0, 140.0, 141.0, 141.0, 143.0, 197.0, 155.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 168.0, 169.0, 168.0, 167.0, 167.0, 170.0, 165.0, 169.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 64.0, 63.0, 67.0, 70.0, 82.0, 88.0, 84.0, 74.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1491.1, "alertThreshold": 2.0}]} 16:25:50 INFO - Return code: 0 16:25:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:25:50 ERROR - # TBPL SUCCESS # 16:25:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:25:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:25:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:25:50 INFO - 2017-01-29 16:25:50.251 screenresolution[2248:29725] starting screenresolution argv=screenresolution get 16:25:50 INFO - 2017-01-29 16:25:50.254 screenresolution[2248:29725] Display 0: 1600x1200x32@60 16:25:50 INFO - 2017-01-29 16:25:50.261 screenresolution[2249:29729] starting screenresolution argv=screenresolution list 16:25:50 INFO - Available Modes on Display 0 16:25:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:25:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:25:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:25:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:25:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:25:50 INFO - Intel Iris: 16:25:50 INFO - Chipset Model: Intel Iris 16:25:50 INFO - Type: GPU 16:25:50 INFO - Bus: Built-In 16:25:50 INFO - VRAM (Dynamic, Max): 1536 MB 16:25:50 INFO - Vendor: Intel (0x8086) 16:25:50 INFO - Device ID: 0x0a2e 16:25:50 INFO - Revision ID: 0x0009 16:25:50 INFO - Displays: 16:25:50 INFO - Display: 16:25:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:25:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:25:50 INFO - Display Serial Number: 1600x1200 60 16:25:50 INFO - Main Display: Yes 16:25:50 INFO - Mirror: Off 16:25:50 INFO - Online: Yes 16:25:50 INFO - Rotation: Supported 16:25:50 INFO - Return code: 0 16:25:50 INFO - Running post-action listener: _resource_record_post_action 16:25:50 INFO - [mozharness: 2017-01-30 00:25:50.496371Z] Finished run-tests step (success) 16:25:50 INFO - Running post-run listener: _resource_record_post_run 16:25:50 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 552960; Write bytes: 510415360; Read time: 4; Write time: 1605 16:25:50 INFO - TinderboxPrint: CPU usage
53.7% 16:25:50 INFO - TinderboxPrint: I/O read bytes / time
552,960 / 4 16:25:50 INFO - TinderboxPrint: I/O write bytes / time
510,415,360 / 1,605 16:25:50 INFO - TinderboxPrint: CPU idle
2,220.4 (46.3%) 16:25:50 INFO - TinderboxPrint: CPU system
968.9 (20.2%) 16:25:50 INFO - TinderboxPrint: CPU user
1,608.5 (33.5%) 16:25:50 INFO - TinderboxPrint: Swap in / out
207,548,416 / 0 16:25:50 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202998272; Write bytes: 201603072; Read time: 15882; Write time: 448 16:25:50 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 552960; Write bytes: 298125824; Read time: 4; Write time: 1118 16:25:50 INFO - Running post-run listener: _upload_blobber_files 16:25:50 INFO - Blob upload gear active. 16:25:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:25:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:25:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:25:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:25:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:25:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:52 INFO - (blobuploader) - INFO - Done attempting. 16:25:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:25:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:53 INFO - (blobuploader) - INFO - Done attempting. 16:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:54 INFO - (blobuploader) - INFO - Done attempting. 16:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:56 INFO - (blobuploader) - INFO - Done attempting. 16:25:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:25:56 INFO - Return code: 0 16:25:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:25:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:25:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2ab6051e627e6cc6e7b634bf325851827b000950cd236c39d2a4085cf2817e7b2f56b0d568ea97b65d0ea51bca100389ba3ce1d37b60cbfbd270ede6526a7c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d5d4fdd428ede35e90e037707ba35246e43ddd6ffa4fe9078191fcd43b34119d88b506b7dd2527570b1e80ce6c7e73f65bd06bde23eb555fa1ee7b13b3f9a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d89cc9becc311ecf409ede4b494d579a62d52a92c39e0b31e965096909e531a9478f24b40a428cc094bd79469095e4d2e9d90712a24d1238bc0926072c9d2d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1f32c0448edc5519042cccfda32485e4346b8cd877e1c45ec7b9e636871f8e46e8a5d3d71cf9235ff0fdbc840e6c980df8469ccccecf92b3bb7a54b7f19e9"} 16:25:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:25:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:25:56 INFO - Contents: 16:25:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2ab6051e627e6cc6e7b634bf325851827b000950cd236c39d2a4085cf2817e7b2f56b0d568ea97b65d0ea51bca100389ba3ce1d37b60cbfbd270ede6526a7c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d5d4fdd428ede35e90e037707ba35246e43ddd6ffa4fe9078191fcd43b34119d88b506b7dd2527570b1e80ce6c7e73f65bd06bde23eb555fa1ee7b13b3f9a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d89cc9becc311ecf409ede4b494d579a62d52a92c39e0b31e965096909e531a9478f24b40a428cc094bd79469095e4d2e9d90712a24d1238bc0926072c9d2d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1f32c0448edc5519042cccfda32485e4346b8cd877e1c45ec7b9e636871f8e46e8a5d3d71cf9235ff0fdbc840e6c980df8469ccccecf92b3bb7a54b7f19e9"} 16:25:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:25:56 INFO - Copying logs to upload dir... 16:25:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:25:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.074410 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-29 16:25:56.953283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-29 16:25:56.957289) ========= 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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2ab6051e627e6cc6e7b634bf325851827b000950cd236c39d2a4085cf2817e7b2f56b0d568ea97b65d0ea51bca100389ba3ce1d37b60cbfbd270ede6526a7c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d5d4fdd428ede35e90e037707ba35246e43ddd6ffa4fe9078191fcd43b34119d88b506b7dd2527570b1e80ce6c7e73f65bd06bde23eb555fa1ee7b13b3f9a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d89cc9becc311ecf409ede4b494d579a62d52a92c39e0b31e965096909e531a9478f24b40a428cc094bd79469095e4d2e9d90712a24d1238bc0926072c9d2d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1f32c0448edc5519042cccfda32485e4346b8cd877e1c45ec7b9e636871f8e46e8a5d3d71cf9235ff0fdbc840e6c980df8469ccccecf92b3bb7a54b7f19e9"} build_url:https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/Ju3yfcWRQ2-rdLA6kROZfg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2ab6051e627e6cc6e7b634bf325851827b000950cd236c39d2a4085cf2817e7b2f56b0d568ea97b65d0ea51bca100389ba3ce1d37b60cbfbd270ede6526a7c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d5d4fdd428ede35e90e037707ba35246e43ddd6ffa4fe9078191fcd43b34119d88b506b7dd2527570b1e80ce6c7e73f65bd06bde23eb555fa1ee7b13b3f9a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d89cc9becc311ecf409ede4b494d579a62d52a92c39e0b31e965096909e531a9478f24b40a428cc094bd79469095e4d2e9d90712a24d1238bc0926072c9d2d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1f32c0448edc5519042cccfda32485e4346b8cd877e1c45ec7b9e636871f8e46e8a5d3d71cf9235ff0fdbc840e6c980df8469ccccecf92b3bb7a54b7f19e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-29 16:25:56.991295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 16:25:56.991628) ========= 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.VcoEYJZavQ/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.YPNsn5BN2C/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.005349 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 16:25:57.040692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-29 16:25:57.041032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-29 16:25:57.041340) ========= ========= Total master_lag: 0.18 =========