builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0312 starttime: 1493176013.36 results: success (0) buildid: 20170425184210 builduid: c5e542b2f6234621a387c2002e0403c8 revision: cd699ab3018fd805767a78e78c8a9564f28ee72c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:53.363325) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:53.363825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:53.364106) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:53.391740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:53.392110) ========= 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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-25 20:06:53-- 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% 20.4M=0.001s 2017-04-25 20:06:53 (20.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.213604 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:53.631586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:53.631908) ========= 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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.027171 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:53.681264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 20:06:53.681650) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cd699ab3018fd805767a78e78c8a9564f28ee72c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cd699ab3018fd805767a78e78c8a9564f28ee72c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kxKwEZYEi7/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.S8tFbcmpFE/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-25 20:06:53,786 truncating revision to first 12 chars 2017-04-25 20:06:53,786 Setting DEBUG logging. 2017-04-25 20:06:53,786 attempt 1/10 2017-04-25 20:06:53,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cd699ab3018f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 20:06:54,969 unpacking tar archive at: mozilla-beta-cd699ab3018f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.449768 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 20:06:55.158456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:55.159067) ========= script_repo_revision: cd699ab3018fd805767a78e78c8a9564f28ee72c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:55.159741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:55.160253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 20:06:55.181740) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-25 20:06:55.182133) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kxKwEZYEi7/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.S8tFbcmpFE/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:06:55 INFO - MultiFileLogger online at 20170425 20:06:55 in /builds/slave/test 20:06:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:06:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:55 INFO - {'append_to_log': False, 20:06:55 INFO - 'base_work_dir': '/builds/slave/test', 20:06:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:06:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:55 INFO - 'branch': 'Mozilla-Beta', 20:06:55 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:55 INFO - 'config_files': ('talos/mac_config.py',), 20:06:55 INFO - 'default_actions': ('clobber', 20:06:55 INFO - 'read-buildbot-config', 20:06:55 INFO - 'download-and-extract', 20:06:55 INFO - 'populate-webroot', 20:06:55 INFO - 'create-virtualenv', 20:06:55 INFO - 'install', 20:06:55 INFO - 'run-tests'), 20:06:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:55 INFO - 'download_minidump_stackwalk': True, 20:06:55 INFO - 'download_symbols': 'ondemand', 20:06:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:55 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:55 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:55 INFO - 'gecko_profile': False, 20:06:55 INFO - 'gecko_profile_interval': 0, 20:06:55 INFO - 'installer_path': 'installer.exe', 20:06:55 INFO - 'log_level': 'info', 20:06:55 INFO - 'log_name': 'talos', 20:06:55 INFO - 'log_to_console': True, 20:06:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:06:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:06:55 INFO - 'opt_config_files': (), 20:06:55 INFO - 'pip_index': False, 20:06:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:06:55 INFO - 'cmd': ('bash', 20:06:55 INFO - '-c', 20:06:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:06:55 INFO - 'enabled': True, 20:06:55 INFO - 'halt_on_failure': False, 20:06:55 INFO - 'name': 'check_screen_resolution'},), 20:06:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:06:55 INFO - 'cmd': ('bash', 20:06:55 INFO - '-c', 20:06:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:06:55 INFO - 'enabled': True, 20:06:55 INFO - 'halt_on_failure': False, 20:06:55 INFO - 'name': 'check_screen_resolution'},), 20:06:55 INFO - 'run_cmd_checks_enabled': True, 20:06:55 INFO - 'suite': 'dromaeojs', 20:06:55 INFO - 'system_bits': '32', 20:06:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:55 INFO - 'title': 't-yosemite-r7-0312', 20:06:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:55 INFO - 'use_talos_json': True, 20:06:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:55 INFO - 'work_dir': 'build'} 20:06:55 INFO - [mozharness: 2017-04-26 03:06:55.391965Z] Running clobber step. 20:06:55 INFO - Running pre-action listener: _resource_record_pre_action 20:06:55 INFO - Running main action method: clobber 20:06:55 INFO - rmtree: /builds/slave/test/build 20:06:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:57 INFO - Running post-action listener: _resource_record_post_action 20:06:57 INFO - [mozharness: 2017-04-26 03:06:57.914111Z] Finished clobber step (success) 20:06:57 INFO - [mozharness: 2017-04-26 03:06:57.914240Z] Running read-buildbot-config step. 20:06:57 INFO - Running pre-action listener: _resource_record_pre_action 20:06:57 INFO - Running main action method: read_buildbot_config 20:06:57 INFO - Using buildbot properties: 20:06:57 INFO - { 20:06:57 INFO - "project": "", 20:06:57 INFO - "product": "firefox", 20:06:57 INFO - "script_repo_revision": "production", 20:06:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:06:57 INFO - "repository": "", 20:06:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:06:57 INFO - "buildid": "20170425184210", 20:06:57 INFO - "pgo_build": "False", 20:06:57 INFO - "basedir": "/builds/slave/test", 20:06:57 INFO - "buildnumber": 13, 20:06:57 INFO - "slavename": "t-yosemite-r7-0312", 20:06:57 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 20:06:57 INFO - "platform": "yosemite_r7", 20:06:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:06:57 INFO - "branch": "mozilla-beta", 20:06:57 INFO - "repo_path": "releases/mozilla-beta", 20:06:57 INFO - "revision": "cd699ab3018fd805767a78e78c8a9564f28ee72c", 20:06:57 INFO - "stage_platform": "macosx64", 20:06:57 INFO - "builduid": "c5e542b2f6234621a387c2002e0403c8", 20:06:57 INFO - "slavebuilddir": "test" 20:06:57 INFO - } 20:06:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 20:06:57 INFO - Running post-action listener: _resource_record_post_action 20:06:57 INFO - [mozharness: 2017-04-26 03:06:57.917469Z] Finished read-buildbot-config step (success) 20:06:57 INFO - [mozharness: 2017-04-26 03:06:57.917580Z] Running download-and-extract step. 20:06:57 INFO - Running pre-action listener: _resource_record_pre_action 20:06:57 INFO - Running main action method: download_and_extract 20:06:57 INFO - mkdir: /builds/slave/test/build/tests 20:06:57 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')]} 20:06:57 INFO - trying https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 20:06:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 20:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 20:06:59 INFO - Downloaded 1165 bytes. 20:06:59 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 20:06:59 INFO - Using the following test package requirements: 20:06:59 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 20:06:59 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 20:06:59 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 20:06:59 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 20:06:59 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 20:06:59 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:06:59 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 20:06:59 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 20:06:59 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 20:06:59 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 20:06:59 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 20:06:59 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 20:06:59 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 20:06:59 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 20:06:59 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 20:06:59 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 20:06:59 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 20:06:59 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 20:06:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 20:06:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 20:06:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 20:07:00 INFO - Expected file size: 51224691 20:07:00 INFO - Obtained file size: 51224691 20:07:16 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 20:07:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 20:07:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 20:07:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 20:07:18 INFO - Expected file size: 51224691 20:07:18 INFO - Obtained file size: 51224691 20:07:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 20:07:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 20:07:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 20:07:34 INFO - Expected file size: 14404449 20:07:34 INFO - Obtained file size: 14404449 20:07: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')]} 20:07:34 INFO - trying https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 20:07:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 20:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 20:07:36 INFO - Downloaded 59533699 bytes. 20:07:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 20:07:36 INFO - mkdir: /builds/slave/test/properties 20:07:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:07:36 INFO - Writing to file /builds/slave/test/properties/build_url 20:07:36 INFO - Contents: 20:07:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 20:07:37 INFO - Running post-action listener: _resource_record_post_action 20:07:37 INFO - Running post-action listener: set_extra_try_arguments 20:07:37 INFO - [mozharness: 2017-04-26 03:07:37.407669Z] Finished download-and-extract step (success) 20:07:37 INFO - [mozharness: 2017-04-26 03:07:37.407817Z] Running populate-webroot step. 20:07:37 INFO - Running pre-action listener: _resource_record_pre_action 20:07:37 INFO - Running main action method: populate_webroot 20:07:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:07:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:07:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:07:37 INFO - '--tppagecycles', 20:07:37 INFO - '7'], 20:07:37 INFO - 'tests': ['tsvgm']}}, 20:07:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:07:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:07:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:07:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:07:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:07:37 INFO - 'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:07:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:07:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:07:37 INFO - 'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['damp', 'tps']}, 20:07:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:07:37 INFO - 'tests': ['damp', 'tps']}, 20:07:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['dromaeo_dom']}, 20:07:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:07:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['basic_compositor_video']}, 20:07:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:07:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['a11yr', 20:07:37 INFO - 'ts_paint', 20:07:37 INFO - 'tpaint', 20:07:37 INFO - 'sessionrestore', 20:07:37 INFO - 'sessionrestore_no_auto_restore', 20:07:37 INFO - 'tabpaint']}, 20:07:37 INFO - 'other-e10s': {'tests': ['a11yr', 20:07:37 INFO - 'ts_paint', 20:07:37 INFO - 'tpaint', 20:07:37 INFO - 'sessionrestore', 20:07:37 INFO - 'sessionrestore_no_auto_restore', 20:07:37 INFO - 'tabpaint']}, 20:07:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:07:37 INFO - 'ts_paint', 20:07:37 INFO - 'tpaint', 20:07:37 INFO - 'sessionrestore', 20:07:37 INFO - 'sessionrestore_no_auto_restore', 20:07:37 INFO - 'tabpaint']}, 20:07:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:07:37 INFO - 'ts_paint', 20:07:37 INFO - 'tpaint', 20:07:37 INFO - 'sessionrestore', 20:07:37 INFO - 'sessionrestore_no_auto_restore', 20:07:37 INFO - 'tabpaint']}, 20:07:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['a11yr', 20:07:37 INFO - 'ts_paint', 20:07:37 INFO - 'tpaint', 20:07:37 INFO - 'sessionrestore', 20:07:37 INFO - 'sessionrestore_no_auto_restore', 20:07:37 INFO - 'tabpaint']}, 20:07:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['a11yr', 20:07:37 INFO - 'ts_paint', 20:07:37 INFO - 'tpaint', 20:07:37 INFO - 'sessionrestore', 20:07:37 INFO - 'sessionrestore_no_auto_restore', 20:07:37 INFO - 'tabpaint']}, 20:07:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['tsvgx', 20:07:37 INFO - 'tsvgr_opacity', 20:07:37 INFO - 'tart', 20:07:37 INFO - 'tscrollx', 20:07:37 INFO - 'cart', 20:07:37 INFO - 'tsvg_static']}, 20:07:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:07:37 INFO - 'tsvgr_opacity', 20:07:37 INFO - 'tart', 20:07:37 INFO - 'tscrollx', 20:07:37 INFO - 'cart', 20:07:37 INFO - 'tsvg_static']}, 20:07:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:07:37 INFO - 'talos_options': ['--disable-e10s'], 20:07:37 INFO - 'tests': ['tp5o']}, 20:07:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:07:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:07:37 INFO - 'talos_options': ['--disable-e10s', 20:07:37 INFO - '--xperf_path', 20:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:07:37 INFO - 'tests': ['tp5n']}, 20:07:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:07:37 INFO - 'talos_options': ['--xperf_path', 20:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:07:37 INFO - 'tests': ['tp5n']}}, 20:07:37 INFO - 'talos.zip': {'path': '', 20:07:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:07:37 INFO - Running post-action listener: _resource_record_post_action 20:07:37 INFO - [mozharness: 2017-04-26 03:07:37.426764Z] Finished populate-webroot step (success) 20:07:37 INFO - [mozharness: 2017-04-26 03:07:37.426876Z] Running create-virtualenv step. 20:07:37 INFO - Running pre-action listener: _resource_record_pre_action 20:07:37 INFO - Running main action method: create_virtualenv 20:07:37 INFO - Creating virtualenv /builds/slave/test/build/venv 20:07:37 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 20:07:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:07:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:07:37 INFO - Using real prefix '/tools/python27' 20:07:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 20:07:41 INFO - Installing pip.................done. 20:07:41 INFO - Return code: 0 20:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:07:41 INFO - Reading from file tmpfile_stdout 20:07:41 INFO - Output received: 20:07:41 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) 20:07:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:07:41 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')]} 20:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:41 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')]} 20:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:42 INFO - 'HOME': '/Users/cltbld', 20:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:42 INFO - 'LOGNAME': 'cltbld', 20:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:42 INFO - 'MOZ_NO_REMOTE': '1', 20:07:42 INFO - 'NO_EM_RESTART': '1', 20:07:42 INFO - 'PAGER': '/bin/cat', 20:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:42 INFO - 'PWD': '/builds/slave/test', 20:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:42 INFO - 'SHELL': '/bin/bash', 20:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:07:42 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:42 INFO - 'USER': 'cltbld', 20:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:42 INFO - 'XPC_FLAGS': '0x0', 20:07:42 INFO - 'XPC_SERVICE_NAME': '0', 20:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:42 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 20:07:42 INFO - Cleaning up... 20:07:42 INFO - Return code: 0 20:07:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:42 INFO - 'HOME': '/Users/cltbld', 20:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:42 INFO - 'LOGNAME': 'cltbld', 20:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:42 INFO - 'MOZ_NO_REMOTE': '1', 20:07:42 INFO - 'NO_EM_RESTART': '1', 20:07:42 INFO - 'PAGER': '/bin/cat', 20:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:42 INFO - 'PWD': '/builds/slave/test', 20:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:42 INFO - 'SHELL': '/bin/bash', 20:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:07:42 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:42 INFO - 'USER': 'cltbld', 20:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:42 INFO - 'XPC_FLAGS': '0x0', 20:07:42 INFO - 'XPC_SERVICE_NAME': '0', 20:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:43 INFO - Downloading/unpacking psutil>=3.1.1 20:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:46 INFO - Installing collected packages: psutil 20:07:46 INFO - Running setup.py install for psutil 20:07:46 INFO - building 'psutil._psutil_osx' extension 20:07:46 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 20:07:47 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 20:07:47 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 20:07:47 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 20:07:47 INFO - building 'psutil._psutil_posix' extension 20:07:47 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 20:07:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:07:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:07:47 INFO - ^ 20:07:47 INFO - 1 warning generated. 20:07:47 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 20:07:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:47 INFO - Successfully installed psutil 20:07:47 INFO - Cleaning up... 20:07:48 INFO - Return code: 0 20:07:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:48 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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:07:48 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 20:07:48 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 20:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:48 INFO - 'HOME': '/Users/cltbld', 20:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:48 INFO - 'LOGNAME': 'cltbld', 20:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:48 INFO - 'MOZ_NO_REMOTE': '1', 20:07:48 INFO - 'NO_EM_RESTART': '1', 20:07:48 INFO - 'PAGER': '/bin/cat', 20:07:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:48 INFO - 'PWD': '/builds/slave/test', 20:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:48 INFO - 'SHELL': '/bin/bash', 20:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:07:48 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:48 INFO - 'USER': 'cltbld', 20:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:48 INFO - 'XPC_FLAGS': '0x0', 20:07:48 INFO - 'XPC_SERVICE_NAME': '0', 20:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:07:50 INFO - Installing collected packages: mozsystemmonitor 20:07:50 INFO - Running setup.py install for mozsystemmonitor 20:07:51 INFO - Successfully installed mozsystemmonitor 20:07:51 INFO - Cleaning up... 20:07:51 INFO - Return code: 0 20:07:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:07:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:07:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:51 INFO - 'HOME': '/Users/cltbld', 20:07:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:51 INFO - 'LOGNAME': 'cltbld', 20:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:51 INFO - 'MOZ_NO_REMOTE': '1', 20:07:51 INFO - 'NO_EM_RESTART': '1', 20:07:51 INFO - 'PAGER': '/bin/cat', 20:07:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:51 INFO - 'PWD': '/builds/slave/test', 20:07:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:51 INFO - 'SHELL': '/bin/bash', 20:07:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:07:51 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:07:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:51 INFO - 'USER': 'cltbld', 20:07:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:51 INFO - 'XPC_FLAGS': '0x0', 20:07:51 INFO - 'XPC_SERVICE_NAME': '0', 20:07:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:51 INFO - Downloading/unpacking jsonschema==2.5.1 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:07:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:54 INFO - Downloading functools32-3.2.3-2.tar.gz 20:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:07:54 INFO - warning: no files found matching '*.txt' 20:07:54 INFO - no previously-included directories found matching 'build' 20:07:54 INFO - no previously-included directories found matching 'dist' 20:07:54 INFO - no previously-included directories found matching '.git*' 20:07:54 INFO - Installing collected packages: jsonschema, functools32 20:07:54 INFO - Running setup.py install for functools32 20:07:54 INFO - warning: no files found matching '*.txt' 20:07:54 INFO - no previously-included directories found matching 'build' 20:07:54 INFO - no previously-included directories found matching 'dist' 20:07:54 INFO - no previously-included directories found matching '.git*' 20:07:54 INFO - Successfully installed jsonschema functools32 20:07:54 INFO - Cleaning up... 20:07:54 INFO - Return code: 0 20:07:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:54 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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:07:54 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 20:07:54 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 20:07:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:07:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:54 INFO - 'HOME': '/Users/cltbld', 20:07:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:54 INFO - 'LOGNAME': 'cltbld', 20:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:54 INFO - 'MOZ_NO_REMOTE': '1', 20:07:54 INFO - 'NO_EM_RESTART': '1', 20:07:54 INFO - 'PAGER': '/bin/cat', 20:07:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:54 INFO - 'PWD': '/builds/slave/test', 20:07:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:54 INFO - 'SHELL': '/bin/bash', 20:07:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:07:54 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:07:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:54 INFO - 'USER': 'cltbld', 20:07:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:54 INFO - 'XPC_FLAGS': '0x0', 20:07:54 INFO - 'XPC_SERVICE_NAME': '0', 20:07:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:07:55 INFO - Cleaning up... 20:07:55 INFO - Return code: 0 20:07:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:55 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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:07:55 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 20:07:55 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 20:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:55 INFO - 'HOME': '/Users/cltbld', 20:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:55 INFO - 'LOGNAME': 'cltbld', 20:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:55 INFO - 'MOZ_NO_REMOTE': '1', 20:07:55 INFO - 'NO_EM_RESTART': '1', 20:07:55 INFO - 'PAGER': '/bin/cat', 20:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:55 INFO - 'PWD': '/builds/slave/test', 20:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:55 INFO - 'SHELL': '/bin/bash', 20:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:07:55 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:55 INFO - 'USER': 'cltbld', 20:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:55 INFO - 'XPC_FLAGS': '0x0', 20:07:55 INFO - 'XPC_SERVICE_NAME': '0', 20:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:55 INFO - Downloading/unpacking blobuploader==1.2.4 20:07:55 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 20:07:55 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 20:07:55 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 20:07:55 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 20:07:55 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 20:07:55 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 20:07:57 INFO - Downloading blobuploader-1.2.4.tar.gz 20:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:07:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:07:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:59 INFO - Downloading docopt-0.6.1.tar.gz 20:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:07:59 INFO - Installing collected packages: blobuploader, requests, docopt 20:07:59 INFO - Running setup.py install for blobuploader 20:07:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:07:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:07:59 INFO - Running setup.py install for requests 20:07:59 INFO - Running setup.py install for docopt 20:08:00 INFO - Successfully installed blobuploader requests docopt 20:08:00 INFO - Cleaning up... 20:08:00 INFO - Return code: 0 20:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:00 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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:08:00 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 20:08:00 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 20:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:00 INFO - 'HOME': '/Users/cltbld', 20:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:00 INFO - 'LOGNAME': 'cltbld', 20:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:00 INFO - 'MOZ_NO_REMOTE': '1', 20:08:00 INFO - 'NO_EM_RESTART': '1', 20:08:00 INFO - 'PAGER': '/bin/cat', 20:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:00 INFO - 'PWD': '/builds/slave/test', 20:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:00 INFO - 'SHELL': '/bin/bash', 20:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:08:00 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:00 INFO - 'USER': 'cltbld', 20:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:00 INFO - 'XPC_FLAGS': '0x0', 20:08:00 INFO - 'XPC_SERVICE_NAME': '0', 20:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jjAkA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-chivJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-b2hww9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-hteOXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jnxG2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-oJvOyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Ik8S7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gBoIxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ODeY1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-BWdVtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-7zjIwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-zP20ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-6v8WhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-1rAHn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-L9ZrH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:02 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-KDEiZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:02 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-j5VZWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:02 INFO - Running setup.py install for manifestparser 20:08:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:02 INFO - Running setup.py install for mozcrash 20:08:02 INFO - Running setup.py install for mozdebug 20:08:02 INFO - Running setup.py install for mozdevice 20:08:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:02 INFO - Running setup.py install for mozfile 20:08:03 INFO - Running setup.py install for mozhttpd 20:08:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Running setup.py install for mozinfo 20:08:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Running setup.py install for mozInstall 20:08:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Running setup.py install for mozleak 20:08:03 INFO - Running setup.py install for mozlog 20:08:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Running setup.py install for moznetwork 20:08:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Running setup.py install for mozprocess 20:08:04 INFO - Running setup.py install for mozprofile 20:08:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:04 INFO - Running setup.py install for mozrunner 20:08:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:04 INFO - Running setup.py install for mozscreenshot 20:08:04 INFO - Running setup.py install for moztest 20:08:04 INFO - Running setup.py install for mozversion 20:08:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:04 INFO - Cleaning up... 20:08:04 INFO - Return code: 0 20:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:04 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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:08:04 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 20:08:04 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 20:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:04 INFO - 'HOME': '/Users/cltbld', 20:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:04 INFO - 'LOGNAME': 'cltbld', 20:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:04 INFO - 'MOZ_NO_REMOTE': '1', 20:08:04 INFO - 'NO_EM_RESTART': '1', 20:08:04 INFO - 'PAGER': '/bin/cat', 20:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:04 INFO - 'PWD': '/builds/slave/test', 20:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:04 INFO - 'SHELL': '/bin/bash', 20:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:08:04 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:04 INFO - 'USER': 'cltbld', 20:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:04 INFO - 'XPC_FLAGS': '0x0', 20:08:04 INFO - 'XPC_SERVICE_NAME': '0', 20:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ow0gev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:05 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)) 20:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-SjuxSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:05 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)) 20:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-B0TVFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:05 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)) 20:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-OyiETM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:05 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)) 20:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-XbUWI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:05 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)) 20:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-V5k6aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:05 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)) 20:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-f6dtF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:05 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)) 20:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-_0YXD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:06 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)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Ytswce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:06 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)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-fj4KxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:06 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)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-m_CcqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:06 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)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ceUqtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Ff1qqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:06 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)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-07plD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:06 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)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-zZsGew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:06 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)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-AtxBqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:06 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)) 20:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Q6MiwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:07 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)) 20:08:07 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)) 20:08:07 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)) 20:08:07 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)) 20:08:07 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)) 20:08:07 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)) 20:08:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:09 INFO - Downloading blessings-1.6.tar.gz 20:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:08:09 INFO - Installing collected packages: blessings 20:08:09 INFO - Running setup.py install for blessings 20:08:09 INFO - Successfully installed blessings 20:08:09 INFO - Cleaning up... 20:08:10 INFO - Return code: 0 20:08:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:10 INFO - Reading from file tmpfile_stdout 20:08:10 INFO - Current package versions: 20:08:10 INFO - blessings == 1.6 20:08:10 INFO - blobuploader == 1.2.4 20:08:10 INFO - docopt == 0.6.1 20:08:10 INFO - functools32 == 3.2.3-2 20:08:10 INFO - jsonschema == 2.5.1 20:08:10 INFO - manifestparser == 1.1 20:08:10 INFO - mozInstall == 1.12 20:08:10 INFO - mozcrash == 1.0 20:08:10 INFO - mozdebug == 0.1 20:08:10 INFO - mozdevice == 0.49 20:08:10 INFO - mozfile == 1.2 20:08:10 INFO - mozhttpd == 0.7 20:08:10 INFO - mozinfo == 0.9 20:08:10 INFO - mozleak == 0.1 20:08:10 INFO - mozlog == 3.4 20:08:10 INFO - moznetwork == 0.27 20:08:10 INFO - mozprocess == 0.25 20:08:10 INFO - mozprofile == 0.28 20:08:10 INFO - mozrunner == 6.13 20:08:10 INFO - mozscreenshot == 0.1 20:08:10 INFO - mozsystemmonitor == 0.3 20:08:10 INFO - moztest == 0.8 20:08:10 INFO - mozversion == 1.4 20:08:10 INFO - psutil == 3.1.1 20:08:10 INFO - requests == 1.2.3 20:08:10 INFO - wsgiref == 0.1.2 20:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:10 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')]} 20:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:10 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')]} 20:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:10 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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:08:10 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 20:08:10 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 20:08:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:08:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:10 INFO - 'HOME': '/Users/cltbld', 20:08:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:10 INFO - 'LOGNAME': 'cltbld', 20:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:10 INFO - 'MOZ_NO_REMOTE': '1', 20:08:10 INFO - 'NO_EM_RESTART': '1', 20:08:10 INFO - 'PAGER': '/bin/cat', 20:08:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:10 INFO - 'PWD': '/builds/slave/test', 20:08:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:10 INFO - 'SHELL': '/bin/bash', 20:08:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:08:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:08:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:10 INFO - 'USER': 'cltbld', 20:08:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:10 INFO - 'XPC_FLAGS': '0x0', 20:08:10 INFO - 'XPC_SERVICE_NAME': '0', 20:08:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 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)) 20:08:10 INFO - Cleaning up... 20:08:10 INFO - Return code: 0 20:08:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:08:10 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')]} 20:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:10 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')]} 20:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:10 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 0x1010e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8713c7d090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, '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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 20:08:10 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 20:08:10 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 20:08:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:08:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:10 INFO - 'HOME': '/Users/cltbld', 20:08:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:10 INFO - 'LOGNAME': 'cltbld', 20:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:10 INFO - 'MOZ_NO_REMOTE': '1', 20:08:10 INFO - 'NO_EM_RESTART': '1', 20:08:10 INFO - 'PAGER': '/bin/cat', 20:08:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:10 INFO - 'PWD': '/builds/slave/test', 20:08:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:10 INFO - 'SHELL': '/bin/bash', 20:08:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:08:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:08:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:10 INFO - 'USER': 'cltbld', 20:08:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:10 INFO - 'XPC_FLAGS': '0x0', 20:08:10 INFO - 'XPC_SERVICE_NAME': '0', 20:08:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:08:10 INFO - Cleaning up... 20:08:10 INFO - Return code: 0 20:08:10 INFO - Running post-action listener: _resource_record_post_action 20:08:10 INFO - Running post-action listener: _start_resource_monitoring 20:08:10 INFO - Starting resource monitoring. 20:08:10 INFO - [mozharness: 2017-04-26 03:08:10.919012Z] Finished create-virtualenv step (success) 20:08:10 INFO - [mozharness: 2017-04-26 03:08:10.920025Z] Running install step. 20:08:10 INFO - Running pre-action listener: _resource_record_pre_action 20:08:10 INFO - Running main action method: install 20:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:11 INFO - Reading from file tmpfile_stdout 20:08:11 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:08:11 INFO - Reading from file tmpfile_stdout 20:08:11 INFO - Output received: 20:08:11 INFO - Usage: mozinstall [options] installer 20:08:11 INFO - Options: 20:08:11 INFO - -h, --help show this help message and exit 20:08:11 INFO - -d DEST, --destination=DEST 20:08:11 INFO - Directory to install application into. [default: 20:08:11 INFO - "/builds/slave/test"] 20:08:11 INFO - --app=APP Application being installed. [default: firefox] 20:08:11 INFO - mkdir: /builds/slave/test/build/application 20:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 20:08:26 INFO - Reading from file tmpfile_stdout 20:08:26 INFO - Output received: 20:08:26 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:08:26 INFO - Running post-action listener: _resource_record_post_action 20:08:26 INFO - [mozharness: 2017-04-26 03:08:26.318858Z] Finished install step (success) 20:08:26 INFO - [mozharness: 2017-04-26 03:08:26.318994Z] Running run-tests step. 20:08:26 INFO - Running pre-action listener: _resource_record_pre_action 20:08:26 INFO - Running main action method: run_tests 20:08:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:08:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:08:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:08:26 INFO - 2017-04-25 20:08:26.332 screenresolution[1619:7301] starting screenresolution argv=screenresolution get 20:08:26 INFO - 2017-04-25 20:08:26.335 screenresolution[1619:7301] Display 0: 1600x1200x32@60 20:08:26 INFO - 2017-04-25 20:08:26.340 screenresolution[1620:7303] starting screenresolution argv=screenresolution list 20:08:26 INFO - Available Modes on Display 0 20:08:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:08:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:08:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:08:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:08:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:08:26 INFO - Intel Iris: 20:08:26 INFO - Chipset Model: Intel Iris 20:08:26 INFO - Type: GPU 20:08:26 INFO - Bus: Built-In 20:08:26 INFO - VRAM (Dynamic, Max): 1536 MB 20:08:26 INFO - Vendor: Intel (0x8086) 20:08:26 INFO - Device ID: 0x0a2e 20:08:26 INFO - Revision ID: 0x0009 20:08:26 INFO - Displays: 20:08:26 INFO - Display: 20:08:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:08:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:08:26 INFO - Display Serial Number: 1600x1200 60 20:08:26 INFO - Main Display: Yes 20:08:26 INFO - Mirror: Off 20:08:26 INFO - Online: Yes 20:08:26 INFO - Rotation: Supported 20:08:26 INFO - Return code: 0 20:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:08:26 INFO - Python 2.7.3 20:08:26 INFO - Return code: 0 20:08:26 INFO - grabbing minidump binary from tooltool 20:08:26 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')]} 20:08:26 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 0x100ec1d30>, '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 0x100de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eb6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:08:26 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 20:08:26 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 20:08:26 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 20:08:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:08:26 INFO - Return code: 0 20:08:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:08:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:08:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:08:26 INFO - ENV: RUST_BACKTRACE is now 1 20:08:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:08:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 20:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 20:08:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kxKwEZYEi7/Render', 20:08:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:26 INFO - 'HOME': '/Users/cltbld', 20:08:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:26 INFO - 'LOGNAME': 'cltbld', 20:08:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:08:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:26 INFO - 'MOZ_NO_REMOTE': '1', 20:08:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:08:26 INFO - 'NO_EM_RESTART': '1', 20:08:26 INFO - 'PAGER': '/bin/cat', 20:08:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:26 INFO - 'PWD': '/builds/slave/test', 20:08:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:08:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:26 INFO - 'RUST_BACKTRACE': '1', 20:08:26 INFO - 'SHELL': '/bin/bash', 20:08:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S8tFbcmpFE/Listeners', 20:08:26 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 20:08:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:26 INFO - 'USER': 'cltbld', 20:08:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:26 INFO - 'XPC_FLAGS': '0x0', 20:08:26 INFO - 'XPC_SERVICE_NAME': '0', 20:08:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 20:08:26 INFO - mozversion application_buildid: 20170425184210 20:08:26 INFO - mozversion application_changeset: cd699ab3018fd805767a78e78c8a9564f28ee72c 20:08:26 INFO - mozversion application_display_name: Firefox 20:08:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:08:26 INFO - mozversion application_name: Firefox 20:08:26 INFO - mozversion application_remotingname: firefox 20:08:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:08:26 INFO - mozversion application_vendor: Mozilla 20:08:26 INFO - mozversion application_version: 54.0 20:08:26 INFO - mozversion platform_buildid: 20170425184210 20:08:26 INFO - mozversion platform_changeset: cd699ab3018fd805767a78e78c8a9564f28ee72c 20:08:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:08:26 INFO - mozversion platform_version: 54.0 20:08:26 INFO - using testdate: 1493176106 20:08:26 INFO - actual date: 1493176106 20:08:26 INFO - starting webserver on 'localhost:49243' 20:08:26 INFO - SUITE-START | Running 2 tests 20:08:26 INFO - TEST-START | dromaeo_css 20:08:26 INFO - operating with platform_type : mac_ 20:08:26 INFO - Initialising browser for dromaeo_css test... 20:08:26 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpGgs7Ty/profile http://localhost:49243/getInfo.html) 20:08:29 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 20:08:29 INFO - PROCESS | 1630 | colorDepth:24 20:08:29 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 20:08:29 INFO - PROCESS | 1630 | __metrics 20:08:29 INFO - PROCESS | 1630 | 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" 20:08:29 INFO - PROCESS | 1630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:08:30 INFO - TEST-INFO | 1630: exit 0 20:08:30 INFO - Browser initialized. 20:08:30 INFO - Running cycle 1/1 for dromaeo_css test... 20:08:30 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpGgs7Ty/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:08:41 INFO - PROCESS | 1633 | RSS: Main: 165179392 20:08:41 INFO - PROCESS | 1633 | 20:11:45 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 20:11:48 INFO - PROCESS | 1633 | RSS: Main: 406011904 20:11:48 INFO - PROCESS | 1633 | 20:14:51 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 20:14:52 INFO - PROCESS | 1633 | RSS: Main: 301576192 20:14:52 INFO - PROCESS | 1633 | 20:17:54 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 20:17:55 INFO - PROCESS | 1633 | RSS: Main: 285151232 20:17:55 INFO - PROCESS | 1633 | 20:20:57 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 20:20:58 INFO - PROCESS | 1633 | RSS: Main: 274550784 20:20:58 INFO - PROCESS | 1633 | 20:24:02 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 20:24:02 INFO - PROCESS | 1633 | RSS: Main: 276258816 20:24:02 INFO - PROCESS | 1633 | 20:27:05 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 20:27:06 INFO - PROCESS | 1633 | RSS: Main: 500740096 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - PROCESS | 1633 | __start_tp_report 20:27:06 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 20:27:06 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 20:27:06 INFO - PROCESS | 1633 | |i|pagename|runs| 20:27:06 INFO - PROCESS | 1633 | |0;dojo.html;3546.8935931922033;3558.377283975305;3575.8212089395533;3604.098975256186;3627.220147668251;6219.906701399483;6223.066540018999;6229.221347331583;6232.5013998880095;6255.468285195764;6200.782972595949;6273.498120150389;6284.340144284842;6289.119523266746;6292.968535157318;5491.533219676322;5522.0336441122845;5548.500634942854;5556.944430555704;5666.54667626591;5425.26758887551;5425.647332923367;5436.91844622331;5612.5229355504625;5648.43515648436;5523.585731070166;5528.44715528446;5531.2532808071;5531.363893152278;5540.695261760601;5521.337439507285;5522.530584900288;5528.06022976095;5535.944640553583;5540.252065971083;5397.437238233244;5432.456754324576;5477.534409575191;5478.45215478453;5478.58910581708;6199.256089269272;6216.316205217422;6224.221972253468;6233.3143354231;6252.906206406908;6444.355564443565;6452.806415807533;6463.644499552523;6467.773627923;6472.449841763456;6549.279579246279;6549.93450065498;6554.279029306773;6560.0815885775555;6583.572067815625;6117.562731150785;6131.346082861964;6185.752569897244;6297.968510157466;6347;6643.534952553371;6714.362135597111;6794.864102717918;6796.490263230277;6797.2523022467485;6385.904211436832;6414.518911081687;6417.294097649255;6420.711068001951;6427.903581446282;6601.768938087144;6603.240627327823;6604.108445359815;6608.7356505739235;6610.0745895574655;6241.78153764616;6271.27880293763;6302.590331628521;6308.337624549448;6393.488520918316;6406.359364063556;6408.967955160288;6412.775552855627;6423.775167869102;6426.742930282736;5135.204043373283;5222.608304377187;5253.842384728464;5259.710715910585;5268.473152684701;4603.355530225771;4610.654200934876;4648.558386953302;4660;4695.741734204583;6258.968705156445;6276.592021518587;6281.937180628135;6284.151639528696;6303.527235457359;6555.147830781968;6564.4420224281475;6573.835654108686;6574.8356291093105;6578.5395022347975;6031.035034394564;6065.059915713072;6204.410580994799;6268.592541484789;6276.435120839146;5692.459216374438;5696.971515142398;5779.017567013618;5787.305523337142;5856.912146317809;6793.116894803644;6795.52431329812;6799.660016999229;6802.897956530755;6810.863782724317;6435.646039467874;6548.1814773153355;6561.967190164019;6563.573367731082;6581.210254769267;5638.295213098363;6453.645049522322;6484.383983521558;6635.336466353326;6765.2896445872475;5776.335721392094;6423.389777971085;6434.67826608677;6435.034744788132;6447.290798012309;5950.239585346375;6009.128676341993;6448.419642232034;6500.837479062872;6514.315996820455;5496.80761173357;6279.026750853625;6291.307956124914;6317.052442133717;6348.9047664286;6250.781222657185;6281.026440901667;6346.333634968262;6363.490920726424;6377.808665740035;6168.814935551941;6308.179936608211;6316.526260530387;6323;6328.588641738273;6260.40526150015;6279.277883043508;6314.557980941474;6324.083007963912;6335.049742538656;6280.811575652738;6306.148669929501;6319.52603554726;6321.051842223703;6345.0482427636225 20:27:06 INFO - PROCESS | 1633 | |1;ext.html;769.5959621198871;828.134599343686;901.571753417127;911.5396724654053;915.4049867586064;41771;42130.36804447936;42448.787756061254;42592.36111458327;42605.14789704204;43025.709228723186;43247.78376108123;43294.13411731763;43350.349744753854;43383.132337353316;7970.840583188333;8113.594320283992;9700.902990970106;9837.409755414697;9851.95074024629;11759;11853.288802671867;12194.451249693786;12214.877851221463;12217.38913054348;11991.880081199208;12057.758844823098;12062.819057714141;12081.093917956188;12084.637460876187;11952.342621155833;11986.400679965967;11995.94002029993;12010.879891201152;12037;11631.243969141979;11685.182037257395;11688.94799468052;11689.298642081503;11730.237534560227;40365;40480.59519404798;40483.59516404857;40532.18935621271;40637;3952.458959255525;4070.2266569352023;4086.1010577672864;4092.877213683594;4099.159672267178;29216.123516294545;29668.258293542833;30402.54396184059;31235.531467028013;31335.9032433866;3287.145342211042;3297.225152089257;3312.801231926092;3443.328550932569;3443.483477478373;332801;338399;338474.30762846273;339127.99999999756;339571;45182.32226516605;46165;48325;52965;53164.73417632887;47830.28254576184;47843;47919.760401198466;56290;57146;15503.84496155024;15888.364465421484;15899.761503577456;15912.52262432129;15972.600684982968;13505.729885402237;13617.523386681418;13619.387127579283;13624.455021799215;13638.522651707142;12969.120904716388;12981;13025.153365031432;13028.47886084565;13196.340182990813;5828.154917536934;5831.883362332815;5864.211415518308;5892.705364731746;5896.852578685567;973.2651847854825;984.5815528400401;989.6734077754323;996.5216695985822;1008.1128606826093;29882.40235195284;30165.396692066035;30458.390832183675;30728.924487642824;30806;925.8055808280336;1019.4851599942131;1055.8310670292717;1075.5590208014676;1083.7778255457613;12711.745765084646;15746.133962631937;15768.76346854798;15823.73910351781;15966.920165399099;372315.1384243116;442231;442573;442756;443464;58946;59019.70490147608;59274.40725592775;59449;59458.10812837811;1465.5383554180612;1508.1705062215956;1516.3403919295142;1519.688463864905;1520.8403117672706;28534.286642833264;29204.853975729984;29321;29902.850485747433;29943.700562994964;40803.7959810199;47142.52857471381;50002.74998625129;50129.248061278384;50294.49705503044;411644;412565;413012;413596.7960480535;414402.9279853702;30064.549031764105;30169.849150754108;30542.930997414984;30826;36215;37030.44454333241;37706.8114659425;45793.77103114463;47713;47960.520394797;29427.411451771273;32080.73099110133;32186.35627287394;32760.83619581887;33074.83462582672;26572.335691607863;31414.685853141174;32509.512357314186;32894.835525822215;34857.65142348645;41771.582284176766;43164.352534712634;43341.34987975246;44334;44538.3319250205;41203.7939810311;41690.374644380965;41886.581134188265;42441;42950;28346;32304.515432268065;34047.4892876612;34590.308193836485;34742 20:27:06 INFO - PROCESS | 1633 | |2;jquery.html;392.1372979445221;427.8167823928767;431.0839466134464;434.2314104035856;441.5650584174588;15848.28682709278;21406.357809265708;23128.88435557824;23544;23826.166084187058;16490.505284841474;20336.084876180572;20372.490687732814;22649.660255096187;23891.805409729488;6552.180977377828;6957.130358705162;7044.682989265495;7231.89152162718;7279.162896266917;6317.905231421532;7199.460040496958;7207.855842883139;7258.528195667292;7305;6933.445324374038;7179.425645948311;7244.782656520313;7248.746293879715;7255.238199989004;5812.941870581282;7087.929120708778;7104.609246491441;7162.570245785243;7190.784276471714;6798.626075565842;6888.965555172243;6969;6992.230854605989;6992.2658120897595;28512.429751405063;28619.14142575726;28639.28401789951;28644.856775716198;28662.570061449096;3060.9540856887165;3603.3153700796765;3618.4210526315665;3668.046307959923;3735.3089678409583;10950.671479855617;11584.47869845859;17648.55878603045;18192.72710909324;18375.540611484685;2074.3362124120285;2088.185607613032;2090.3937858021154;2099.041374857212;2169.9783002169934;121996;155047.22476387545;156605;157389;170509;18276.73376179802;18954.715679264824;25081.372965676004;25167.87416062908;25760.613590796154;43615.781921090194;44117.77941110274;44683;44744.77627611906;44885.32672009923;11742.765144697058;11847.822282665767;11982.820257696141;11996.40017999114;12236.510539578496;8065.7901314802075;9716.659916903016;9728.902710972941;9730.12428881404;9901.05939935705;8710.825783484295;11465.426728663533;11560.537578496765;11800.996915262298;11929.150981597693;3787.62123787619;3909.243982992041;4636.165490211727;4641.164590373698;4678.76606169697;1064.1965316186383;1074.435921141407;1077.8059949209219;1089.7657003744232;1118.8433619293305;20046.699299510517;22627.321180364615;22735.317940461813;22753.772462275167;22760.88619556925;1072.8176210044312;1086.7500474890662;1093.6384201668973;1118.59730497021;1133.5239199536215;11193.552257909592;11462.54149834014;11774.175807693378;11792;11796.52813887435;680983;753257;756937;766567;777922;140955;153529;154910;157780.87126598574;158532.20733896256;1207.4264724255909;1214.3381856888018;1268.3151098406756;1273.0833799664226;1274.1972557288848;18290.908545457187;18804.717929231345;19017.809821902156;19023.809761902758;19314.71027934554;61051.77896442135;63700.40748981312;68124;68314;69703;79192.60403697945;90587.54706226426;91746;93514.12971740663;94139.52930235305;7585.502553244489;11576.594819181626;11795.52817887275;12056.457459414523;12229.266244025386;13429.992750543553;13824.447022119002;13830.170189788645;14083;14149.08030977983;8417.5791210438;11625.5349786011;11641.6507504775;11782.941085294518;11985.820212696643;10403.895961040293;10778.730531736455;11021;11116.888831111586;11396.715082123013;10962;11847.052235820942;12095.939520302341;12100.309405631368;12122.969547588202;10961.945190273998;11890.821637675615;12212.206206596542;12218.450169742206;12330;10581.100606448537;11753.823692644788;11937.045036396894;12052.337121458404;12102.515899363927 20:27:06 INFO - PROCESS | 1633 | |3;mootools.html;1611.814641316249;1626.1869065467267;1645.7778199943007;1649.8102718187413;1650.4800987688877;11089.33463992161;11704.707382315446;11708.941455292734;11719.648410547687;11730.706732331695;9641.662541811038;10967.122630189586;11321.830172547398;11498.597549085784;11537.538498460073;2460.2865169100983;2508.636247744076;2512.773850353468;2521.35705395124;2521.684789401325;2436.7319594844553;2454.7790698837102;2496.662950501677;2497.6628155198996;2503.1364179358093;2420.9636855447184;2441.2554170977846;2463.408781892351;2467.0625162438337;2472.443700167457;2356.3873392917794;2368.786809187164;2421.0799896039393;2445.730969593343;2454.128784281581;2111.1977448569446;2450.1179575352858;2469.2839076667747;2472.925812225636;2477.7522247775078;10715.249932504728;10753.569857205703;10788.406637634927;10795.83806242907;10797.29817561856;5886.6173698709445;6089.847753806146;6097.542684298695;6097.695115244264;6105.755769769248;3540.6990405815536;3548.308079924416;3629;3692.51997240357;3749.43758436234;1213.7875871722501;1221.4442428694922;1256.2525297448094;1278.0670110819153;1278.9680257993532;14316.069455485464;14630.26848657563;14968;16436.1781910904;16673.24970376324;4662.440507139165;4827.831025914076;4839.056384005085;4871.780769865293;4893.290472881412;10615.097716694014;12164.14850960442;12198;12198.085143614264;12228.755424891453;5129.820456284012;5185.922211166836;5188.299579556787;5189.532942035159;5202.661826981234;5289.57683385336;5342.492463215988;5511.145772405283;5520.91718624221;5552.333719953632;3208.7272581830807;3404.2000129969438;3976.522817261889;4015.0326340093143;4052.594740525924;1034.7568321444455;1037.6835065305154;1039.443897514826;1046.2048842879467;1052.578968412641;797.2846535146307;824.9958750206331;845.2350622686479;875.8554838451712;876.4697358098259;5814;5981.803639272163;6310.368963103653;6467.159269294962;6980.825479363057;1014.8680671512803;1024.4530758554636;1027.5786927359748;1048.365738728074;1050.3907733514543;4150.730202536825;4213.747175169499;4234.809433575497;4265.061686429042;4357.0632314052;14132.01075924696;14793;14812.481563145453;14835.480758173628;14842.925785371004;14331.641708957359;14559.344829482487;14668.633284167981;14759.852401475848;14781.26093695311;10086.848697269546;10223;10234.181265498892;10243.975602439696;10245.74385640365;6368.617882927039;6369.554131210956;6423.96788016057;6547.083408322934;6556.442702370352;10056.49717514136;11005.119590432587;11467.197296189186;12122.575709850113;12126.818097728717;11546.76906461883;11777.234479758788;13224.669383265495;13239.3380330985;13264.602061938158;6972.721091156297;9179.724608261762;9345.479249624517;9398.95300523493;9462.290328225274;10302.175825933757;10327.48362581853;10412.739681508023;10439.478026098514;10483.475826208507;9036.638534458549;9042.819143617222;9058.728238152866;9169.679061232824;9187.816243675223;8604.268637165911;8663.48019118855;8673.826523469621;8704.738857834274;8710.346723995599;8053.718119865776;8135.633896474555;8161.79595510117;8171.509709417454;8202.466839655403;5944.613600115978;5990.6705131218205;5993.31076926159;6006.819795406145;6059.424354686298;5929.377415371497;5979.790707325223;6025.186599809145;6125.264968203844;6132.38676132401 20:27:06 INFO - PROCESS | 1633 | |4;prototype.html;372.8937252882928;385.2603002235707;387.45562484708995;389.33812518718184;393.95666476687575;4173.520045194796;4312.611864932155;4418.7406589122065;4945.826896058638;5125.564327032207;4252.893677658052;4272.935905961405;4450.5104438511735;4634.791434385453;4822.710637361761;3310.3875782980103;3553.662402071799;4060.451839001741;4175.853845115414;4303.526612072669;3980.263651224518;3983.629740304514;4129.6076872697195;4296.334068219431;4313.913721725564;3804.5054142961376;4306.956930430687;4307.763073030982;4313.223619748444;4324.37296591994;3948.7038472114705;4142.71001029928;4167.812448439828;4248.9787551062045;4251.300424230605;3951.3480275754464;3951.4270430787374;3952.822123004472;3966.8661757211767;3978.9455794214555;4549.795259213343;4719.787609557544;4798.256270278112;5027.421846487664;5249.4488078751565;4555.316702494619;4610.838620648295;4691.460482044575;4691.507391723888;4861.180515301116;5006.699598024094;5010.69935803853;5234.037236036486;5481.943361912156;5483;3902.7853468059247;4457.952381190417;4530.524294949016;4603.7698115094445;4618.376519169903;4959.991203562527;5108.752149054404;5227.6079294052715;5480.479354461319;5868.151532267322;3939.7045221608496;4149.9832541027645;4455.086707225011;4460.643148548108;4492.3935268738305;4212.915741685149;4276.444062271885;4356.934645980313;4519.525449827786;4563.885902852455;4261.998430368861;4505.459344878635;4722.5513576210205;4858.02839432115;4968.571685536968;5115.693058416507;5395.838124856261;5408.323959505062;5425.68657916957;5439.374471935699;1344.475654494748;1393.533166389271;1414.886809055273;1540.0297812378353;1541.6685412636336;1055.2560444886337;1099.5931505343074;1171.3908767440882;1171.976560468803;1174.6843535240414;4615.284630882219;4747.999999999931;4779.674394672757;5092.516210959953;5102.4897510248675;5190.598538394613;5315.388730296066;5386.559574829372;5458.243586988625;5623.947259250344;4357.847475338412;4435.179491794029;4487.214737420938;4697.577218050392;4871.5128487151715;2342.3909783456425;2735.64883018301;2783.401568662747;2962.215013021551;2977.211039074647;5334.253204551366;5624.409437009055;5871.442212989759;5883.441073098049;5892.469677729025;5408.4050754416985;5421.3464893207165;5523.8066667666435;5691.8861622768145;5771.883183081173;4784.784684689267;5091.516305950929;5716.742746576414;5758;5758.7618661987035;5160.477659090502;5163.690178589297;5368.409474957673;5684.8010319638615;5692.43075692444;5289.550388217045;5352.464753524617;5478.301726464809;5591.692456914746;5652.773889044557;5071.71772702278;5411.891762164656;5470.4988807164245;5857.50211232033;5877.4122587740885;3953.8418463261146;4064.6138616831354;4449.3770872078585;4511.842085526991;4544.863654090383;4860.465348811698;4958.8760280993265;5405.324334458192;5463.4536546346635;5606.439356064361;4539.84110556129;5261.763220655003;5417.079096553516;5433.375161856437;5448.809291674773;4492.303692927601;4823.662343635911;4950.084234416644;5256.553192978639;5508.063629182969;4832.589229915497;5224.238548245257;5310.495502927216;5340.75966581497;5355.357357117015;4642.721436713808;4798.712077275374;5185.974070129625;5275.522853600998;5482.958237934779;4283.329501494357;4618.907621847611;4960.330355401975;5391.649542779707;5415.837524874102 20:27:06 INFO - PROCESS | 1633 | |5;yui.html;762.7063580521498;768.9577073260969;805.5730462854685;868.2619773192785;876.4128034217074;15751.133687647189;16769.24538395772;17310.913445432787;17389.39137130201;18032.729509057375;15770;15881.602959926007;16313.755293670605;16414.83585164148;16566.83433165668;990.8464188050827;995;995.0596686131609;996.696007717644;996.8305388084007;990.2573070197352;1006.2603986070233;1031.8297480915678;1033.2302434686133;1034.9948250258776;1066.7333166708322;1068.2468859454104;1069.2996087562658;1071.7481391872905;1073.2058276875096;1061.6178175856685;1062.9309094908806;1063.2079101069753;1063.8351055586397;1063.8616979792616;783.7413653494333;783.91768864269;784.8391079828679;786.1705900275207;786.685325869651;16928;16928.23822927959;16999.660006799917;17743.645127097516;18019.27922883083;14654;14656.633584160374;14721.705565888622;14738.55784326472;14858.702825943421;12024.204177816793;12206.328651924141;12226.388680566026;12250.387480625934;12566.81149782754;3765.303418867491;3880.6507414332564;3895.824687889052;3916.7649941003347;4040.4949381327333;118511;118677.40661296724;122137;122143;122463.38768306191;11508.136889733303;11568.074554035657;11588.768224635629;11628.1860269782;12178.512859485698;24304.7569524306;24426.755732442805;24533.754662453146;24726;24726.629100563507;7729;7799.220077992269;7900.960495197487;8080.83838323242;8311.875321870177;3898.317794385971;4219.3249080147025;4494.37078808967;4623.676342655982;4767.380240568704;3264.1186879542865;3289.605247370283;3356.664333566624;3371.5448414463735;3388.0513456232293;572.5019233267001;588.664461257088;590.8286596886941;592.4756590417511;594.5570549940322;644.3105876711967;652.6852700126259;654.2182092399632;656.3961155736733;670.3899451499112;10059.849102263472;10669.19981001428;10750.677479675465;10882.61910833117;11794.174407791545;578.8205656246577;580.3007376111775;607.7052629474701;650.2294780684904;730.6273800361854;5120.206368012964;5222.060029194781;5236.895262094813;5244.737763111829;5248.606354523426;52884;84243.15756842475;101954.49022754839;104531.43202851963;106737.46631266794;74945.62527187329;85576.14423855806;91456.54271728599;92026.53986730023;94630;67856;68161.65919170373;69756.302436976;71824;79716;9831.754206144904;11127.499262533367;11215.775684486427;11234.887651123385;11548.191626586395;35481;49974.750126249135;50953.23570146377;51682.22476662928;53217;57449.85100298054;62411.37588624056;63562.046569300575;65239.347606523326;65689;10375.740606484898;12914.09601327898;13025.413856376295;13513.527026554417;13739.62603739658;15596.307347818192;16020.919895400448;16035.919820400823;16043.759343609621;16051.839481605502;13744.86255137436;14050.227237502035;14452;14549.345279462237;14562;14313.427462901784;14363.784543231652;14574.417023318949;14611.561653150422;15280;13340.799888001493;14354.712905741619;14370.209638469985;14575.489857854924;14650.19423931694;10022.749431264278;10216.080552750289;10660.946695266784;10802.227160370276;10902.945485272523;10106.343087699275;10136.949315253376;11434.199606027498;11620.825687614524;11683.18217724751 20:27:06 INFO - PROCESS | 1633 | __end_tp_report 20:27:06 INFO - PROCESS | 1633 | __start_cc_report 20:27:06 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,2883 20:27:06 INFO - PROCESS | 1633 | __end_cc_report 20:27:06 INFO - PROCESS | 1633 | __startTimestamp1493177226081__endTimestamp 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - PROCESS | 1633 | ------- Summary: start ------- 20:27:06 INFO - PROCESS | 1633 | Number of tests: 6 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:6059.50 Median:6284.15 stddev:654.60 (10.4%) stddev-sans-first:626.23 20:27:06 INFO - PROCESS | 1633 | Values: 3546.9 3558.4 3575.8 3604.1 3627.2 6219.9 6223.1 6229.2 6232.5 6255.5 6200.8 6273.5 6284.3 6289.1 6293.0 5491.5 5522.0 5548.5 5556.9 5666.5 5425.3 5425.6 5436.9 5612.5 5648.4 5523.6 5528.4 5531.3 5531.4 5540.7 5521.3 5522.5 5528.1 5535.9 5540.3 5397.4 5432.5 5477.5 5478.5 5478.6 6199.3 6216.3 6224.2 6233.3 6252.9 6444.4 6452.8 6463.6 6467.8 6472.4 6549.3 6549.9 6554.3 6560.1 6583.6 6117.6 6131.3 6185.8 6298.0 6347.0 6643.5 6714.4 6794.9 6796.5 6797.3 6385.9 6414.5 6417.3 6420.7 6427.9 6601.8 6603.2 6604.1 6608.7 6610.1 6241.8 6271.3 6302.6 6308.3 6393.5 6406.4 6409.0 6412.8 6423.8 6426.7 5135.2 5222.6 5253.8 5259.7 5268.5 4603.4 4610.7 4648.6 4660.0 4695.7 6259.0 6276.6 6281.9 6284.2 6303.5 6555.1 6564.4 6573.8 6574.8 6578.5 6031.0 6065.1 6204.4 6268.6 6276.4 5692.5 5697.0 5779.0 5787.3 5856.9 6793.1 6795.5 6799.7 6802.9 6810.9 6435.6 6548.2 6562.0 6563.6 6581.2 5638.3 6453.6 6484.4 6635.3 6765.3 5776.3 6423.4 6434.7 6435.0 6447.3 5950.2 6009.1 6448.4 6500.8 6514.3 5496.8 6279.0 6291.3 6317.1 6348.9 6250.8 6281.0 6346.3 6363.5 6377.8 6168.8 6308.2 6316.5 6323.0 6328.6 6260.4 6279.3 6314.6 6324.1 6335.0 6280.8 6306.1 6319.5 6321.1 6345.0 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:55331.99 Median:19016.90 stddev:104251.23 (548.2%) stddev-sans-first:104463.19 20:27:06 INFO - PROCESS | 1633 | Values: 769.6 828.1 901.6 911.5 915.4 41771.0 42130.4 42448.8 42592.4 42605.1 43025.7 43247.8 43294.1 43350.3 43383.1 7970.8 8113.6 9700.9 9837.4 9852.0 11759.0 11853.3 12194.5 12214.9 12217.4 11991.9 12057.8 12062.8 12081.1 12084.6 11952.3 11986.4 11995.9 12010.9 12037.0 11631.2 11685.2 11688.9 11689.3 11730.2 40365.0 40480.6 40483.6 40532.2 40637.0 3952.5 4070.2 4086.1 4092.9 4099.2 29216.1 29668.3 30402.5 31235.5 31335.9 3287.1 3297.2 3312.8 3443.3 3443.5 332801.0 338399.0 338474.3 339128.0 339571.0 45182.3 46165.0 48325.0 52965.0 53164.7 47830.3 47843.0 47919.8 56290.0 57146.0 15503.8 15888.4 15899.8 15912.5 15972.6 13505.7 13617.5 13619.4 13624.5 13638.5 12969.1 12981.0 13025.2 13028.5 13196.3 5828.2 5831.9 5864.2 5892.7 5896.9 973.3 984.6 989.7 996.5 1008.1 29882.4 30165.4 30458.4 30728.9 30806.0 925.8 1019.5 1055.8 1075.6 1083.8 12711.7 15746.1 15768.8 15823.7 15966.9 372315.1 442231.0 442573.0 442756.0 443464.0 58946.0 59019.7 59274.4 59449.0 59458.1 1465.5 1508.2 1516.3 1519.7 1520.8 28534.3 29204.9 29321.0 29902.9 29943.7 40803.8 47142.5 50002.7 50129.2 50294.5 411644.0 412565.0 413012.0 413596.8 414402.9 30064.5 30169.8 30542.9 30826.0 36215.0 37030.4 37706.8 45793.8 47713.0 47960.5 29427.4 32080.7 32186.4 32760.8 33074.8 26572.3 31414.7 32509.5 32894.8 34857.7 41771.6 43164.4 43341.3 44334.0 44538.3 41203.8 41690.4 41886.6 42441.0 42950.0 28346.0 32304.5 34047.5 34590.3 34742.0 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:43842.70 Median:2089.29 stddev:124700.77 (5968.6%) stddev-sans-first:125007.91 20:27:06 INFO - PROCESS | 1633 | Values: 392.1 427.8 431.1 434.2 441.6 15848.3 21406.4 23128.9 23544.0 23826.2 16490.5 20336.1 20372.5 22649.7 23891.8 6552.2 6957.1 7044.7 7231.9 7279.2 6317.9 7199.5 7207.9 7258.5 7305.0 6933.4 7179.4 7244.8 7248.7 7255.2 5812.9 7087.9 7104.6 7162.6 7190.8 6798.6 6889.0 6969.0 6992.2 6992.3 28512.4 28619.1 28639.3 28644.9 28662.6 3061.0 3603.3 3618.4 3668.0 3735.3 10950.7 11584.5 17648.6 18192.7 18375.5 2074.3 2088.2 2090.4 2099.0 2170.0 121996.0 155047.2 156605.0 157389.0 170509.0 18276.7 18954.7 25081.4 25167.9 25760.6 43615.8 44117.8 44683.0 44744.8 44885.3 11742.8 11847.8 11982.8 11996.4 12236.5 8065.8 9716.7 9728.9 9730.1 9901.1 8710.8 11465.4 11560.5 11801.0 11929.2 3787.6 3909.2 4636.2 4641.2 4678.8 1064.2 1074.4 1077.8 1089.8 1118.8 20046.7 22627.3 22735.3 22753.8 22760.9 1072.8 1086.8 1093.6 1118.6 1133.5 11193.6 11462.5 11774.2 11792.0 11796.5 680983.0 753257.0 756937.0 766567.0 777922.0 140955.0 153529.0 154910.0 157780.9 158532.2 1207.4 1214.3 1268.3 1273.1 1274.2 18290.9 18804.7 19017.8 19023.8 19314.7 61051.8 63700.4 68124.0 68314.0 69703.0 79192.6 90587.5 91746.0 93514.1 94139.5 7585.5 11576.6 11795.5 12056.5 12229.3 13430.0 13824.4 13830.2 14083.0 14149.1 8417.6 11625.5 11641.7 11782.9 11985.8 10403.9 10778.7 11021.0 11116.9 11396.7 10962.0 11847.1 12095.9 12100.3 12123.0 10961.9 11890.8 12212.2 12218.5 12330.0 10581.1 11753.8 11937.0 12052.3 12102.5 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:6812.48 Median:2475.34 stddev:4321.00 (174.6%) stddev-sans-first:4315.45 20:27:06 INFO - PROCESS | 1633 | Values: 1611.8 1626.2 1645.8 1649.8 1650.5 11089.3 11704.7 11708.9 11719.6 11730.7 9641.7 10967.1 11321.8 11498.6 11537.5 2460.3 2508.6 2512.8 2521.4 2521.7 2436.7 2454.8 2496.7 2497.7 2503.1 2421.0 2441.3 2463.4 2467.1 2472.4 2356.4 2368.8 2421.1 2445.7 2454.1 2111.2 2450.1 2469.3 2472.9 2477.8 10715.2 10753.6 10788.4 10795.8 10797.3 5886.6 6089.8 6097.5 6097.7 6105.8 3540.7 3548.3 3629.0 3692.5 3749.4 1213.8 1221.4 1256.3 1278.1 1279.0 14316.1 14630.3 14968.0 16436.2 16673.2 4662.4 4827.8 4839.1 4871.8 4893.3 10615.1 12164.1 12198.0 12198.1 12228.8 5129.8 5185.9 5188.3 5189.5 5202.7 5289.6 5342.5 5511.1 5520.9 5552.3 3208.7 3404.2 3976.5 4015.0 4052.6 1034.8 1037.7 1039.4 1046.2 1052.6 797.3 825.0 845.2 875.9 876.5 5814.0 5981.8 6310.4 6467.2 6980.8 1014.9 1024.5 1027.6 1048.4 1050.4 4150.7 4213.7 4234.8 4265.1 4357.1 14132.0 14793.0 14812.5 14835.5 14842.9 14331.6 14559.3 14668.6 14759.9 14781.3 10086.8 10223.0 10234.2 10244.0 10245.7 6368.6 6369.6 6424.0 6547.1 6556.4 10056.5 11005.1 11467.2 12122.6 12126.8 11546.8 11777.2 13224.7 13239.3 13264.6 6972.7 9179.7 9345.5 9399.0 9462.3 10302.2 10327.5 10412.7 10439.5 10483.5 9036.6 9042.8 9058.7 9169.7 9187.8 8604.3 8663.5 8673.8 8704.7 8710.3 8053.7 8135.6 8161.8 8171.5 8202.5 5944.6 5990.7 5993.3 6006.8 6059.4 5929.4 5979.8 6025.2 6125.3 6132.4 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4482.89 Median:4735.28 stddev:1246.69 (26.3%) stddev-sans-first:1211.42 20:27:06 INFO - PROCESS | 1633 | Values: 372.9 385.3 387.5 389.3 394.0 4173.5 4312.6 4418.7 4945.8 5125.6 4252.9 4272.9 4450.5 4634.8 4822.7 3310.4 3553.7 4060.5 4175.9 4303.5 3980.3 3983.6 4129.6 4296.3 4313.9 3804.5 4307.0 4307.8 4313.2 4324.4 3948.7 4142.7 4167.8 4249.0 4251.3 3951.3 3951.4 3952.8 3966.9 3978.9 4549.8 4719.8 4798.3 5027.4 5249.4 4555.3 4610.8 4691.5 4691.5 4861.2 5006.7 5010.7 5234.0 5481.9 5483.0 3902.8 4458.0 4530.5 4603.8 4618.4 4960.0 5108.8 5227.6 5480.5 5868.2 3939.7 4150.0 4455.1 4460.6 4492.4 4212.9 4276.4 4356.9 4519.5 4563.9 4262.0 4505.5 4722.6 4858.0 4968.6 5115.7 5395.8 5408.3 5425.7 5439.4 1344.5 1393.5 1414.9 1540.0 1541.7 1055.3 1099.6 1171.4 1172.0 1174.7 4615.3 4748.0 4779.7 5092.5 5102.5 5190.6 5315.4 5386.6 5458.2 5623.9 4357.8 4435.2 4487.2 4697.6 4871.5 2342.4 2735.6 2783.4 2962.2 2977.2 5334.3 5624.4 5871.4 5883.4 5892.5 5408.4 5421.3 5523.8 5691.9 5771.9 4784.8 5091.5 5716.7 5758.0 5758.8 5160.5 5163.7 5368.4 5684.8 5692.4 5289.6 5352.5 5478.3 5591.7 5652.8 5071.7 5411.9 5470.5 5857.5 5877.4 3953.8 4064.6 4449.4 4511.8 4544.9 4860.5 4958.9 5405.3 5463.5 5606.4 4539.8 5261.8 5417.1 5433.4 5448.8 4492.3 4823.7 4950.1 5256.6 5508.1 4832.6 5224.2 5310.5 5340.8 5355.4 4642.7 4798.7 5186.0 5275.5 5483.0 4283.3 4618.9 4960.3 5391.6 5415.8 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:20626.61 Median:17155.29 stddev:29243.34 (170.5%) stddev-sans-first:29287.34 20:27:06 INFO - PROCESS | 1633 | Values: 762.7 769.0 805.6 868.3 876.4 15751.1 16769.2 17310.9 17389.4 18032.7 15770.0 15881.6 16313.8 16414.8 16566.8 990.8 995.0 995.1 996.7 996.8 990.3 1006.3 1031.8 1033.2 1035.0 1066.7 1068.2 1069.3 1071.7 1073.2 1061.6 1062.9 1063.2 1063.8 1063.9 783.7 783.9 784.8 786.2 786.7 16928.0 16928.2 16999.7 17743.6 18019.3 14654.0 14656.6 14721.7 14738.6 14858.7 12024.2 12206.3 12226.4 12250.4 12566.8 3765.3 3880.7 3895.8 3916.8 4040.5 118511.0 118677.4 122137.0 122143.0 122463.4 11508.1 11568.1 11588.8 11628.2 12178.5 24304.8 24426.8 24533.8 24726.0 24726.6 7729.0 7799.2 7901.0 8080.8 8311.9 3898.3 4219.3 4494.4 4623.7 4767.4 3264.1 3289.6 3356.7 3371.5 3388.1 572.5 588.7 590.8 592.5 594.6 644.3 652.7 654.2 656.4 670.4 10059.8 10669.2 10750.7 10882.6 11794.2 578.8 580.3 607.7 650.2 730.6 5120.2 5222.1 5236.9 5244.7 5248.6 52884.0 84243.2 101954.5 104531.4 106737.5 74945.6 85576.1 91456.5 92026.5 94630.0 67856.0 68161.7 69756.3 71824.0 79716.0 9831.8 11127.5 11215.8 11234.9 11548.2 35481.0 49974.8 50953.2 51682.2 53217.0 57449.9 62411.4 63562.0 65239.3 65689.0 10375.7 12914.1 13025.4 13513.5 13739.6 15596.3 16020.9 16035.9 16043.8 16051.8 13744.9 14050.2 14452.0 14549.3 14562.0 14313.4 14363.8 14574.4 14611.6 15280.0 13340.8 14354.7 14370.2 14575.5 14650.2 10022.7 10216.1 10660.9 10802.2 10902.9 10106.3 10136.9 11434.2 11620.8 11683.2 20:27:06 INFO - PROCESS | 1633 | -------- Summary: end -------- 20:27:06 INFO - PROCESS | 1633 | 20:27:06 INFO - TEST-INFO | 1633: exit 0 20:27:06 INFO - TEST-OK | dromaeo_css | took 1119773ms 20:27:06 INFO - TEST-START | kraken 20:27:06 INFO - operating with platform_type : mac_ 20:27:06 INFO - Initialising browser for kraken test... 20:27:06 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpIXaZhl/profile http://localhost:49243/getInfo.html) 20:27:08 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 20:27:08 INFO - PROCESS | 1642 | colorDepth:24 20:27:08 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 20:27:08 INFO - PROCESS | 1642 | __metrics 20:27:08 INFO - PROCESS | 1642 | 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" 20:27:08 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:27:09 INFO - TEST-INFO | 1642: exit 0 20:27:09 INFO - Browser initialized. 20:27:09 INFO - Running cycle 1/1 for kraken test... 20:27:09 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpIXaZhl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:21 INFO - PROCESS | 1644 | RSS: Main: 165289984 20:27:21 INFO - PROCESS | 1644 | 20:27:24 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 20:27:25 INFO - PROCESS | 1644 | RSS: Main: 216395776 20:27:25 INFO - PROCESS | 1644 | 20:27:28 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 20:27:28 INFO - PROCESS | 1644 | RSS: Main: 231960576 20:27:28 INFO - PROCESS | 1644 | 20:27:31 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 20:27:32 INFO - PROCESS | 1644 | RSS: Main: 328081408 20:27:32 INFO - PROCESS | 1644 | 20:27:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 20:27:34 INFO - PROCESS | 1644 | RSS: Main: 230252544 20:27:34 INFO - PROCESS | 1644 | 20:27:36 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:27:37 INFO - PROCESS | 1644 | RSS: Main: 232312832 20:27:37 INFO - PROCESS | 1644 | 20:27:40 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 20:27:41 INFO - PROCESS | 1644 | RSS: Main: 272068608 20:27:41 INFO - PROCESS | 1644 | 20:27:44 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 20:27:44 INFO - PROCESS | 1644 | RSS: Main: 273268736 20:27:44 INFO - PROCESS | 1644 | 20:27:47 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 20:27:48 INFO - PROCESS | 1644 | RSS: Main: 268242944 20:27:48 INFO - PROCESS | 1644 | 20:27:49 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:27:50 INFO - PROCESS | 1644 | RSS: Main: 248766464 20:27:50 INFO - PROCESS | 1644 | 20:27:52 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:27:53 INFO - PROCESS | 1644 | RSS: Main: 252518400 20:27:53 INFO - PROCESS | 1644 | 20:27:55 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:27:55 INFO - PROCESS | 1644 | RSS: Main: 259362816 20:27:55 INFO - PROCESS | 1644 | 20:27:58 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:27:59 INFO - PROCESS | 1644 | RSS: Main: 271843328 20:27:59 INFO - PROCESS | 1644 | 20:28:02 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:28:02 INFO - PROCESS | 1644 | RSS: Main: 264671232 20:28:02 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 20:28:04 INFO - PROCESS | 1644 | RSS: Main: 309358592 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | __start_tp_report 20:28:04 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 20:28:04 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 20:28:04 INFO - PROCESS | 1644 | |i|pagename|runs| 20:28:04 INFO - PROCESS | 1644 | |0;ai-astar;104;114;116;113;125;175;115;116;117;116 20:28:04 INFO - PROCESS | 1644 | |1;audio-beat-detection;137;107;108;140;105;108;106;122;128;94 20:28:04 INFO - PROCESS | 1644 | |2;audio-dft;179;185;180;184;182;185;184;184;187;186 20:28:04 INFO - PROCESS | 1644 | |3;audio-fft;82;59;56;88;62;60;59;58;73;60 20:28:04 INFO - PROCESS | 1644 | |4;audio-oscillator;87;69;86;70;69;68;83;69;69;83 20:28:04 INFO - PROCESS | 1644 | |5;imaging-gaussian-blur;89;89;89;89;89;89;90;89;88;88 20:28:04 INFO - PROCESS | 1644 | |6;imaging-darkroom;95;94;96;104;150;93;135;128;95;95 20:28:04 INFO - PROCESS | 1644 | |7;imaging-desaturate;83;85;85;87;85;85;83;84;86;84 20:28:04 INFO - PROCESS | 1644 | |8;json-parse-financial;61;58;62;60;62;61;63;88;92;93 20:28:04 INFO - PROCESS | 1644 | |9;json-stringify-tinderbox;56;68;63;64;60;59;57;59;57;57 20:28:04 INFO - PROCESS | 1644 | |10;stanford-crypto-aes;79;71;83;82;83;83;80;83;88;85 20:28:04 INFO - PROCESS | 1644 | |11;stanford-crypto-ccm;135;126;131;141;143;139;134;137;178;133 20:28:04 INFO - PROCESS | 1644 | |12;stanford-crypto-pbkdf2;162;162;163;163;160;164;161;161;162;161 20:28:04 INFO - PROCESS | 1644 | |13;stanford-crypto-sha256-iterative;64;63;64;62;62;65;63;60;61;62 20:28:04 INFO - PROCESS | 1644 | __end_tp_report 20:28:04 INFO - PROCESS | 1644 | __start_cc_report 20:28:04 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2076 20:28:04 INFO - PROCESS | 1644 | __end_cc_report 20:28:04 INFO - PROCESS | 1644 | __startTimestamp1493177284728__endTimestamp 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | ------- Summary: start ------- 20:28:04 INFO - PROCESS | 1644 | Number of tests: 14 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#0] ai-astar Cycles:10 Average:121.10 Median:116.00 stddev:19.61 (16.9%) stddev-sans-first:19.80 20:28:04 INFO - PROCESS | 1644 | Values: 104.0 114.0 116.0 113.0 125.0 175.0 115.0 116.0 117.0 116.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:125.00 stddev:15.31 (12.2%) stddev-sans-first:14.12 20:28:04 INFO - PROCESS | 1644 | Values: 137.0 107.0 108.0 140.0 105.0 108.0 106.0 122.0 128.0 94.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:2.55 (1.4%) stddev-sans-first:2.09 20:28:04 INFO - PROCESS | 1644 | Values: 179.0 185.0 180.0 184.0 182.0 185.0 184.0 184.0 187.0 186.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#3] audio-fft Cycles:10 Average:65.70 Median:61.00 stddev:11.25 (18.4%) stddev-sans-first:10.26 20:28:04 INFO - PROCESS | 1644 | Values: 82.0 59.0 56.0 88.0 62.0 60.0 59.0 58.0 73.0 60.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.50 stddev:8.23 (10.8%) stddev-sans-first:7.57 20:28:04 INFO - PROCESS | 1644 | Values: 87.0 69.0 86.0 70.0 69.0 68.0 83.0 69.0 69.0 83.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:88.90 Median:89.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 20:28:04 INFO - PROCESS | 1644 | Values: 89.0 89.0 89.0 89.0 89.0 89.0 90.0 89.0 88.0 88.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:94.50 stddev:21.03 (22.2%) stddev-sans-first:21.73 20:28:04 INFO - PROCESS | 1644 | Values: 95.0 94.0 96.0 104.0 150.0 93.0 135.0 128.0 95.0 95.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.25 (1.5%) stddev-sans-first:1.17 20:28:04 INFO - PROCESS | 1644 | Values: 83.0 85.0 85.0 87.0 85.0 85.0 83.0 84.0 86.0 84.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:62.50 stddev:14.61 (23.4%) stddev-sans-first:15.12 20:28:04 INFO - PROCESS | 1644 | Values: 61.0 58.0 62.0 60.0 62.0 61.0 63.0 88.0 92.0 93.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:59.50 stddev:3.86 (6.5%) stddev-sans-first:3.81 20:28:04 INFO - PROCESS | 1644 | Values: 56.0 68.0 63.0 64.0 60.0 59.0 57.0 59.0 57.0 57.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:83.00 stddev:4.50 (5.4%) stddev-sans-first:4.66 20:28:04 INFO - PROCESS | 1644 | Values: 79.0 71.0 83.0 82.0 83.0 83.0 80.0 83.0 88.0 85.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:138.00 stddev:14.34 (10.4%) stddev-sans-first:15.11 20:28:04 INFO - PROCESS | 1644 | Values: 135.0 126.0 131.0 141.0 143.0 139.0 134.0 137.0 178.0 133.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 20:28:04 INFO - PROCESS | 1644 | Values: 162.0 162.0 163.0 163.0 160.0 164.0 161.0 161.0 162.0 161.0 20:28:04 INFO - PROCESS | 1644 | 20:28:04 INFO - PROCESS | 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.51 20:28:04 INFO - PROCESS | 1644 | Values: 64.0 63.0 64.0 62.0 62.0 65.0 63.0 60.0 61.0 62.0 20:28:04 INFO - PROCESS | 1644 | -------- Summary: end -------- 20:28:04 INFO - PROCESS | 1644 | 20:28:05 INFO - TEST-INFO | 1644: exit 0 20:28:05 INFO - TEST-OK | kraken | took 58876ms 20:28:05 INFO - SUITE-END | took 1178s 20:28:05 INFO - Completed test suite (00:19:38) 20:28:05 INFO - javascript benchmark 20:28:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7917.876345152995, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3546.8935931922033, 3558.377283975305, 3575.8212089395533, 3604.098975256186, 3627.220147668251, 6219.906701399483, 6223.066540018999, 6229.221347331583, 6232.5013998880095, 6255.468285195764, 6200.782972595949, 6273.498120150389, 6284.340144284842, 6289.119523266746, 6292.968535157318, 5491.533219676322, 5522.0336441122845, 5548.500634942854, 5556.944430555704, 5666.54667626591, 5425.26758887551, 5425.647332923367, 5436.91844622331, 5612.5229355504625, 5648.43515648436, 5523.585731070166, 5528.44715528446, 5531.2532808071, 5531.363893152278, 5540.695261760601, 5521.337439507285, 5522.530584900288, 5528.06022976095, 5535.944640553583, 5540.252065971083, 5397.437238233244, 5432.456754324576, 5477.534409575191, 5478.45215478453, 5478.58910581708, 6199.256089269272, 6216.316205217422, 6224.221972253468, 6233.3143354231, 6252.906206406908, 6444.355564443565, 6452.806415807533, 6463.644499552523, 6467.773627923, 6472.449841763456, 6549.279579246279, 6549.93450065498, 6554.279029306773, 6560.0815885775555, 6583.572067815625, 6117.562731150785, 6131.346082861964, 6185.752569897244, 6297.968510157466, 6347.0, 6643.534952553371, 6714.362135597111, 6794.864102717918, 6796.490263230277, 6797.2523022467485, 6385.904211436832, 6414.518911081687, 6417.294097649255, 6420.711068001951, 6427.903581446282, 6601.768938087144, 6603.240627327823, 6604.108445359815, 6608.7356505739235, 6610.0745895574655, 6241.78153764616, 6271.27880293763, 6302.590331628521, 6308.337624549448, 6393.488520918316, 6406.359364063556, 6408.967955160288, 6412.775552855627, 6423.775167869102, 6426.742930282736, 5135.204043373283, 5222.608304377187, 5253.842384728464, 5259.710715910585, 5268.473152684701, 4603.355530225771, 4610.654200934876, 4648.558386953302, 4660.0, 4695.741734204583, 6258.968705156445, 6276.592021518587, 6281.937180628135, 6284.151639528696, 6303.527235457359, 6555.147830781968, 6564.4420224281475, 6573.835654108686, 6574.8356291093105, 6578.5395022347975, 6031.035034394564, 6065.059915713072, 6204.410580994799, 6268.592541484789, 6276.435120839146, 5692.459216374438, 5696.971515142398, 5779.017567013618, 5787.305523337142, 5856.912146317809, 6793.116894803644, 6795.52431329812, 6799.660016999229, 6802.897956530755, 6810.863782724317, 6435.646039467874, 6548.1814773153355, 6561.967190164019, 6563.573367731082, 6581.210254769267, 5638.295213098363, 6453.645049522322, 6484.383983521558, 6635.336466353326, 6765.2896445872475, 5776.335721392094, 6423.389777971085, 6434.67826608677, 6435.034744788132, 6447.290798012309, 5950.239585346375, 6009.128676341993, 6448.419642232034, 6500.837479062872, 6514.315996820455, 5496.80761173357, 6279.026750853625, 6291.307956124914, 6317.052442133717, 6348.9047664286, 6250.781222657185, 6281.026440901667, 6346.333634968262, 6363.490920726424, 6377.808665740035, 6168.814935551941, 6308.179936608211, 6316.526260530387, 6323.0, 6328.588641738273, 6260.40526150015, 6279.277883043508, 6314.557980941474, 6324.083007963912, 6335.049742538656, 6280.811575652738, 6306.148669929501, 6319.52603554726, 6321.051842223703, 6345.0482427636225], "value": 6018.574202261636, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.5959621198871, 828.134599343686, 901.571753417127, 911.5396724654053, 915.4049867586064, 41771.0, 42130.36804447936, 42448.787756061254, 42592.36111458327, 42605.14789704204, 43025.709228723186, 43247.78376108123, 43294.13411731763, 43350.349744753854, 43383.132337353316, 7970.840583188333, 8113.594320283992, 9700.902990970106, 9837.409755414697, 9851.95074024629, 11759.0, 11853.288802671867, 12194.451249693786, 12214.877851221463, 12217.38913054348, 11991.880081199208, 12057.758844823098, 12062.819057714141, 12081.093917956188, 12084.637460876187, 11952.342621155833, 11986.400679965967, 11995.94002029993, 12010.879891201152, 12037.0, 11631.243969141979, 11685.182037257395, 11688.94799468052, 11689.298642081503, 11730.237534560227, 40365.0, 40480.59519404798, 40483.59516404857, 40532.18935621271, 40637.0, 3952.458959255525, 4070.2266569352023, 4086.1010577672864, 4092.877213683594, 4099.159672267178, 29216.123516294545, 29668.258293542833, 30402.54396184059, 31235.531467028013, 31335.9032433866, 3287.145342211042, 3297.225152089257, 3312.801231926092, 3443.328550932569, 3443.483477478373, 332801.0, 338399.0, 338474.30762846273, 339127.99999999756, 339571.0, 45182.32226516605, 46165.0, 48325.0, 52965.0, 53164.73417632887, 47830.28254576184, 47843.0, 47919.760401198466, 56290.0, 57146.0, 15503.84496155024, 15888.364465421484, 15899.761503577456, 15912.52262432129, 15972.600684982968, 13505.729885402237, 13617.523386681418, 13619.387127579283, 13624.455021799215, 13638.522651707142, 12969.120904716388, 12981.0, 13025.153365031432, 13028.47886084565, 13196.340182990813, 5828.154917536934, 5831.883362332815, 5864.211415518308, 5892.705364731746, 5896.852578685567, 973.2651847854825, 984.5815528400401, 989.6734077754323, 996.5216695985822, 1008.1128606826093, 29882.40235195284, 30165.396692066035, 30458.390832183675, 30728.924487642824, 30806.0, 925.8055808280336, 1019.4851599942131, 1055.8310670292717, 1075.5590208014676, 1083.7778255457613, 12711.745765084646, 15746.133962631937, 15768.76346854798, 15823.73910351781, 15966.920165399099, 372315.1384243116, 442231.0, 442573.0, 442756.0, 443464.0, 58946.0, 59019.70490147608, 59274.40725592775, 59449.0, 59458.10812837811, 1465.5383554180612, 1508.1705062215956, 1516.3403919295142, 1519.688463864905, 1520.8403117672706, 28534.286642833264, 29204.853975729984, 29321.0, 29902.850485747433, 29943.700562994964, 40803.7959810199, 47142.52857471381, 50002.74998625129, 50129.248061278384, 50294.49705503044, 411644.0, 412565.0, 413012.0, 413596.7960480535, 414402.9279853702, 30064.549031764105, 30169.849150754108, 30542.930997414984, 30826.0, 36215.0, 37030.44454333241, 37706.8114659425, 45793.77103114463, 47713.0, 47960.520394797, 29427.411451771273, 32080.73099110133, 32186.35627287394, 32760.83619581887, 33074.83462582672, 26572.335691607863, 31414.685853141174, 32509.512357314186, 32894.835525822215, 34857.65142348645, 41771.582284176766, 43164.352534712634, 43341.34987975246, 44334.0, 44538.3319250205, 41203.7939810311, 41690.374644380965, 41886.581134188265, 42441.0, 42950.0, 28346.0, 32304.515432268065, 34047.4892876612, 34590.308193836485, 34742.0], "value": 19923.36295906284, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.1372979445221, 427.8167823928767, 431.0839466134464, 434.2314104035856, 441.5650584174588, 15848.28682709278, 21406.357809265708, 23128.88435557824, 23544.0, 23826.166084187058, 16490.505284841474, 20336.084876180572, 20372.490687732814, 22649.660255096187, 23891.805409729488, 6552.180977377828, 6957.130358705162, 7044.682989265495, 7231.89152162718, 7279.162896266917, 6317.905231421532, 7199.460040496958, 7207.855842883139, 7258.528195667292, 7305.0, 6933.445324374038, 7179.425645948311, 7244.782656520313, 7248.746293879715, 7255.238199989004, 5812.941870581282, 7087.929120708778, 7104.609246491441, 7162.570245785243, 7190.784276471714, 6798.626075565842, 6888.965555172243, 6969.0, 6992.230854605989, 6992.2658120897595, 28512.429751405063, 28619.14142575726, 28639.28401789951, 28644.856775716198, 28662.570061449096, 3060.9540856887165, 3603.3153700796765, 3618.4210526315665, 3668.046307959923, 3735.3089678409583, 10950.671479855617, 11584.47869845859, 17648.55878603045, 18192.72710909324, 18375.540611484685, 2074.3362124120285, 2088.185607613032, 2090.3937858021154, 2099.041374857212, 2169.9783002169934, 121996.0, 155047.22476387545, 156605.0, 157389.0, 170509.0, 18276.73376179802, 18954.715679264824, 25081.372965676004, 25167.87416062908, 25760.613590796154, 43615.781921090194, 44117.77941110274, 44683.0, 44744.77627611906, 44885.32672009923, 11742.765144697058, 11847.822282665767, 11982.820257696141, 11996.40017999114, 12236.510539578496, 8065.7901314802075, 9716.659916903016, 9728.902710972941, 9730.12428881404, 9901.05939935705, 8710.825783484295, 11465.426728663533, 11560.537578496765, 11800.996915262298, 11929.150981597693, 3787.62123787619, 3909.243982992041, 4636.165490211727, 4641.164590373698, 4678.76606169697, 1064.1965316186383, 1074.435921141407, 1077.8059949209219, 1089.7657003744232, 1118.8433619293305, 20046.699299510517, 22627.321180364615, 22735.317940461813, 22753.772462275167, 22760.88619556925, 1072.8176210044312, 1086.7500474890662, 1093.6384201668973, 1118.59730497021, 1133.5239199536215, 11193.552257909592, 11462.54149834014, 11774.175807693378, 11792.0, 11796.52813887435, 680983.0, 753257.0, 756937.0, 766567.0, 777922.0, 140955.0, 153529.0, 154910.0, 157780.87126598574, 158532.20733896256, 1207.4264724255909, 1214.3381856888018, 1268.3151098406756, 1273.0833799664226, 1274.1972557288848, 18290.908545457187, 18804.717929231345, 19017.809821902156, 19023.809761902758, 19314.71027934554, 61051.77896442135, 63700.40748981312, 68124.0, 68314.0, 69703.0, 79192.60403697945, 90587.54706226426, 91746.0, 93514.12971740663, 94139.52930235305, 7585.502553244489, 11576.594819181626, 11795.52817887275, 12056.457459414523, 12229.266244025386, 13429.992750543553, 13824.447022119002, 13830.170189788645, 14083.0, 14149.08030977983, 8417.5791210438, 11625.5349786011, 11641.6507504775, 11782.941085294518, 11985.820212696643, 10403.895961040293, 10778.730531736455, 11021.0, 11116.888831111586, 11396.715082123013, 10962.0, 11847.052235820942, 12095.939520302341, 12100.309405631368, 12122.969547588202, 10961.945190273998, 11890.821637675615, 12212.206206596542, 12218.450169742206, 12330.0, 10581.100606448537, 11753.823692644788, 11937.045036396894, 12052.337121458404, 12102.515899363927], "value": 12210.089956634018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1611.814641316249, 1626.1869065467267, 1645.7778199943007, 1649.8102718187413, 1650.4800987688877, 11089.33463992161, 11704.707382315446, 11708.941455292734, 11719.648410547687, 11730.706732331695, 9641.662541811038, 10967.122630189586, 11321.830172547398, 11498.597549085784, 11537.538498460073, 2460.2865169100983, 2508.636247744076, 2512.773850353468, 2521.35705395124, 2521.684789401325, 2436.7319594844553, 2454.7790698837102, 2496.662950501677, 2497.6628155198996, 2503.1364179358093, 2420.9636855447184, 2441.2554170977846, 2463.408781892351, 2467.0625162438337, 2472.443700167457, 2356.3873392917794, 2368.786809187164, 2421.0799896039393, 2445.730969593343, 2454.128784281581, 2111.1977448569446, 2450.1179575352858, 2469.2839076667747, 2472.925812225636, 2477.7522247775078, 10715.249932504728, 10753.569857205703, 10788.406637634927, 10795.83806242907, 10797.29817561856, 5886.6173698709445, 6089.847753806146, 6097.542684298695, 6097.695115244264, 6105.755769769248, 3540.6990405815536, 3548.308079924416, 3629.0, 3692.51997240357, 3749.43758436234, 1213.7875871722501, 1221.4442428694922, 1256.2525297448094, 1278.0670110819153, 1278.9680257993532, 14316.069455485464, 14630.26848657563, 14968.0, 16436.1781910904, 16673.24970376324, 4662.440507139165, 4827.831025914076, 4839.056384005085, 4871.780769865293, 4893.290472881412, 10615.097716694014, 12164.14850960442, 12198.0, 12198.085143614264, 12228.755424891453, 5129.820456284012, 5185.922211166836, 5188.299579556787, 5189.532942035159, 5202.661826981234, 5289.57683385336, 5342.492463215988, 5511.145772405283, 5520.91718624221, 5552.333719953632, 3208.7272581830807, 3404.2000129969438, 3976.522817261889, 4015.0326340093143, 4052.594740525924, 1034.7568321444455, 1037.6835065305154, 1039.443897514826, 1046.2048842879467, 1052.578968412641, 797.2846535146307, 824.9958750206331, 845.2350622686479, 875.8554838451712, 876.4697358098259, 5814.0, 5981.803639272163, 6310.368963103653, 6467.159269294962, 6980.825479363057, 1014.8680671512803, 1024.4530758554636, 1027.5786927359748, 1048.365738728074, 1050.3907733514543, 4150.730202536825, 4213.747175169499, 4234.809433575497, 4265.061686429042, 4357.0632314052, 14132.01075924696, 14793.0, 14812.481563145453, 14835.480758173628, 14842.925785371004, 14331.641708957359, 14559.344829482487, 14668.633284167981, 14759.852401475848, 14781.26093695311, 10086.848697269546, 10223.0, 10234.181265498892, 10243.975602439696, 10245.74385640365, 6368.617882927039, 6369.554131210956, 6423.96788016057, 6547.083408322934, 6556.442702370352, 10056.49717514136, 11005.119590432587, 11467.197296189186, 12122.575709850113, 12126.818097728717, 11546.76906461883, 11777.234479758788, 13224.669383265495, 13239.3380330985, 13264.602061938158, 6972.721091156297, 9179.724608261762, 9345.479249624517, 9398.95300523493, 9462.290328225274, 10302.175825933757, 10327.48362581853, 10412.739681508023, 10439.478026098514, 10483.475826208507, 9036.638534458549, 9042.819143617222, 9058.728238152866, 9169.679061232824, 9187.816243675223, 8604.268637165911, 8663.48019118855, 8673.826523469621, 8704.738857834274, 8710.346723995599, 8053.718119865776, 8135.633896474555, 8161.79595510117, 8171.509709417454, 8202.466839655403, 5944.613600115978, 5990.6705131218205, 5993.31076926159, 6006.819795406145, 6059.424354686298, 5929.377415371497, 5979.790707325223, 6025.186599809145, 6125.264968203844, 6132.38676132401], "value": 5183.942284717493, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8937252882928, 385.2603002235707, 387.45562484708995, 389.33812518718184, 393.95666476687575, 4173.520045194796, 4312.611864932155, 4418.7406589122065, 4945.826896058638, 5125.564327032207, 4252.893677658052, 4272.935905961405, 4450.5104438511735, 4634.791434385453, 4822.710637361761, 3310.3875782980103, 3553.662402071799, 4060.451839001741, 4175.853845115414, 4303.526612072669, 3980.263651224518, 3983.629740304514, 4129.6076872697195, 4296.334068219431, 4313.913721725564, 3804.5054142961376, 4306.956930430687, 4307.763073030982, 4313.223619748444, 4324.37296591994, 3948.7038472114705, 4142.71001029928, 4167.812448439828, 4248.9787551062045, 4251.300424230605, 3951.3480275754464, 3951.4270430787374, 3952.822123004472, 3966.8661757211767, 3978.9455794214555, 4549.795259213343, 4719.787609557544, 4798.256270278112, 5027.421846487664, 5249.4488078751565, 4555.316702494619, 4610.838620648295, 4691.460482044575, 4691.507391723888, 4861.180515301116, 5006.699598024094, 5010.69935803853, 5234.037236036486, 5481.943361912156, 5483.0, 3902.7853468059247, 4457.952381190417, 4530.524294949016, 4603.7698115094445, 4618.376519169903, 4959.991203562527, 5108.752149054404, 5227.6079294052715, 5480.479354461319, 5868.151532267322, 3939.7045221608496, 4149.9832541027645, 4455.086707225011, 4460.643148548108, 4492.3935268738305, 4212.915741685149, 4276.444062271885, 4356.934645980313, 4519.525449827786, 4563.885902852455, 4261.998430368861, 4505.459344878635, 4722.5513576210205, 4858.02839432115, 4968.571685536968, 5115.693058416507, 5395.838124856261, 5408.323959505062, 5425.68657916957, 5439.374471935699, 1344.475654494748, 1393.533166389271, 1414.886809055273, 1540.0297812378353, 1541.6685412636336, 1055.2560444886337, 1099.5931505343074, 1171.3908767440882, 1171.976560468803, 1174.6843535240414, 4615.284630882219, 4747.999999999931, 4779.674394672757, 5092.516210959953, 5102.4897510248675, 5190.598538394613, 5315.388730296066, 5386.559574829372, 5458.243586988625, 5623.947259250344, 4357.847475338412, 4435.179491794029, 4487.214737420938, 4697.577218050392, 4871.5128487151715, 2342.3909783456425, 2735.64883018301, 2783.401568662747, 2962.215013021551, 2977.211039074647, 5334.253204551366, 5624.409437009055, 5871.442212989759, 5883.441073098049, 5892.469677729025, 5408.4050754416985, 5421.3464893207165, 5523.8066667666435, 5691.8861622768145, 5771.883183081173, 4784.784684689267, 5091.516305950929, 5716.742746576414, 5758.0, 5758.7618661987035, 5160.477659090502, 5163.690178589297, 5368.409474957673, 5684.8010319638615, 5692.43075692444, 5289.550388217045, 5352.464753524617, 5478.301726464809, 5591.692456914746, 5652.773889044557, 5071.71772702278, 5411.891762164656, 5470.4988807164245, 5857.50211232033, 5877.4122587740885, 3953.8418463261146, 4064.6138616831354, 4449.3770872078585, 4511.842085526991, 4544.863654090383, 4860.465348811698, 4958.8760280993265, 5405.324334458192, 5463.4536546346635, 5606.439356064361, 4539.84110556129, 5261.763220655003, 5417.079096553516, 5433.375161856437, 5448.809291674773, 4492.303692927601, 4823.662343635911, 4950.084234416644, 5256.553192978639, 5508.063629182969, 4832.589229915497, 5224.238548245257, 5310.495502927216, 5340.75966581497, 5355.357357117015, 4642.721436713808, 4798.712077275374, 5185.974070129625, 5275.522853600998, 5482.958237934779, 4283.329501494357, 4618.907621847611, 4960.330355401975, 5391.649542779707, 5415.837524874102], "value": 4122.653179616436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.7063580521498, 768.9577073260969, 805.5730462854685, 868.2619773192785, 876.4128034217074, 15751.133687647189, 16769.24538395772, 17310.913445432787, 17389.39137130201, 18032.729509057375, 15770.0, 15881.602959926007, 16313.755293670605, 16414.83585164148, 16566.83433165668, 990.8464188050827, 995.0, 995.0596686131609, 996.696007717644, 996.8305388084007, 990.2573070197352, 1006.2603986070233, 1031.8297480915678, 1033.2302434686133, 1034.9948250258776, 1066.7333166708322, 1068.2468859454104, 1069.2996087562658, 1071.7481391872905, 1073.2058276875096, 1061.6178175856685, 1062.9309094908806, 1063.2079101069753, 1063.8351055586397, 1063.8616979792616, 783.7413653494333, 783.91768864269, 784.8391079828679, 786.1705900275207, 786.685325869651, 16928.0, 16928.23822927959, 16999.660006799917, 17743.645127097516, 18019.27922883083, 14654.0, 14656.633584160374, 14721.705565888622, 14738.55784326472, 14858.702825943421, 12024.204177816793, 12206.328651924141, 12226.388680566026, 12250.387480625934, 12566.81149782754, 3765.303418867491, 3880.6507414332564, 3895.824687889052, 3916.7649941003347, 4040.4949381327333, 118511.0, 118677.40661296724, 122137.0, 122143.0, 122463.38768306191, 11508.136889733303, 11568.074554035657, 11588.768224635629, 11628.1860269782, 12178.512859485698, 24304.7569524306, 24426.755732442805, 24533.754662453146, 24726.0, 24726.629100563507, 7729.0, 7799.220077992269, 7900.960495197487, 8080.83838323242, 8311.875321870177, 3898.317794385971, 4219.3249080147025, 4494.37078808967, 4623.676342655982, 4767.380240568704, 3264.1186879542865, 3289.605247370283, 3356.664333566624, 3371.5448414463735, 3388.0513456232293, 572.5019233267001, 588.664461257088, 590.8286596886941, 592.4756590417511, 594.5570549940322, 644.3105876711967, 652.6852700126259, 654.2182092399632, 656.3961155736733, 670.3899451499112, 10059.849102263472, 10669.19981001428, 10750.677479675465, 10882.61910833117, 11794.174407791545, 578.8205656246577, 580.3007376111775, 607.7052629474701, 650.2294780684904, 730.6273800361854, 5120.206368012964, 5222.060029194781, 5236.895262094813, 5244.737763111829, 5248.606354523426, 52884.0, 84243.15756842475, 101954.49022754839, 104531.43202851963, 106737.46631266794, 74945.62527187329, 85576.14423855806, 91456.54271728599, 92026.53986730023, 94630.0, 67856.0, 68161.65919170373, 69756.302436976, 71824.0, 79716.0, 9831.754206144904, 11127.499262533367, 11215.775684486427, 11234.887651123385, 11548.191626586395, 35481.0, 49974.750126249135, 50953.23570146377, 51682.22476662928, 53217.0, 57449.85100298054, 62411.37588624056, 63562.046569300575, 65239.347606523326, 65689.0, 10375.740606484898, 12914.09601327898, 13025.413856376295, 13513.527026554417, 13739.62603739658, 15596.307347818192, 16020.919895400448, 16035.919820400823, 16043.759343609621, 16051.839481605502, 13744.86255137436, 14050.227237502035, 14452.0, 14549.345279462237, 14562.0, 14313.427462901784, 14363.784543231652, 14574.417023318949, 14611.561653150422, 15280.0, 13340.799888001493, 14354.712905741619, 14370.209638469985, 14575.489857854924, 14650.19423931694, 10022.749431264278, 10216.080552750289, 10660.946695266784, 10802.227160370276, 10902.945485272523, 10106.343087699275, 10136.949315253376, 11434.199606027498, 11620.825687614524, 11683.18217724751], "value": 7874.001819167819, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1419.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 116.0, 113.0, 125.0, 175.0, 115.0, 116.0, 117.0, 116.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 107.0, 108.0, 140.0, 105.0, 108.0, 106.0, 122.0, 128.0, 94.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 185.0, 180.0, 184.0, 182.0, 185.0, 184.0, 184.0, 187.0, 186.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 56.0, 88.0, 62.0, 60.0, 59.0, 58.0, 73.0, 60.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 86.0, 70.0, 69.0, 68.0, 83.0, 69.0, 69.0, 83.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 89.0, 89.0, 90.0, 89.0, 88.0, 88.0], "value": 88.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 104.0, 150.0, 93.0, 135.0, 128.0, 95.0, 95.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 87.0, 85.0, 85.0, 83.0, 84.0, 86.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 62.0, 60.0, 62.0, 61.0, 63.0, 88.0, 92.0, 93.0], "value": 70.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 68.0, 63.0, 64.0, 60.0, 59.0, 57.0, 59.0, 57.0, 57.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 71.0, 83.0, 82.0, 83.0, 83.0, 80.0, 83.0, 88.0, 85.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 131.0, 141.0, 143.0, 139.0, 134.0, 137.0, 178.0, 133.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 160.0, 164.0, 161.0, 161.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 62.0, 62.0, 65.0, 63.0, 60.0, 61.0, 62.0], "value": 62.6, "unit": "score"}]}]} 20:28:05 INFO - Return code: 0 20:28:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:28:06 INFO - # TBPL SUCCESS # 20:28:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:28:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:28:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:28:06 INFO - 2017-04-25 20:28:06.037 screenresolution[1648:9691] starting screenresolution argv=screenresolution get 20:28:06 INFO - 2017-04-25 20:28:06.039 screenresolution[1648:9691] Display 0: 1600x1200x32@60 20:28:06 INFO - 2017-04-25 20:28:06.045 screenresolution[1649:9694] starting screenresolution argv=screenresolution list 20:28:06 INFO - Available Modes on Display 0 20:28:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:28:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:28:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:28:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:28:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:28:06 INFO - Intel Iris: 20:28:06 INFO - Chipset Model: Intel Iris 20:28:06 INFO - Type: GPU 20:28:06 INFO - Bus: Built-In 20:28:06 INFO - VRAM (Dynamic, Max): 1536 MB 20:28:06 INFO - Vendor: Intel (0x8086) 20:28:06 INFO - Device ID: 0x0a2e 20:28:06 INFO - Revision ID: 0x0009 20:28:06 INFO - Displays: 20:28:06 INFO - Display: 20:28:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:28:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:28:06 INFO - Display Serial Number: 1600x1200 60 20:28:06 INFO - Main Display: Yes 20:28:06 INFO - Mirror: Off 20:28:06 INFO - Online: Yes 20:28:06 INFO - Rotation: Supported 20:28:06 INFO - Return code: 0 20:28:06 INFO - Running post-action listener: _resource_record_post_action 20:28:06 INFO - [mozharness: 2017-04-26 03:28:06.281201Z] Finished run-tests step (success) 20:28:06 INFO - Running post-run listener: _resource_record_post_run 20:28:06 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 38932480; Write bytes: 419912704; Read time: 252; Write time: 1373 20:28:06 INFO - TinderboxPrint: CPU usage
54.0% 20:28:06 INFO - TinderboxPrint: I/O read bytes / time
38,932,480 / 252 20:28:06 INFO - TinderboxPrint: I/O write bytes / time
419,912,704 / 1,373 20:28:06 INFO - TinderboxPrint: CPU idle
2,199.4 (46.0%) 20:28:06 INFO - TinderboxPrint: CPU system
957.8 (20.0%) 20:28:06 INFO - TinderboxPrint: CPU user
1,620.5 (33.9%) 20:28:06 INFO - TinderboxPrint: Swap in / out
160,190,464 / 0 20:28:06 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 117672448; Write bytes: 112869376; Read time: 10567; Write time: 244 20:28:06 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36630528; Write bytes: 296061952; Read time: 227; Write time: 1090 20:28:06 INFO - Running post-run listener: _upload_blobber_files 20:28:06 INFO - Blob upload gear active. 20:28:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:28:06 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 20:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:28:07 INFO - (blobuploader) - INFO - Open directory for files ... 20:28:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:28:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:28:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:07 INFO - (blobuploader) - INFO - Done attempting. 20:28:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:28:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:08 INFO - (blobuploader) - INFO - Done attempting. 20:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:28:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:10 INFO - (blobuploader) - INFO - Done attempting. 20:28:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:28:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:28:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:12 INFO - (blobuploader) - INFO - Done attempting. 20:28:12 INFO - (blobuploader) - INFO - Iteration through files over. 20:28:12 INFO - Return code: 0 20:28:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:28:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:28:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3495575a0374adae540b856882bde4b0519eb0524c18288ca6ebc4f3994f06b37e73590babd92563980e072602e4964d692be35848cec1fe58200270afbb5f56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1577d840383bd803d3c6b821d0f520297e86a2be22b04b787e514dc76f4ab5429b7b81cb724236c9509770b1b732dee4c8938ada505130b41bb2e93628b92ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ef409d8b75f7685fef968d865d257f994cd0231bd4d1aaa3fd42db7c72983d9cb7b0149675c80c425a3fb0db37369e2d607a7bf22f116b383cb336f0e7da65", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec103c153154481c66b81a483baa361593f58db1dcfa3f82afd6eac36caec404ba744d65eac441ff886abafdff1ac6c61b74b6577f3320ff692a7bdd5d078fcd"} 20:28:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:28:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:28:12 INFO - Contents: 20:28:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3495575a0374adae540b856882bde4b0519eb0524c18288ca6ebc4f3994f06b37e73590babd92563980e072602e4964d692be35848cec1fe58200270afbb5f56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1577d840383bd803d3c6b821d0f520297e86a2be22b04b787e514dc76f4ab5429b7b81cb724236c9509770b1b732dee4c8938ada505130b41bb2e93628b92ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ef409d8b75f7685fef968d865d257f994cd0231bd4d1aaa3fd42db7c72983d9cb7b0149675c80c425a3fb0db37369e2d607a7bf22f116b383cb336f0e7da65", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec103c153154481c66b81a483baa361593f58db1dcfa3f82afd6eac36caec404ba744d65eac441ff886abafdff1ac6c61b74b6577f3320ff692a7bdd5d078fcd"} 20:28:12 INFO - Running post-run listener: copy_logs_to_upload_dir 20:28:12 INFO - Copying logs to upload dir... 20:28:12 INFO - mkdir: /builds/slave/test/build/upload/logs 20:28:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.086681 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-25 20:28:12.441283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2017-04-25 20:28:12.445764) ========= 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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3495575a0374adae540b856882bde4b0519eb0524c18288ca6ebc4f3994f06b37e73590babd92563980e072602e4964d692be35848cec1fe58200270afbb5f56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1577d840383bd803d3c6b821d0f520297e86a2be22b04b787e514dc76f4ab5429b7b81cb724236c9509770b1b732dee4c8938ada505130b41bb2e93628b92ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ef409d8b75f7685fef968d865d257f994cd0231bd4d1aaa3fd42db7c72983d9cb7b0149675c80c425a3fb0db37369e2d607a7bf22f116b383cb336f0e7da65", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec103c153154481c66b81a483baa361593f58db1dcfa3f82afd6eac36caec404ba744d65eac441ff886abafdff1ac6c61b74b6577f3320ff692a7bdd5d078fcd"} build_url:https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/Ot6uV0YfRfWOBd-4S9hPhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3495575a0374adae540b856882bde4b0519eb0524c18288ca6ebc4f3994f06b37e73590babd92563980e072602e4964d692be35848cec1fe58200270afbb5f56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1577d840383bd803d3c6b821d0f520297e86a2be22b04b787e514dc76f4ab5429b7b81cb724236c9509770b1b732dee4c8938ada505130b41bb2e93628b92ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ef409d8b75f7685fef968d865d257f994cd0231bd4d1aaa3fd42db7c72983d9cb7b0149675c80c425a3fb0db37369e2d607a7bf22f116b383cb336f0e7da65", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec103c153154481c66b81a483baa361593f58db1dcfa3f82afd6eac36caec404ba744d65eac441ff886abafdff1ac6c61b74b6577f3320ff692a7bdd5d078fcd"}' ========= master_lag: 4.41 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2017-04-25 20:28:16.870094) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 20:28:16.870480) ========= 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.kxKwEZYEi7/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.S8tFbcmpFE/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005140 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 20:28:16.900018) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 20:28:16.900359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 20:28:16.900694) ========= ========= Total master_lag: 4.69 =========