builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0285 starttime: 1491949993.14 results: success (0) buildid: 20170411135808 builduid: 845bc46cad9b47cca6c350f044471e7a revision: 50e40d6c3f09c736a076c3d9e864e67a175ec633 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:13.137759) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:13.138182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:13.138466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:13.167637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:13.168004) ========= 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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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-11 15:33:13-- 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% 145M=0s 2017-04-11 15:33:13 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154085 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:13.346831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:13.347141) ========= 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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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.022001 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:13.395858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 15:33:13.396249) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 50e40d6c3f09c736a076c3d9e864e67a175ec633 --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 50e40d6c3f09c736a076c3d9e864e67a175ec633 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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-11 15:33:13,488 truncating revision to first 12 chars 2017-04-11 15:33:13,488 Setting DEBUG logging. 2017-04-11 15:33:13,488 attempt 1/10 2017-04-11 15:33:13,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/50e40d6c3f09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 15:33:14,604 unpacking tar archive at: mozilla-beta-50e40d6c3f09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.405885 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 15:33:14.825959) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:14.826277) ========= script_repo_revision: 50e40d6c3f09c736a076c3d9e864e67a175ec633 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:14.826668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:14.826928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 15:33:14.846477) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-04-11 15:33:14.846870) ========= /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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:33:15 INFO - MultiFileLogger online at 20170411 15:33:15 in /builds/slave/test 15:33:15 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 15:33:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:15 INFO - {'append_to_log': False, 15:33:15 INFO - 'base_work_dir': '/builds/slave/test', 15:33:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:33:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:15 INFO - 'branch': 'Mozilla-Beta', 15:33:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:15 INFO - 'config_files': ('talos/mac_config.py',), 15:33:15 INFO - 'default_actions': ('clobber', 15:33:15 INFO - 'read-buildbot-config', 15:33:15 INFO - 'download-and-extract', 15:33:15 INFO - 'populate-webroot', 15:33:15 INFO - 'create-virtualenv', 15:33:15 INFO - 'install', 15:33:15 INFO - 'run-tests'), 15:33:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:15 INFO - 'download_minidump_stackwalk': True, 15:33:15 INFO - 'download_symbols': 'ondemand', 15:33:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:15 INFO - 'installer_path': 'installer.exe', 15:33:15 INFO - 'log_level': 'info', 15:33:15 INFO - 'log_name': 'talos', 15:33:15 INFO - 'log_to_console': True, 15:33:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:33:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:33:15 INFO - 'opt_config_files': (), 15:33:15 INFO - 'pip_index': False, 15:33:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:15 INFO - 'cmd': ('bash', 15:33:15 INFO - '-c', 15:33:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:15 INFO - 'enabled': True, 15:33:15 INFO - 'halt_on_failure': False, 15:33:15 INFO - 'name': 'check_screen_resolution'},), 15:33:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:15 INFO - 'cmd': ('bash', 15:33:15 INFO - '-c', 15:33:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:15 INFO - 'enabled': True, 15:33:15 INFO - 'halt_on_failure': False, 15:33:15 INFO - 'name': 'check_screen_resolution'},), 15:33:15 INFO - 'run_cmd_checks_enabled': True, 15:33:15 INFO - 'sps_profile': False, 15:33:15 INFO - 'sps_profile_interval': 0, 15:33:15 INFO - 'suite': 'dromaeojs', 15:33:15 INFO - 'system_bits': '32', 15:33:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:15 INFO - 'title': 't-yosemite-r7-0285', 15:33:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:15 INFO - 'use_talos_json': True, 15:33:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:15 INFO - 'work_dir': 'build'} 15:33:15 INFO - [mozharness: 2017-04-11 22:33:15.055233Z] Running clobber step. 15:33:15 INFO - Running pre-action listener: _resource_record_pre_action 15:33:15 INFO - Running main action method: clobber 15:33:15 INFO - rmtree: /builds/slave/test/build 15:33:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:33:15 INFO - Running post-action listener: _resource_record_post_action 15:33:15 INFO - [mozharness: 2017-04-11 22:33:15.219148Z] Finished clobber step (success) 15:33:15 INFO - [mozharness: 2017-04-11 22:33:15.219279Z] Running read-buildbot-config step. 15:33:15 INFO - Running pre-action listener: _resource_record_pre_action 15:33:15 INFO - Running main action method: read_buildbot_config 15:33:15 INFO - Using buildbot properties: 15:33:15 INFO - { 15:33:15 INFO - "project": "", 15:33:15 INFO - "product": "firefox", 15:33:15 INFO - "script_repo_revision": "production", 15:33:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:33:15 INFO - "repository": "", 15:33:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:33:15 INFO - "buildid": "20170411135808", 15:33:15 INFO - "pgo_build": "False", 15:33:15 INFO - "basedir": "/builds/slave/test", 15:33:15 INFO - "buildnumber": 0, 15:33:15 INFO - "slavename": "t-yosemite-r7-0285", 15:33:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:33:15 INFO - "platform": "yosemite_r7", 15:33:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:33:15 INFO - "branch": "mozilla-beta", 15:33:15 INFO - "repo_path": "releases/mozilla-beta", 15:33:15 INFO - "revision": "50e40d6c3f09c736a076c3d9e864e67a175ec633", 15:33:15 INFO - "stage_platform": "macosx64", 15:33:15 INFO - "builduid": "845bc46cad9b47cca6c350f044471e7a", 15:33:15 INFO - "slavebuilddir": "test" 15:33:15 INFO - } 15:33:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:33:15 INFO - Running post-action listener: _resource_record_post_action 15:33:15 INFO - [mozharness: 2017-04-11 22:33:15.222629Z] Finished read-buildbot-config step (success) 15:33:15 INFO - [mozharness: 2017-04-11 22:33:15.222772Z] Running download-and-extract step. 15:33:15 INFO - Running pre-action listener: _resource_record_pre_action 15:33:15 INFO - Running main action method: download_and_extract 15:33:15 INFO - mkdir: /builds/slave/test/build/tests 15:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:15 INFO - trying https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:33:15 INFO - Downloading https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 15:33:16 INFO - Downloaded 1165 bytes. 15:33:16 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:33:16 INFO - Using the following test package requirements: 15:33:16 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:33:16 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:33:16 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:33:16 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:33:16 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:33:16 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:33:16 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:33:16 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:33:16 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:33:16 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:33:16 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:33:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:33:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:33:16 INFO - Fetch https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:33:17 INFO - Expected file size: 16116600 15:33:17 INFO - Obtained file size: 16116600 15:33:23 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:33:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:33:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:33:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:33:24 INFO - Expected file size: 16116600 15:33:24 INFO - Obtained file size: 16116600 15:33:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:33:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:33:31 INFO - Fetch https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:33:32 INFO - Expected file size: 14403650 15:33:32 INFO - Obtained file size: 14403650 15:33:32 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')]} 15:33:32 INFO - trying https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:33:32 INFO - Downloading https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 15:33:34 INFO - Downloaded 58457927 bytes. 15:33:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:33:34 INFO - mkdir: /builds/slave/test/properties 15:33:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:33:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:33:34 INFO - Contents: 15:33:34 INFO - build_url:https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:33:34 INFO - Running post-action listener: _resource_record_post_action 15:33:34 INFO - Running post-action listener: set_extra_try_arguments 15:33:34 INFO - [mozharness: 2017-04-11 22:33:34.736419Z] Finished download-and-extract step (success) 15:33:34 INFO - [mozharness: 2017-04-11 22:33:34.736547Z] Running populate-webroot step. 15:33:34 INFO - Running pre-action listener: _resource_record_pre_action 15:33:34 INFO - Running main action method: populate_webroot 15:33:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:34 INFO - '--tppagecycles', 15:33:34 INFO - '7'], 15:33:34 INFO - 'tests': ['tsvgm']}}, 15:33:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:33:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:33:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:33:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:33:34 INFO - 'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:33:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:33:34 INFO - 'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['damp', 'tps']}, 15:33:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:33:34 INFO - 'tests': ['damp', 'tps']}, 15:33:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['dromaeo_dom']}, 15:33:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['basic_compositor_video']}, 15:33:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:33:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['a11yr', 15:33:34 INFO - 'ts_paint', 15:33:34 INFO - 'tpaint', 15:33:34 INFO - 'sessionrestore', 15:33:34 INFO - 'sessionrestore_no_auto_restore', 15:33:34 INFO - 'tabpaint']}, 15:33:34 INFO - 'other-e10s': {'tests': ['a11yr', 15:33:34 INFO - 'ts_paint', 15:33:34 INFO - 'tpaint', 15:33:34 INFO - 'sessionrestore', 15:33:34 INFO - 'sessionrestore_no_auto_restore', 15:33:34 INFO - 'tabpaint']}, 15:33:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:33:34 INFO - 'ts_paint', 15:33:34 INFO - 'tpaint', 15:33:34 INFO - 'sessionrestore', 15:33:34 INFO - 'sessionrestore_no_auto_restore', 15:33:34 INFO - 'tabpaint']}, 15:33:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:33:34 INFO - 'ts_paint', 15:33:34 INFO - 'tpaint', 15:33:34 INFO - 'sessionrestore', 15:33:34 INFO - 'sessionrestore_no_auto_restore', 15:33:34 INFO - 'tabpaint']}, 15:33:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['a11yr', 15:33:34 INFO - 'ts_paint', 15:33:34 INFO - 'tpaint', 15:33:34 INFO - 'sessionrestore', 15:33:34 INFO - 'sessionrestore_no_auto_restore', 15:33:34 INFO - 'tabpaint']}, 15:33:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['a11yr', 15:33:34 INFO - 'ts_paint', 15:33:34 INFO - 'tpaint', 15:33:34 INFO - 'sessionrestore', 15:33:34 INFO - 'sessionrestore_no_auto_restore', 15:33:34 INFO - 'tabpaint']}, 15:33:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['tsvgx', 15:33:34 INFO - 'tsvgr_opacity', 15:33:34 INFO - 'tart', 15:33:34 INFO - 'tscrollx', 15:33:34 INFO - 'cart', 15:33:34 INFO - 'tsvg_static']}, 15:33:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:33:34 INFO - 'tsvgr_opacity', 15:33:34 INFO - 'tart', 15:33:34 INFO - 'tscrollx', 15:33:34 INFO - 'cart', 15:33:34 INFO - 'tsvg_static']}, 15:33:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:33:34 INFO - 'talos_options': ['--disable-e10s'], 15:33:34 INFO - 'tests': ['tp5o']}, 15:33:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:33:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:33:34 INFO - 'talos_options': ['--disable-e10s', 15:33:34 INFO - '--xperf_path', 15:33:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:34 INFO - 'tests': ['tp5n']}, 15:33:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:33:34 INFO - 'talos_options': ['--xperf_path', 15:33:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:34 INFO - 'tests': ['tp5n']}}, 15:33:34 INFO - 'talos.zip': {'path': '', 15:33:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:34 INFO - Running post-action listener: _resource_record_post_action 15:33:34 INFO - [mozharness: 2017-04-11 22:33:34.756624Z] Finished populate-webroot step (success) 15:33:34 INFO - [mozharness: 2017-04-11 22:33:34.756757Z] Running create-virtualenv step. 15:33:34 INFO - Running pre-action listener: _resource_record_pre_action 15:33:34 INFO - Running main action method: create_virtualenv 15:33:34 INFO - Creating virtualenv /builds/slave/test/build/venv 15:33:34 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 15:33:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:33:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:34 INFO - Using real prefix '/tools/python27' 15:33:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:33:35 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:38 INFO - Installing pip.................done. 15:33:38 INFO - Return code: 0 15:33:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:33:38 INFO - Reading from file tmpfile_stdout 15:33:38 INFO - Output received: 15:33:38 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) 15:33:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:33:38 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')]} 15:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:38 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')]} 15:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:38 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 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:33:38 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 15:33:38 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 15:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:38 INFO - 'HOME': '/Users/cltbld', 15:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:38 INFO - 'LOGNAME': 'cltbld', 15:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:38 INFO - 'MOZ_NO_REMOTE': '1', 15:33:38 INFO - 'NO_EM_RESTART': '1', 15:33:38 INFO - 'PAGER': '/bin/cat', 15:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:38 INFO - 'PWD': '/builds/slave/test', 15:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:38 INFO - 'SHELL': '/bin/bash', 15:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:33:38 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:38 INFO - 'USER': 'cltbld', 15:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:38 INFO - 'XPC_FLAGS': '0x0', 15:33:38 INFO - 'XPC_SERVICE_NAME': '0', 15:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:38 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 15:33:38 INFO - Cleaning up... 15:33:38 INFO - Return code: 0 15:33:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:39 INFO - 'HOME': '/Users/cltbld', 15:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:39 INFO - 'LOGNAME': 'cltbld', 15:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:39 INFO - 'MOZ_NO_REMOTE': '1', 15:33:39 INFO - 'NO_EM_RESTART': '1', 15:33:39 INFO - 'PAGER': '/bin/cat', 15:33:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:39 INFO - 'PWD': '/builds/slave/test', 15:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:39 INFO - 'SHELL': '/bin/bash', 15:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:33:39 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:39 INFO - 'USER': 'cltbld', 15:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:39 INFO - 'XPC_FLAGS': '0x0', 15:33:39 INFO - 'XPC_SERVICE_NAME': '0', 15:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:39 INFO - Downloading/unpacking psutil>=3.1.1 15:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:42 INFO - Installing collected packages: psutil 15:33:42 INFO - Running setup.py install for psutil 15:33:42 INFO - building 'psutil._psutil_osx' extension 15:33:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:33:43 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 15:33:43 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 15:33:43 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 15:33:43 INFO - building 'psutil._psutil_posix' extension 15:33:43 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 15:33:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:33:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:33:43 INFO - ^ 15:33:43 INFO - 1 warning generated. 15:33:43 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 15:33:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:43 INFO - Successfully installed psutil 15:33:43 INFO - Cleaning up... 15:33:43 INFO - Return code: 0 15:33:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:43 INFO - 'HOME': '/Users/cltbld', 15:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:43 INFO - 'LOGNAME': 'cltbld', 15:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:43 INFO - 'MOZ_NO_REMOTE': '1', 15:33:43 INFO - 'NO_EM_RESTART': '1', 15:33:43 INFO - 'PAGER': '/bin/cat', 15:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:43 INFO - 'PWD': '/builds/slave/test', 15:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:43 INFO - 'SHELL': '/bin/bash', 15:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:33:43 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:43 INFO - 'USER': 'cltbld', 15:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:43 INFO - 'XPC_FLAGS': '0x0', 15:33:43 INFO - 'XPC_SERVICE_NAME': '0', 15:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:33:46 INFO - Installing collected packages: mozsystemmonitor 15:33:46 INFO - Running setup.py install for mozsystemmonitor 15:33:46 INFO - Successfully installed mozsystemmonitor 15:33:46 INFO - Cleaning up... 15:33:46 INFO - Return code: 0 15:33:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:33:46 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')]} 15:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:46 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')]} 15:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:46 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 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:33:46 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 15:33:46 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 15:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:46 INFO - 'HOME': '/Users/cltbld', 15:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:46 INFO - 'LOGNAME': 'cltbld', 15:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:46 INFO - 'MOZ_NO_REMOTE': '1', 15:33:46 INFO - 'NO_EM_RESTART': '1', 15:33:46 INFO - 'PAGER': '/bin/cat', 15:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:46 INFO - 'PWD': '/builds/slave/test', 15:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:46 INFO - 'SHELL': '/bin/bash', 15:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:33:46 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:46 INFO - 'USER': 'cltbld', 15:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:46 INFO - 'XPC_FLAGS': '0x0', 15:33:46 INFO - 'XPC_SERVICE_NAME': '0', 15:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:47 INFO - Downloading/unpacking jsonschema==2.5.1 15:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:50 INFO - warning: no files found matching '*.txt' 15:33:50 INFO - no previously-included directories found matching 'build' 15:33:50 INFO - no previously-included directories found matching 'dist' 15:33:50 INFO - no previously-included directories found matching '.git*' 15:33:50 INFO - Installing collected packages: jsonschema, functools32 15:33:50 INFO - Running setup.py install for functools32 15:33:50 INFO - warning: no files found matching '*.txt' 15:33:50 INFO - no previously-included directories found matching 'build' 15:33:50 INFO - no previously-included directories found matching 'dist' 15:33:50 INFO - no previously-included directories found matching '.git*' 15:33:50 INFO - Successfully installed jsonschema functools32 15:33:50 INFO - Cleaning up... 15:33:50 INFO - Return code: 0 15:33:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:50 INFO - 'HOME': '/Users/cltbld', 15:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:50 INFO - 'LOGNAME': 'cltbld', 15:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:50 INFO - 'MOZ_NO_REMOTE': '1', 15:33:50 INFO - 'NO_EM_RESTART': '1', 15:33:50 INFO - 'PAGER': '/bin/cat', 15:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:50 INFO - 'PWD': '/builds/slave/test', 15:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:50 INFO - 'SHELL': '/bin/bash', 15:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:33:50 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:50 INFO - 'USER': 'cltbld', 15:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:50 INFO - 'XPC_FLAGS': '0x0', 15:33:50 INFO - 'XPC_SERVICE_NAME': '0', 15:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:33:50 INFO - Cleaning up... 15:33:50 INFO - Return code: 0 15:33:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:50 INFO - 'HOME': '/Users/cltbld', 15:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:50 INFO - 'LOGNAME': 'cltbld', 15:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:50 INFO - 'MOZ_NO_REMOTE': '1', 15:33:50 INFO - 'NO_EM_RESTART': '1', 15:33:50 INFO - 'PAGER': '/bin/cat', 15:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:50 INFO - 'PWD': '/builds/slave/test', 15:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:50 INFO - 'SHELL': '/bin/bash', 15:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:33:50 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:50 INFO - 'USER': 'cltbld', 15:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:50 INFO - 'XPC_FLAGS': '0x0', 15:33:50 INFO - 'XPC_SERVICE_NAME': '0', 15:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:54 INFO - Downloading docopt-0.6.1.tar.gz 15:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:54 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:54 INFO - Running setup.py install for blobuploader 15:33:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:55 INFO - Running setup.py install for requests 15:33:55 INFO - Running setup.py install for docopt 15:33:55 INFO - Successfully installed blobuploader requests docopt 15:33:55 INFO - Cleaning up... 15:33:55 INFO - Return code: 0 15:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33: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')]} 15:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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')]} 15:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:55 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 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:33:55 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 15:33:55 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 15:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:55 INFO - 'HOME': '/Users/cltbld', 15:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:55 INFO - 'LOGNAME': 'cltbld', 15:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:55 INFO - 'MOZ_NO_REMOTE': '1', 15:33:55 INFO - 'NO_EM_RESTART': '1', 15:33:55 INFO - 'PAGER': '/bin/cat', 15:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:55 INFO - 'PWD': '/builds/slave/test', 15:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:55 INFO - 'SHELL': '/bin/bash', 15:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:33:55 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:55 INFO - 'USER': 'cltbld', 15:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:55 INFO - 'XPC_FLAGS': '0x0', 15:33:55 INFO - 'XPC_SERVICE_NAME': '0', 15:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-woLAGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-AyVYIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-MyLXYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-VMJC7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-RBBT_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-aMr2Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-b5I5iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-pjQQuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-GkX674-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:56 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-OKv9VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:57 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-niS4R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:57 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-xe6m4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:57 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-4SMPKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:57 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-ty1uAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:57 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-3eurfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:57 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-6gTLAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:57 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-gyqWMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:57 INFO - Running setup.py install for manifestparser 15:33:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:57 INFO - Running setup.py install for mozcrash 15:33:58 INFO - Running setup.py install for mozdebug 15:33:58 INFO - Running setup.py install for mozdevice 15:33:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:33:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:58 INFO - Running setup.py install for mozfile 15:33:58 INFO - Running setup.py install for mozhttpd 15:33:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:58 INFO - Running setup.py install for mozinfo 15:33:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:58 INFO - Running setup.py install for mozInstall 15:33:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for mozleak 15:33:59 INFO - Running setup.py install for mozlog 15:33:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for moznetwork 15:33:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for mozprocess 15:33:59 INFO - Running setup.py install for mozprofile 15:33:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for mozrunner 15:33:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for mozscreenshot 15:34:00 INFO - Running setup.py install for moztest 15:34:00 INFO - Running setup.py install for mozversion 15:34:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:00 INFO - Cleaning up... 15:34:00 INFO - Return code: 0 15:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:00 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 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:34:00 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 15:34:00 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 15:34:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:34:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:00 INFO - 'HOME': '/Users/cltbld', 15:34:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:00 INFO - 'LOGNAME': 'cltbld', 15:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:00 INFO - 'MOZ_NO_REMOTE': '1', 15:34:00 INFO - 'NO_EM_RESTART': '1', 15:34:00 INFO - 'PAGER': '/bin/cat', 15:34:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:00 INFO - 'PWD': '/builds/slave/test', 15:34:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:00 INFO - 'SHELL': '/bin/bash', 15:34:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:34:00 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:34:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:00 INFO - 'USER': 'cltbld', 15:34:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:00 INFO - 'XPC_FLAGS': '0x0', 15:34:00 INFO - 'XPC_SERVICE_NAME': '0', 15:34:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:00 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-VWDaP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:00 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)) 15:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:00 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-61NxKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:00 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)) 15:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:00 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-T47pbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:00 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-T6jKj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-G4wc9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-ISQKP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-1aiHkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-N0Yy3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-WWFXZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-WZce7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-iRywEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-qIRhwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:01 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-OuFOAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:02 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-CvLwBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:02 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-r8a8Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:02 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-5BZ5zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:02 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-TzGgY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:02 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)) 15:34:02 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)) 15:34:02 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)) 15:34:02 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)) 15:34:02 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)) 15:34:02 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)) 15:34:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:02 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 15:34:02 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 15:34:02 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 15:34:02 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 15:34:02 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 15:34:02 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 15:34:05 INFO - Downloading blessings-1.6.tar.gz 15:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:05 INFO - Installing collected packages: blessings 15:34:05 INFO - Running setup.py install for blessings 15:34:05 INFO - Successfully installed blessings 15:34:05 INFO - Cleaning up... 15:34:05 INFO - Return code: 0 15:34:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:05 INFO - Reading from file tmpfile_stdout 15:34:05 INFO - Current package versions: 15:34:05 INFO - blessings == 1.6 15:34:05 INFO - blobuploader == 1.2.4 15:34:05 INFO - docopt == 0.6.1 15:34:05 INFO - functools32 == 3.2.3-2 15:34:05 INFO - jsonschema == 2.5.1 15:34:05 INFO - manifestparser == 1.1 15:34:05 INFO - mozInstall == 1.12 15:34:05 INFO - mozcrash == 1.0 15:34:05 INFO - mozdebug == 0.1 15:34:05 INFO - mozdevice == 0.49 15:34:05 INFO - mozfile == 1.2 15:34:05 INFO - mozhttpd == 0.7 15:34:05 INFO - mozinfo == 0.9 15:34:05 INFO - mozleak == 0.1 15:34:05 INFO - mozlog == 3.4 15:34:05 INFO - moznetwork == 0.27 15:34:05 INFO - mozprocess == 0.24 15:34:05 INFO - mozprofile == 0.28 15:34:05 INFO - mozrunner == 6.13 15:34:05 INFO - mozscreenshot == 0.1 15:34:05 INFO - mozsystemmonitor == 0.3 15:34:05 INFO - moztest == 0.8 15:34:05 INFO - mozversion == 1.4 15:34:05 INFO - psutil == 3.1.1 15:34:05 INFO - requests == 1.2.3 15:34:05 INFO - wsgiref == 0.1.2 15:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:34:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:34:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:05 INFO - 'HOME': '/Users/cltbld', 15:34:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:05 INFO - 'LOGNAME': 'cltbld', 15:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:05 INFO - 'MOZ_NO_REMOTE': '1', 15:34:05 INFO - 'NO_EM_RESTART': '1', 15:34:05 INFO - 'PAGER': '/bin/cat', 15:34:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:05 INFO - 'PWD': '/builds/slave/test', 15:34:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:05 INFO - 'SHELL': '/bin/bash', 15:34:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:34:05 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:34:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:05 INFO - 'USER': 'cltbld', 15:34:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:05 INFO - 'XPC_FLAGS': '0x0', 15:34:05 INFO - 'XPC_SERVICE_NAME': '0', 15:34:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:34:05 INFO - Cleaning up... 15:34:05 INFO - Return code: 0 15:34:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:05 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 0x10bda7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdaa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc71b467650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, '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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 15:34:05 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 15:34:05 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 15:34:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:34:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:05 INFO - 'HOME': '/Users/cltbld', 15:34:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:05 INFO - 'LOGNAME': 'cltbld', 15:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:05 INFO - 'MOZ_NO_REMOTE': '1', 15:34:05 INFO - 'NO_EM_RESTART': '1', 15:34:05 INFO - 'PAGER': '/bin/cat', 15:34:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:05 INFO - 'PWD': '/builds/slave/test', 15:34:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:05 INFO - 'SHELL': '/bin/bash', 15:34:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:34:05 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:34:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:05 INFO - 'USER': 'cltbld', 15:34:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:05 INFO - 'XPC_FLAGS': '0x0', 15:34:05 INFO - 'XPC_SERVICE_NAME': '0', 15:34:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:06 INFO - Cleaning up... 15:34:06 INFO - Return code: 0 15:34:06 INFO - Running post-action listener: _resource_record_post_action 15:34:06 INFO - Running post-action listener: _start_resource_monitoring 15:34:06 INFO - Starting resource monitoring. 15:34:06 INFO - [mozharness: 2017-04-11 22:34:06.239589Z] Finished create-virtualenv step (success) 15:34:06 INFO - [mozharness: 2017-04-11 22:34:06.240622Z] Running install step. 15:34:06 INFO - Running pre-action listener: _resource_record_pre_action 15:34:06 INFO - Running main action method: install 15:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:06 INFO - Reading from file tmpfile_stdout 15:34:06 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:06 INFO - Reading from file tmpfile_stdout 15:34:06 INFO - Output received: 15:34:06 INFO - Usage: mozinstall [options] installer 15:34:06 INFO - Options: 15:34:06 INFO - -h, --help show this help message and exit 15:34:06 INFO - -d DEST, --destination=DEST 15:34:06 INFO - Directory to install application into. [default: 15:34:06 INFO - "/builds/slave/test"] 15:34:06 INFO - --app=APP Application being installed. [default: firefox] 15:34:06 INFO - mkdir: /builds/slave/test/build/application 15:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:34:21 INFO - Reading from file tmpfile_stdout 15:34:21 INFO - Output received: 15:34:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:34:21 INFO - Running post-action listener: _resource_record_post_action 15:34:21 INFO - [mozharness: 2017-04-11 22:34:21.019011Z] Finished install step (success) 15:34:21 INFO - [mozharness: 2017-04-11 22:34:21.019163Z] Running run-tests step. 15:34:21 INFO - Running pre-action listener: _resource_record_pre_action 15:34:21 INFO - Running main action method: run_tests 15:34:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:34:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:34:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:34:21 INFO - 2017-04-11 15:34:21.031 screenresolution[1879:8582] starting screenresolution argv=screenresolution get 15:34:21 INFO - 2017-04-11 15:34:21.034 screenresolution[1879:8582] Display 0: 1600x1200x32@60 15:34:21 INFO - 2017-04-11 15:34:21.039 screenresolution[1880:8584] starting screenresolution argv=screenresolution list 15:34:21 INFO - Available Modes on Display 0 15:34:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:34:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:34:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:34:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:34:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:34:21 INFO - Intel Iris: 15:34:21 INFO - Chipset Model: Intel Iris 15:34:21 INFO - Type: GPU 15:34:21 INFO - Bus: Built-In 15:34:21 INFO - VRAM (Dynamic, Max): 1536 MB 15:34:21 INFO - Vendor: Intel (0x8086) 15:34:21 INFO - Device ID: 0x0a2e 15:34:21 INFO - Revision ID: 0x0009 15:34:21 INFO - Displays: 15:34:21 INFO - Display: 15:34:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:34:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:34:21 INFO - Display Serial Number: 1600x1200 60 15:34:21 INFO - Main Display: Yes 15:34:21 INFO - Mirror: Off 15:34:21 INFO - Online: Yes 15:34:21 INFO - Rotation: Supported 15:34:21 INFO - Return code: 0 15:34:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:34:21 INFO - Python 2.7.3 15:34:21 INFO - Return code: 0 15:34:21 INFO - grabbing minidump binary from tooltool 15:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb85d30>, '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 0x10baacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb7abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:34:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:34:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:34:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:34:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:34:21 INFO - Return code: 0 15:34:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:34:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:34:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:34:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:34:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:34:21 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/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--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 15:34:21 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/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0285 --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 15:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fv25xtbgF1/Render', 15:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:21 INFO - 'HOME': '/Users/cltbld', 15:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:21 INFO - 'LOGNAME': 'cltbld', 15:34:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:34:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:21 INFO - 'MOZ_NO_REMOTE': '1', 15:34:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:34:21 INFO - 'NO_EM_RESTART': '1', 15:34:21 INFO - 'PAGER': '/bin/cat', 15:34:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:21 INFO - 'PWD': '/builds/slave/test', 15:34:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:21 INFO - 'SHELL': '/bin/bash', 15:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cu9nYtPHeI/Listeners', 15:34:21 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 15:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:21 INFO - 'USER': 'cltbld', 15:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:21 INFO - 'XPC_FLAGS': '0x0', 15:34:21 INFO - 'XPC_SERVICE_NAME': '0', 15:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:21 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/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--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 15:34:21 INFO - mozversion application_buildid: 20170411135808 15:34:21 INFO - mozversion application_changeset: 50e40d6c3f09c736a076c3d9e864e67a175ec633 15:34:21 INFO - mozversion application_display_name: Firefox 15:34:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:34:21 INFO - mozversion application_name: Firefox 15:34:21 INFO - mozversion application_remotingname: firefox 15:34:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:34:21 INFO - mozversion application_vendor: Mozilla 15:34:21 INFO - mozversion application_version: 53.0 15:34:21 INFO - mozversion platform_buildid: 20170411135808 15:34:21 INFO - mozversion platform_changeset: 50e40d6c3f09c736a076c3d9e864e67a175ec633 15:34:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:34:21 INFO - mozversion platform_version: 53.0 15:34:21 INFO - using testdate: 1491950061 15:34:21 INFO - actual date: 1491950061 15:34:21 INFO - starting webserver on 'localhost:49372' 15:34:21 INFO - SUITE-START | Running 2 tests 15:34:21 INFO - TEST-START | dromaeo_css 15:34:21 INFO - operating with platform_type : mac_ 15:34:21 INFO - Initialising browser for dromaeo_css test... 15:34:21 INFO - TEST-INFO | started process 1890 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpKWF_xL/profile http://localhost:49372/getInfo.html) 15:34:24 INFO - PROCESS | 1890 | __metrics Screen width/height:1600/1200 15:34:24 INFO - PROCESS | 1890 | colorDepth:24 15:34:24 INFO - PROCESS | 1890 | Browser inner width/height: 1024/689 15:34:24 INFO - PROCESS | 1890 | __metrics 15:34:24 INFO - PROCESS | 1890 | 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" 15:34:24 INFO - PROCESS | 1890 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:34:24 INFO - TEST-INFO | 1890: exit 0 15:34:24 INFO - Browser initialized. 15:34:24 INFO - Running cycle 1/1 for dromaeo_css test... 15:34:24 INFO - TEST-INFO | started process 1893 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpKWF_xL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:36 INFO - PROCESS | 1893 | RSS: Main: 167526400 15:34:36 INFO - PROCESS | 1893 | 15:37:39 INFO - PROCESS | 1893 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49372/tests/dromaeo/cssquery-ext.html) 15:37:41 INFO - PROCESS | 1893 | RSS: Main: 324091904 15:37:41 INFO - PROCESS | 1893 | 15:40:43 INFO - PROCESS | 1893 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-ext.html (next: http://localhost:49372/tests/dromaeo/cssquery-jquery.html) 15:40:44 INFO - PROCESS | 1893 | RSS: Main: 312107008 15:40:44 INFO - PROCESS | 1893 | 15:43:46 INFO - PROCESS | 1893 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49372/tests/dromaeo/cssquery-mootools.html) 15:43:47 INFO - PROCESS | 1893 | RSS: Main: 302612480 15:43:47 INFO - PROCESS | 1893 | 15:46:49 INFO - PROCESS | 1893 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49372/tests/dromaeo/cssquery-prototype.html) 15:46:50 INFO - PROCESS | 1893 | RSS: Main: 284770304 15:46:50 INFO - PROCESS | 1893 | 15:49:53 INFO - PROCESS | 1893 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49372/tests/dromaeo/cssquery-yui.html) 15:49:54 INFO - PROCESS | 1893 | RSS: Main: 263565312 15:49:54 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-yui.html (next: http://localhost:49372/tests/dromaeo/cssquery-dojo.html) 15:52:57 INFO - PROCESS | 1893 | RSS: Main: 338108416 15:52:57 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | __start_tp_report 15:52:57 INFO - PROCESS | 1893 | _x_x_mozilla_page_load 15:52:57 INFO - PROCESS | 1893 | _x_x_mozilla_page_load_details 15:52:57 INFO - PROCESS | 1893 | |i|pagename|runs| 15:52:57 INFO - PROCESS | 1893 | |0;dojo.html;3373.5445714828493;3431.4681224410224;3437.999999999999;3443.122003889008;3487.3897068013093;5734.025215713328;5743.195952566644;5749.856253593657;5787.623804452718;5791.478766910983;5697.886042279162;5801.796937107191;5803.361630220672;5814.854628634286;5816.883662326751;5166.819161329364;5228.2680424740565;5239.449857764937;5263.0526505229045;5302.973485132588;5119.206522988924;5149.897002059956;5311.282976798141;5313.867153321159;5323.095073837438;5148.639595228336;5204.583633309345;5260.894782104356;5268;5327.147656374981;5263.6841789492755;5279.445658205871;5283.181106928432;5298.97350513245;5302.3106996090455;4309.5690430956965;5169.53474187325;5207.270982062514;5244.423113457517;5274.683518988834;5597.580181486404;5645.915311270334;5652.858678533028;5672.631278966854;5734.283214598176;6251.968740156316;6307.621542707452;6315.5894866833505;6324.367563243685;6339.714712837887;6253.749850005995;6268.435840774307;6269.467095296905;6273.592216505913;6277.7802776903045;5674.829755107395;5819.156222347736;5824.825255242349;5919.911201331984;5940.198073260141;6246.219222597176;6300.527460440485;6313;6324.841878953063;6340.795248902694;6221.626702397871;6268.373162683786;6276.246850377893;6290.591111577733;6290.748370065146;6221.129041934133;6245.0632405139595;6302.212223472066;6320.936790632127;6323.146375239376;6174.413430724074;6228.844278893064;6260.123582698426;6278.30938596754;6352.968235158887;6332.746690132435;6332.968335158294;6343;6344.873102537924;6346.333634968354;5034.521720436553;5072.797088116507;5081.74591270435;5093.083245015859;5100.183970564692;4459.175052615276;4488.438945131858;4491.348754430589;4491.595756381876;4518.774061296987;5839.708014599253;5862.443067908542;5880.7353669085;5893.469587737039;5917.378675239038;6286.748530058838;6287.339829317856;6295.055741638791;6301.842453938597;6303.180586523723;5625.212470254168;5652.63257888236;5671.234383358276;5867;5874;5370.758315875795;5407.621466497386;5428.674279543161;5466.972665136728;5470.9452905471235;6252.812415627538;6261.311255761862;6264.185655864709;6279.748810047547;6326.620402775849;5038.765502451776;5985.790497332572;6210.968945155426;6317.96841015792;6331.398517140864;6198.783042593487;6201.782937597162;6211.65835879031;6242.344553821965;6293.37066293367;6235.875282494234;6266.655333956493;6268.1851359323;6283;6293.779717709858;6247.656378899204;6303.716332765129;6309.684515774285;6311.2426508819235;6324.810255692337;5966.910496342472;6080.087986802015;6095.847603809941;6127.7393367763425;6146.078088286793;5697.774978379668;5702.885942281048;6132.233470816148;6180.690965451619;6235.064740288993;6088.817335479943;6091.939080609137;6107.786227482017;6121.296050954019;6133.509319254538;6012.609180403259;6109.404666050415;6126.792505495216;6130.8873626509085;6236.594621349598;6114.266954506099;6115.471326262934;6137.438273608381;6140.688304616386;6142.293636231891 15:52:57 INFO - PROCESS | 1893 | |1;ext.html;470.6705306285601;504.097665179329;535.3522238091908;536.8604162917641;544.6405372454182;32554;42530.78734606326;44271.77864110679;44503.55496445043;45751.084978300416;45492.862678433055;45858.312125318145;45885.7705711471;45914.31128533075;45980.3102953456;9580.233581313512;9768.511574421285;9779.951100244489;9806.901930980706;9812.215022798158;9122.817543649124;9269.860952085724;9908.801823963517;11819.172657913949;12007.579734709287;11833.526658933632;11868.64394068175;11936.582219622314;11964.102692298113;11967.281963082243;11903;11979.94010029953;11997.760044799055;12003.099767517471;12009.699757506045;11811.822822657667;11880.168388212829;11884.227525210834;11898.048156147488;11948.761024779456;42303.78848105771;42558.14883702339;42618;42705.57294427047;42736.35895461571;3998.7000974926996;4002.139539998885;4066.0648050948153;4073.3279008963486;4100.507939047304;27508.44983100327;30099.849500752356;30226.69773302283;30979.225519362197;31145.53971971877;3363.1928337199142;3365.6970872621337;3369.9560527367257;3436.055084851661;3477.3566890125408;495006.52496737643;497021;498767;499460;500807;63041;63430.68284658547;63517;63559.68220158962;63569.36430635727;58472.415275846695;71812.28187718161;71983;72074.675519469;72140.2785972144;17901.462956111336;18116.90941545284;18145.183466744027;18191.089935556574;18195;13675.658108547366;13761.17432954026;13779.655508612164;13802.861971380358;13803.79294310566;16818.07500587455;16983.98096114237;17007.23467443968;19802.70295945562;22973.770262297163;8975.461472311552;9144.451332920045;9181.862272065791;9199.77000574991;9279.39683920543;885.751989442957;909.9909000910038;913.794396260836;933.5985526223789;949.107838631684;25447.69932982405;26091.608625870627;30647;30658.54012189819;31302.530462043087;1075.3762817565794;1105.701460605632;1117.7373317270435;1121.2319561100671;1210.5473431881778;15780.526584202493;15799.763003554956;16216.351345946267;16287.104209268604;16579.419720309732;666508;671474;675960;676832.5425355871;678576;50538.74730626397;51644.48355516472;57965;59041.704791475764;59130.70434647799;1259.4647274908127;1434.5624584501618;1466.6846627974824;1481.4962912609765;1487.2638044168207;28990.985315513855;29819.850900745358;29984.100476985725;30350.984578176693;30744.231394215323;50096.24855627241;50616.240756387946;50933.74533127311;50949.981000380525;51095.489045109076;480864;481278;482721;483611;485444;26704;26944;26947.86526067357;27049.323766905196;27080.32299192536;44549.73939499842;45788.54211457976;46583.76708116573;47047.53048460391;47229.81925451891;25651.35871603225;30779;30883.536746949263;31349.373012539167;32422.351552968335;30372;30706.232344191572;31319;32142.03573892787;32277.677223227467;35468.11329716778;36611.35248913752;37108.443373348884;37302.253954920205;37320.44019339658;30649.846750766104;31461.056168314986;31624;32094.518582221754;32522.51216231711;21796.493403258828;22227.222047228268;22923.426914327276;24707.62938555887;24721.752782471944 15:52:57 INFO - PROCESS | 1893 | |2;jquery.html;401.403915185949;402.5049189496919;411.2104758862983;412.52971612361904;433.4386968875306;20866.582668346626;20904.904685169204;22086;22225.2221172259;22230.777692223073;16483.752743708854;17518.562035949075;18355.908220458914;21649.458763530918;22331.883405829685;5475.260839786628;5834.124881267822;5860.677662728548;5863.442972917587;5872.823815285548;5712.8857422851515;5715;5754.942450575482;5811.1283307504;5851.327097383792;6069.271687397519;6174.35169307223;6181.629102253857;6182.8454288642915;6189.195404597396;5311.654742441768;6132.049532322497;6172.321044685081;6650.966745166292;6731.596104233761;5991.880162396727;5997.790077347316;6010.278766548042;6012.0380739081975;6018.8495287617725;11525.423728813526;13245.47018119274;13544.86455135446;13656.317184140753;13812.93093534536;2659.7872170226337;2679.6516452861197;2703;2704.5537486314734;2719.2929838242003;9906.306558540906;10005.549750261256;10162.288639795217;10599.523021464052;10663.893361066444;1835.183343412182;1859.1447933950399;1860.6929856573784;1898;1904.8952307623076;113692;121603.99999999911;130619.42832000834;141160;149161.50838491693;11568.595099171489;11687.88312116885;12122.999410194614;12130.150889437831;12146.75706485883;15673.137977411352;16026.11856347912;16105.838941610667;16138.838611613968;16196;9018.278537716968;9165.679201227926;9193.448393096436;9264.907350926405;9349.345545811864;7312.5246858954;9020.819583608421;9049.502277374675;9195.448273103635;9198.494082825375;4857.878553036202;4862.586680132157;4871.5128487151005;4872.7087321859735;4948.38145231846;1540.9752514577904;1727.6199236168022;1872.5412273992958;1985.4738494299022;2001.7597888253504;1049.567912924732;1050.6585359757955;1073.350622873166;1073.5544748929108;1110.8722496912958;21424.571508570054;21648;21726.674099888514;21729.891350543145;21826.236081737065;1083.247143235444;1085.1210519479089;1110.8611423572054;1121.2823792772633;1123.5225029362653;10831.2959657622;10835.930238915264;11359.772804543863;11406.42967851604;11411.42942852854;763823;778463;781084;794053;801638;106159;140951;156518.21740891223;160925;167800;957.3872721458272;1056.7358160459885;1090.3948308688596;1092.0608276881876;1099.5381939585554;19502.8049719501;20021.09905054247;20207.393778186677;20501.58996820085;20509.974501275174;49463.25805112998;62330;62408.68795655993;64355.35644643493;64592.677036614514;72228.63885680538;89658;92400.53799731228;92710.14579708503;95338;8413.579321033802;8426.831463370821;8681.348898832486;8706.042335343234;8803.207711306013;10095.596176153165;13177.736445271232;13242;13459.259740714355;13636.93181534086;5739.598228123991;8145.551994640115;9093.818123637358;9661.758456038655;11530.423478826193;9420.764480888032;9894.109530142321;10788.676339709822;10945.726356841144;11186.496607652838;10589.947050265007;11588.188826782045;11653;11961.700957476132;12075.818862716891;7378.5941773202985;7739.690412383667;7821.452498325063;7877.133515313197;8767.868481972648;10848.783024339627;11546.769064618493;11568.363739994045;11879.287242765462;11910.464029118884 15:52:57 INFO - PROCESS | 1893 | |3;mootools.html;1449.6375906023495;1476.5791749351438;1491.6196369925672;1507.879369650428;1508.4041803487623;8267.421280510367;8685.826283474327;8686.739397818059;8688.304935605152;8701.042885282613;7625.656845441955;7887.921120788805;8247.463914845532;8426.36802239833;8438.198371154731;2024.210557882427;2387.892544835478;2423.9636405453934;2430.307362401716;2430.829841911067;2412.7587241275905;2439.621858611918;2445.74319696432;2449.608062709967;2453.877306134695;2403.170906037414;2405.3505553500545;2428.550718117154;2436.3665446983823;2437.3662847659557;2384.344305316043;2384.4873352229356;2413.6500207469994;2414.5291668124723;2414.9275521734376;2216.6035397699507;2242.3048854855047;2365.160368069328;2384.0821283805685;2401.5317013182434;8473.406861519696;8501.319894408432;8597.4841509509;8600.440971336906;8603.31173506118;5177.016366890316;5334.253204551366;5344.064788661969;5345.492178243061;5350.785968561292;3337.03226064441;3366.2425954160117;3442.604100528421;3516.806575638339;3586.22896077342;1218.9695257618541;1225.8712835152269;1267.1700036476122;1291.7029083310797;1314.6844757258284;11112.388818614972;11160.107191424666;11168.106551475863;11171.888281117166;11194.944025279821;4622.548519764791;4744.383230180124;4812.302216178635;4849.612031037508;4896.11869863428;9730.562124704406;9734.221262299;9745.12293893553;9753.170980466739;9759.463229522302;5394.514493695587;5410.404855465896;5411.485908838654;5427.83716488506;5431.592630552725;4399.714018588846;4440.7335559866515;4869.878253043702;4940.431850337185;4962.60299176065;3929.2534418460973;3976;4028.67770578353;4066.1054567994993;4083.530394004668;1294.4627979388636;1295.9870401296055;1300.174389262825;1306.9738605228033;1315.1977293850744;890.9910900891037;919.2232563483846;924.8843894513186;927.4388994658269;959.6689142245914;5701.885962280814;5745.368009518949;5799.4490523401055;5981.551383646244;6045.516358691294;964.6864768950119;983.1102851919024;995.865558149655;1013.9797204055877;1059.0838924330553;3579.2483578448296;3801.8024322338374;3830.7893065881085;3878.980605097013;3923;9957.800843983225;10196;10299.124574411258;10303.690889273334;10328.173746100294;9733.124018838338;10021.749456263506;10142.137918276881;10245.436500992368;10278.33190842593;7751.883721744066;7990.960045199737;8140.796480088045;8144.552049637208;8145.266925976691;5446.482584154499;5471.151971444432;5581.609287350009;5639.943600563942;5672.858178545569;9342.953285233802;9357.39176953523;9608.231341492525;9614.95192524033;9620.086091821266;9149.725508234764;9450.905490945277;9475.763105922131;9503.429794212369;9566.521673916415;6777.932220677927;6983.266756990442;7002.529468811606;7353.5955522446775;7391.8152046199275;7652.1582625912215;7719.652615632423;7722.7297044603165;7730.806729831799;7834.725784597512;6760.96619516919;7108.218096009331;7133.286671332825;7177.210506844347;7219.45854060958;6058.515318774399;6691.297413771484;6978.930210697828;7014.5440546364325;7034.718611255493;6352;6424.325445828121;6434.806955791334;6523.739050437929;6525.119108920235;4949.836788354805;4965.155923493087;4972.353594032753;5008.949910500848;5089.956558905489;4913.238448040559;5032.521910418504;5064.5441910228255;5079.212722028092;5132.666376685504 15:52:57 INFO - PROCESS | 1893 | |4;prototype.html;360.3154007385968;364.28054592180445;374.2720408804872;375.8045816175589;385.1334497380891;4096.733712308698;4601.884952876179;5172.844814655557;5190.351206099238;5289.471052894709;4315.805788739506;4683.199720286708;4862.29496722975;5020.698758074509;5224.955008998206;3147.9611728129776;3746.9625303746884;3997.9200415991663;4215.451991241134;4231.4076029355765;3834.2714884172055;4058.959410405888;4231.386448964899;4247.405363249148;4254.319308910575;4126.401671757593;4148.419221309019;4163.916721665565;4169.895752606194;4186.727862688931;3917.921641567167;4125.278076336629;4151.6886233532605;4151.97924010381;4192.559781222958;3547.308274886398;3632.527771389729;3713.8645278964705;3728.179800443925;3733.663970242691;4173.97913010433;4511.8646440606835;5114.488551144893;5132.307138536325;5169.353830771153;4054.209429161315;4090.7750073745933;4419.41464243418;4603.9769801151115;4726.929096063562;4190.455240818705;4899.338589290472;5153.458886816868;5573.860653483695;5611.344653327278;3851.4607954886337;4074.694397920168;4118.670506359484;4125.947883289772;4130.153318569686;5604.579656525736;5859.296884373903;5865.0615901455985;5887.264091988502;5889.381614930414;4200.429634810448;4232.449781528381;4235.7670328131635;4243.490781106287;4247.320428731388;3174.873005079817;3928.6464218219926;3998.8000599969887;4054.8175332110127;4296.5273819879785;3730.7201959852578;4374.993751437188;4564.083085104264;4609.746463944448;4618.983823558811;4906.754662266872;5214.348206474191;5283.682979021194;5619.314205738262;5639.379668236491;995.9352642078387;1088.2545456362418;1174.653477224221;1227.2023184929867;1240.5782034108447;840.9495430274203;876.8027193881453;881.6076845803556;882.2544949517647;897.2956229359921;4547.590716835501;4614.90022039971;4917.041176970456;4961.593627090858;4962.7246017628195;4727.290906364073;5234.26720259164;5351.010063138254;5467.469108649584;5490.917636235459;4293.389978757966;4706.035262771192;4777.808887644455;4918.631102667243;4962.776675049631;2543.262453888389;2575.896964121414;2824.1104052223895;2867.483852906497;2869;4878.390201224847;5238.694974211335;5568.303962004749;5570.6657600544095;5631.352394474606;5079.822206222764;5238.856685988452;5871.911921321183;5896.7936122235515;5920.8815823684145;5480.835574932758;5870.88648086697;5944.375840536768;5971.98476259037;5986;4934.950650493449;5027.949720502748;5212.426633070435;5679.858003549944;5772.163036359789;5565;5584.692841893735;5698.914516282176;5721.4552070941445;5725.394945299795;4746.691465054761;5834.649921004753;5961.284645842353;5967.880642387041;6003.399660034136;3598.7660802047785;3681.705463562855;4214.388913607449;4236.661067114562;4251.617354438115;4896.877578060435;5779.739911704068;5783.392743761844;5786.392428794916;5823.912641310469;4334.739915605074;5639.069553523623;5641.548676105819;5662.065759149694;5672.092465205547;4920.876978075434;5168.715720635401;5441.979701265677;5585.944140558542;5597.93639208549;4700;4823;5243.580513558983;5248.714065054086;5509.917351239655;5427.728613569227;5583.860403489945;5586.692731899784;5602.887942241214;5612.186232996274;5019.716029206776;5055.674389780742;5073.847784566469;5229.372475302988;5464.371597266365 15:52:57 INFO - PROCESS | 1893 | |5;yui.html;737.6570982191412;749.067411073214;802.0175285275538;868.5440143924438;868.6525389844062;15027.549173524798;15633.140177290245;15639.218039098028;15648.608784780386;15661.765073523906;11888.702782430422;14368.640783980405;14376.562343765645;14415.423383064664;14445.205513696743;706.7455715942257;884.0231544143709;888.8177923525694;890.0565400675305;894.4365050018512;724.5688815155;729.095921057887;859.9422710066622;887.742554659148;889.6130183370223;958.0850287975002;960.1742501448748;960.9423434593912;961.3847137831793;963.1957315641413;951.219999600328;952.7570469530294;953.8044700836347;954.1889394015067;955.0497255231089;703.595432626242;704.7568588836843;706.4348521183084;706.6078326528774;708.7023450150949;13154.408051637603;14939.028963117362;15261.847381526153;15308.464203752816;15515.069095854173;14527.78208326876;14805.333759980827;14931;15023.399064037425;15221;11229.494672739746;11642.126840486997;11801.17391782567;11837.230580012272;12277.140600157993;4525.615322697575;4546.454425468932;4636.09596128755;4650.674452788307;4727.621790256806;103437.48281258621;105568;106272;107007.92992070057;107813;11013.2841365311;11202.21584489078;11278.605248816251;11334.036606888341;11465;21156.894215528824;21867.562648747255;21959.34121976343;21968.670469942965;22050;7472.887906681404;7772.183920688246;7842.5686587237105;7958.6816527339415;8083.797905052303;4351.477822661301;4481.484629267611;4504.436945381827;4508.932366014513;4521.253993091169;3507.9649203508147;3579.6420357964516;3580.9820950895078;3592.4072528033103;3597.9280414391565;663.1743479368217;673.2795908378087;673.6362364323309;676.3101636330915;693.3724978894109;579.9130130480378;593.5459373579215;597.2116805816368;601.4316470934924;615.6398506873439;9422.670206542874;9432.953904092119;9694.22446204302;10660.733481662865;10934.56261749521;540.753956949587;541.2882060090968;567.9176519404746;577.6043410263983;578.3840210176149;4854.150523658345;5086.793349639012;5128.358955130609;5246.058958185419;5275.683458992473;99177;99425;99530;103812;104782.4760876206;81971;82335.17664823275;83315.5834220825;85576.57211714025;89527;76344.61827690827;76685;77715;78494.21505784869;78630.46162922682;9694.56374463165;10061.597536098474;10101.797964040825;10142.746431338981;10183.185345172516;48274;48516.5148348512;50124.74937625288;50400;50570;67221;67949.32050679627;68444;69938;70885.6455717718;13321.933390333374;13510.662233444242;13593.184408935496;13842.238676872466;13852.238126903118;14938.850611494181;15127.39490420415;15167.848321517085;15229.466968656045;15512;13283.867161328262;13451.663708407368;14105.365258563184;14290.857091428952;14485.420583176976;11616.477258523219;11903.226290291102;11904.940475297568;12495.93752031234;13580.592582222549;14199.787003194753;14209.360578774187;14337.928310358382;14416.42334306616;14973.251337433303;9945.502724863873;10070.8489372658;10156.695299141038;10290.485475726333;10340.586376544854;9878.135276291265;10480.794708608608;10680.145588353069;11945.581904633644;11982.281063135892 15:52:57 INFO - PROCESS | 1893 | __end_tp_report 15:52:57 INFO - PROCESS | 1893 | __start_cc_report 15:52:57 INFO - PROCESS | 1893 | _x_x_mozilla_cycle_collect,1664 15:52:57 INFO - PROCESS | 1893 | __end_cc_report 15:52:57 INFO - PROCESS | 1893 | __startTimestamp1491951177678__endTimestamp 15:52:57 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | ------- Summary: start ------- 15:52:57 INFO - PROCESS | 1893 | Number of tests: 6 15:52:57 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | [#0] dojo.html Cycles:165 Average:5786.61 Median:6088.82 stddev:642.41 (10.6%) stddev-sans-first:615.86 15:52:57 INFO - PROCESS | 1893 | Values: 3373.5 3431.5 3438.0 3443.1 3487.4 5734.0 5743.2 5749.9 5787.6 5791.5 5697.9 5801.8 5803.4 5814.9 5816.9 5166.8 5228.3 5239.4 5263.1 5303.0 5119.2 5149.9 5311.3 5313.9 5323.1 5148.6 5204.6 5260.9 5268.0 5327.1 5263.7 5279.4 5283.2 5299.0 5302.3 4309.6 5169.5 5207.3 5244.4 5274.7 5597.6 5645.9 5652.9 5672.6 5734.3 6252.0 6307.6 6315.6 6324.4 6339.7 6253.7 6268.4 6269.5 6273.6 6277.8 5674.8 5819.2 5824.8 5919.9 5940.2 6246.2 6300.5 6313.0 6324.8 6340.8 6221.6 6268.4 6276.2 6290.6 6290.7 6221.1 6245.1 6302.2 6320.9 6323.1 6174.4 6228.8 6260.1 6278.3 6353.0 6332.7 6333.0 6343.0 6344.9 6346.3 5034.5 5072.8 5081.7 5093.1 5100.2 4459.2 4488.4 4491.3 4491.6 4518.8 5839.7 5862.4 5880.7 5893.5 5917.4 6286.7 6287.3 6295.1 6301.8 6303.2 5625.2 5652.6 5671.2 5867.0 5874.0 5370.8 5407.6 5428.7 5467.0 5470.9 6252.8 6261.3 6264.2 6279.7 6326.6 5038.8 5985.8 6211.0 6318.0 6331.4 6198.8 6201.8 6211.7 6242.3 6293.4 6235.9 6266.7 6268.2 6283.0 6293.8 6247.7 6303.7 6309.7 6311.2 6324.8 5966.9 6080.1 6095.8 6127.7 6146.1 5697.8 5702.9 6132.2 6180.7 6235.1 6088.8 6091.9 6107.8 6121.3 6133.5 6012.6 6109.4 6126.8 6130.9 6236.6 6114.3 6115.5 6137.4 6140.7 6142.3 15:52:57 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | [#1] ext.html Cycles:180 Average:68968.52 Median:3403.01 stddev:149169.42 (4383.5%) stddev-sans-first:149499.22 15:52:57 INFO - PROCESS | 1893 | Values: 470.7 504.1 535.4 536.9 544.6 32554.0 42530.8 44271.8 44503.6 45751.1 45492.9 45858.3 45885.8 45914.3 45980.3 9580.2 9768.5 9780.0 9806.9 9812.2 9122.8 9269.9 9908.8 11819.2 12007.6 11833.5 11868.6 11936.6 11964.1 11967.3 11903.0 11979.9 11997.8 12003.1 12009.7 11811.8 11880.2 11884.2 11898.0 11948.8 42303.8 42558.1 42618.0 42705.6 42736.4 3998.7 4002.1 4066.1 4073.3 4100.5 27508.4 30099.8 30226.7 30979.2 31145.5 3363.2 3365.7 3370.0 3436.1 3477.4 495006.5 497021.0 498767.0 499460.0 500807.0 63041.0 63430.7 63517.0 63559.7 63569.4 58472.4 71812.3 71983.0 72074.7 72140.3 17901.5 18116.9 18145.2 18191.1 18195.0 13675.7 13761.2 13779.7 13802.9 13803.8 16818.1 16984.0 17007.2 19802.7 22973.8 8975.5 9144.5 9181.9 9199.8 9279.4 885.8 910.0 913.8 933.6 949.1 25447.7 26091.6 30647.0 30658.5 31302.5 1075.4 1105.7 1117.7 1121.2 1210.5 15780.5 15799.8 16216.4 16287.1 16579.4 666508.0 671474.0 675960.0 676832.5 678576.0 50538.7 51644.5 57965.0 59041.7 59130.7 1259.5 1434.6 1466.7 1481.5 1487.3 28991.0 29819.9 29984.1 30351.0 30744.2 50096.2 50616.2 50933.7 50950.0 51095.5 480864.0 481278.0 482721.0 483611.0 485444.0 26704.0 26944.0 26947.9 27049.3 27080.3 44549.7 45788.5 46583.8 47047.5 47229.8 25651.4 30779.0 30883.5 31349.4 32422.4 30372.0 30706.2 31319.0 32142.0 32277.7 35468.1 36611.4 37108.4 37302.3 37320.4 30649.8 31461.1 31624.0 32094.5 32522.5 21796.5 22227.2 22923.4 24707.6 24721.8 15:52:57 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | [#2] jquery.html Cycles:180 Average:41399.22 Median:21728.28 stddev:130258.92 (599.5%) stddev-sans-first:130587.95 15:52:57 INFO - PROCESS | 1893 | Values: 401.4 402.5 411.2 412.5 433.4 20866.6 20904.9 22086.0 22225.2 22230.8 16483.8 17518.6 18355.9 21649.5 22331.9 5475.3 5834.1 5860.7 5863.4 5872.8 5712.9 5715.0 5754.9 5811.1 5851.3 6069.3 6174.4 6181.6 6182.8 6189.2 5311.7 6132.0 6172.3 6651.0 6731.6 5991.9 5997.8 6010.3 6012.0 6018.8 11525.4 13245.5 13544.9 13656.3 13812.9 2659.8 2679.7 2703.0 2704.6 2719.3 9906.3 10005.5 10162.3 10599.5 10663.9 1835.2 1859.1 1860.7 1898.0 1904.9 113692.0 121604.0 130619.4 141160.0 149161.5 11568.6 11687.9 12123.0 12130.2 12146.8 15673.1 16026.1 16105.8 16138.8 16196.0 9018.3 9165.7 9193.4 9264.9 9349.3 7312.5 9020.8 9049.5 9195.4 9198.5 4857.9 4862.6 4871.5 4872.7 4948.4 1541.0 1727.6 1872.5 1985.5 2001.8 1049.6 1050.7 1073.4 1073.6 1110.9 21424.6 21648.0 21726.7 21729.9 21826.2 1083.2 1085.1 1110.9 1121.3 1123.5 10831.3 10835.9 11359.8 11406.4 11411.4 763823.0 778463.0 781084.0 794053.0 801638.0 106159.0 140951.0 156518.2 160925.0 167800.0 957.4 1056.7 1090.4 1092.1 1099.5 19502.8 20021.1 20207.4 20501.6 20510.0 49463.3 62330.0 62408.7 64355.4 64592.7 72228.6 89658.0 92400.5 92710.1 95338.0 8413.6 8426.8 8681.3 8706.0 8803.2 10095.6 13177.7 13242.0 13459.3 13636.9 5739.6 8145.6 9093.8 9661.8 11530.4 9420.8 9894.1 10788.7 10945.7 11186.5 10589.9 11588.2 11653.0 11961.7 12075.8 7378.6 7739.7 7821.5 7877.1 8767.9 10848.8 11546.8 11568.4 11879.3 11910.5 15:52:57 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | [#3] mootools.html Cycles:180 Average:5540.43 Median:5255.63 stddev:3002.03 (57.1%) stddev-sans-first:2994.70 15:52:57 INFO - PROCESS | 1893 | Values: 1449.6 1476.6 1491.6 1507.9 1508.4 8267.4 8685.8 8686.7 8688.3 8701.0 7625.7 7887.9 8247.5 8426.4 8438.2 2024.2 2387.9 2424.0 2430.3 2430.8 2412.8 2439.6 2445.7 2449.6 2453.9 2403.2 2405.4 2428.6 2436.4 2437.4 2384.3 2384.5 2413.7 2414.5 2414.9 2216.6 2242.3 2365.2 2384.1 2401.5 8473.4 8501.3 8597.5 8600.4 8603.3 5177.0 5334.3 5344.1 5345.5 5350.8 3337.0 3366.2 3442.6 3516.8 3586.2 1219.0 1225.9 1267.2 1291.7 1314.7 11112.4 11160.1 11168.1 11171.9 11194.9 4622.5 4744.4 4812.3 4849.6 4896.1 9730.6 9734.2 9745.1 9753.2 9759.5 5394.5 5410.4 5411.5 5427.8 5431.6 4399.7 4440.7 4869.9 4940.4 4962.6 3929.3 3976.0 4028.7 4066.1 4083.5 1294.5 1296.0 1300.2 1307.0 1315.2 891.0 919.2 924.9 927.4 959.7 5701.9 5745.4 5799.4 5981.6 6045.5 964.7 983.1 995.9 1014.0 1059.1 3579.2 3801.8 3830.8 3879.0 3923.0 9957.8 10196.0 10299.1 10303.7 10328.2 9733.1 10021.7 10142.1 10245.4 10278.3 7751.9 7991.0 8140.8 8144.6 8145.3 5446.5 5471.2 5581.6 5639.9 5672.9 9343.0 9357.4 9608.2 9615.0 9620.1 9149.7 9450.9 9475.8 9503.4 9566.5 6777.9 6983.3 7002.5 7353.6 7391.8 7652.2 7719.7 7722.7 7730.8 7834.7 6761.0 7108.2 7133.3 7177.2 7219.5 6058.5 6691.3 6978.9 7014.5 7034.7 6352.0 6424.3 6434.8 6523.7 6525.1 4949.8 4965.2 4972.4 5008.9 5090.0 4913.2 5032.5 5064.5 5079.2 5132.7 15:52:57 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | [#4] prototype.html Cycles:180 Average:4478.82 Median:4911.90 stddev:1353.61 (27.6%) stddev-sans-first:1321.64 15:52:57 INFO - PROCESS | 1893 | Values: 360.3 364.3 374.3 375.8 385.1 4096.7 4601.9 5172.8 5190.4 5289.5 4315.8 4683.2 4862.3 5020.7 5225.0 3148.0 3747.0 3997.9 4215.5 4231.4 3834.3 4059.0 4231.4 4247.4 4254.3 4126.4 4148.4 4163.9 4169.9 4186.7 3917.9 4125.3 4151.7 4152.0 4192.6 3547.3 3632.5 3713.9 3728.2 3733.7 4174.0 4511.9 5114.5 5132.3 5169.4 4054.2 4090.8 4419.4 4604.0 4726.9 4190.5 4899.3 5153.5 5573.9 5611.3 3851.5 4074.7 4118.7 4125.9 4130.2 5604.6 5859.3 5865.1 5887.3 5889.4 4200.4 4232.4 4235.8 4243.5 4247.3 3174.9 3928.6 3998.8 4054.8 4296.5 3730.7 4375.0 4564.1 4609.7 4619.0 4906.8 5214.3 5283.7 5619.3 5639.4 995.9 1088.3 1174.7 1227.2 1240.6 840.9 876.8 881.6 882.3 897.3 4547.6 4614.9 4917.0 4961.6 4962.7 4727.3 5234.3 5351.0 5467.5 5490.9 4293.4 4706.0 4777.8 4918.6 4962.8 2543.3 2575.9 2824.1 2867.5 2869.0 4878.4 5238.7 5568.3 5570.7 5631.4 5079.8 5238.9 5871.9 5896.8 5920.9 5480.8 5870.9 5944.4 5972.0 5986.0 4935.0 5027.9 5212.4 5679.9 5772.2 5565.0 5584.7 5698.9 5721.5 5725.4 4746.7 5834.6 5961.3 5967.9 6003.4 3598.8 3681.7 4214.4 4236.7 4251.6 4896.9 5779.7 5783.4 5786.4 5823.9 4334.7 5639.1 5641.5 5662.1 5672.1 4920.9 5168.7 5442.0 5585.9 5597.9 4700.0 4823.0 5243.6 5248.7 5509.9 5427.7 5583.9 5586.7 5602.9 5612.2 5019.7 5055.7 5073.8 5229.4 5464.4 15:52:57 INFO - PROCESS | 1893 | 15:52:57 INFO - PROCESS | 1893 | [#5] yui.html Cycles:180 Average:20420.88 Median:4523.43 stddev:28972.20 (640.5%) stddev-sans-first:29015.78 15:52:57 INFO - PROCESS | 1893 | Values: 737.7 749.1 802.0 868.5 868.7 15027.5 15633.1 15639.2 15648.6 15661.8 11888.7 14368.6 14376.6 14415.4 14445.2 706.7 884.0 888.8 890.1 894.4 724.6 729.1 859.9 887.7 889.6 958.1 960.2 960.9 961.4 963.2 951.2 952.8 953.8 954.2 955.0 703.6 704.8 706.4 706.6 708.7 13154.4 14939.0 15261.8 15308.5 15515.1 14527.8 14805.3 14931.0 15023.4 15221.0 11229.5 11642.1 11801.2 11837.2 12277.1 4525.6 4546.5 4636.1 4650.7 4727.6 103437.5 105568.0 106272.0 107007.9 107813.0 11013.3 11202.2 11278.6 11334.0 11465.0 21156.9 21867.6 21959.3 21968.7 22050.0 7472.9 7772.2 7842.6 7958.7 8083.8 4351.5 4481.5 4504.4 4508.9 4521.3 3508.0 3579.6 3581.0 3592.4 3597.9 663.2 673.3 673.6 676.3 693.4 579.9 593.5 597.2 601.4 615.6 9422.7 9433.0 9694.2 10660.7 10934.6 540.8 541.3 567.9 577.6 578.4 4854.2 5086.8 5128.4 5246.1 5275.7 99177.0 99425.0 99530.0 103812.0 104782.5 81971.0 82335.2 83315.6 85576.6 89527.0 76344.6 76685.0 77715.0 78494.2 78630.5 9694.6 10061.6 10101.8 10142.7 10183.2 48274.0 48516.5 50124.7 50400.0 50570.0 67221.0 67949.3 68444.0 69938.0 70885.6 13321.9 13510.7 13593.2 13842.2 13852.2 14938.9 15127.4 15167.8 15229.5 15512.0 13283.9 13451.7 14105.4 14290.9 14485.4 11616.5 11903.2 11904.9 12495.9 13580.6 14199.8 14209.4 14337.9 14416.4 14973.3 9945.5 10070.8 10156.7 10290.5 10340.6 9878.1 10480.8 10680.1 11945.6 11982.3 15:52:57 INFO - PROCESS | 1893 | -------- Summary: end -------- 15:52:57 INFO - PROCESS | 1893 | 15:52:58 INFO - TEST-INFO | 1893: exit 0 15:52:58 INFO - TEST-OK | dromaeo_css | took 1116696ms 15:52:58 INFO - TEST-START | kraken 15:52:58 INFO - operating with platform_type : mac_ 15:52:58 INFO - Initialising browser for kraken test... 15:52:58 INFO - TEST-INFO | started process 1898 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpp3kWtT/profile http://localhost:49372/getInfo.html) 15:53:00 INFO - PROCESS | 1898 | __metrics Screen width/height:1600/1200 15:53:00 INFO - PROCESS | 1898 | colorDepth:24 15:53:00 INFO - PROCESS | 1898 | Browser inner width/height: 1024/689 15:53:00 INFO - PROCESS | 1898 | __metrics 15:53:00 INFO - PROCESS | 1898 | 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" 15:53:00 INFO - PROCESS | 1898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:01 INFO - TEST-INFO | 1898: exit 0 15:53:01 INFO - Browser initialized. 15:53:01 INFO - Running cycle 1/1 for kraken test... 15:53:01 INFO - TEST-INFO | started process 1900 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpp3kWtT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:13 INFO - PROCESS | 1900 | RSS: Main: 163729408 15:53:13 INFO - PROCESS | 1900 | 15:53:15 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:16 INFO - PROCESS | 1900 | RSS: Main: 214487040 15:53:16 INFO - PROCESS | 1900 | 15:53:19 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-dft) 15:53:20 INFO - PROCESS | 1900 | RSS: Main: 227028992 15:53:20 INFO - PROCESS | 1900 | 15:53:23 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-fft) 15:53:23 INFO - PROCESS | 1900 | RSS: Main: 323354624 15:53:23 INFO - PROCESS | 1900 | 15:53:25 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-oscillator) 15:53:26 INFO - PROCESS | 1900 | RSS: Main: 227991552 15:53:26 INFO - PROCESS | 1900 | 15:53:28 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:53:28 INFO - PROCESS | 1900 | RSS: Main: 229560320 15:53:28 INFO - PROCESS | 1900 | 15:53:31 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-darkroom) 15:53:32 INFO - PROCESS | 1900 | RSS: Main: 270647296 15:53:32 INFO - PROCESS | 1900 | 15:53:35 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-desaturate) 15:53:36 INFO - PROCESS | 1900 | RSS: Main: 270102528 15:53:36 INFO - PROCESS | 1900 | 15:53:38 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49372/tests/kraken/driver.html?testName=json-parse-financial) 15:53:39 INFO - PROCESS | 1900 | RSS: Main: 266727424 15:53:39 INFO - PROCESS | 1900 | 15:53:40 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:41 INFO - PROCESS | 1900 | RSS: Main: 244060160 15:53:41 INFO - PROCESS | 1900 | 15:53:43 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:44 INFO - PROCESS | 1900 | RSS: Main: 246333440 15:53:44 INFO - PROCESS | 1900 | 15:53:46 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:46 INFO - PROCESS | 1900 | RSS: Main: 256811008 15:53:46 INFO - PROCESS | 1900 | 15:53:49 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:50 INFO - PROCESS | 1900 | RSS: Main: 270508032 15:53:50 INFO - PROCESS | 1900 | 15:53:53 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:53 INFO - PROCESS | 1900 | RSS: Main: 264204288 15:53:53 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49372/tests/kraken/driver.html?testName=ai-astar) 15:53:55 INFO - PROCESS | 1900 | RSS: Main: 308543488 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | __start_tp_report 15:53:55 INFO - PROCESS | 1900 | _x_x_mozilla_page_load 15:53:55 INFO - PROCESS | 1900 | _x_x_mozilla_page_load_details 15:53:55 INFO - PROCESS | 1900 | |i|pagename|runs| 15:53:55 INFO - PROCESS | 1900 | |0;ai-astar;100;110;110;110;111;111;112;110;112;111 15:53:55 INFO - PROCESS | 1900 | |1;audio-beat-detection;143;126;137;175;110;111;88;113;159;138 15:53:55 INFO - PROCESS | 1900 | |2;audio-dft;181;183;185;181;183;186;183;185;184;183 15:53:55 INFO - PROCESS | 1900 | |3;audio-fft;83;59;58;89;59;57;56;57;72;56 15:53:55 INFO - PROCESS | 1900 | |4;audio-oscillator;88;70;86;70;67;68;81;52;63;88 15:53:55 INFO - PROCESS | 1900 | |5;imaging-gaussian-blur;87;83;87;84;88;121;88;84;87;83 15:53:55 INFO - PROCESS | 1900 | |6;imaging-darkroom;93;93;92;93;93;92;93;120;151;143 15:53:55 INFO - PROCESS | 1900 | |7;imaging-desaturate;89;85;87;86;86;84;87;84;89;85 15:53:55 INFO - PROCESS | 1900 | |8;json-parse-financial;55;52;51;54;54;57;57;55;55;56 15:53:55 INFO - PROCESS | 1900 | |9;json-stringify-tinderbox;62;75;80;73;70;67;68;68;69;68 15:53:55 INFO - PROCESS | 1900 | |10;stanford-crypto-aes;79;83;81;82;75;82;82;81;79;85 15:53:55 INFO - PROCESS | 1900 | |11;stanford-crypto-ccm;143;141;125;142;142;146;132;135;174;139 15:53:55 INFO - PROCESS | 1900 | |12;stanford-crypto-pbkdf2;162;161;176;162;161;163;164;161;160;160 15:53:55 INFO - PROCESS | 1900 | |13;stanford-crypto-sha256-iterative;69;80;81;82;62;65;63;61;63;65 15:53:55 INFO - PROCESS | 1900 | __end_tp_report 15:53:55 INFO - PROCESS | 1900 | __start_cc_report 15:53:55 INFO - PROCESS | 1900 | _x_x_mozilla_cycle_collect,1958 15:53:55 INFO - PROCESS | 1900 | __end_cc_report 15:53:55 INFO - PROCESS | 1900 | __startTimestamp1491951235814__endTimestamp 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | ------- Summary: start ------- 15:53:55 INFO - PROCESS | 1900 | Number of tests: 14 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.50 (3.2%) stddev-sans-first:0.83 15:53:55 INFO - PROCESS | 1900 | Values: 100.0 110.0 110.0 110.0 111.0 111.0 112.0 110.0 112.0 111.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:140.50 stddev:25.77 (18.3%) stddev-sans-first:26.90 15:53:55 INFO - PROCESS | 1900 | Values: 143.0 126.0 137.0 175.0 110.0 111.0 88.0 113.0 159.0 138.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:1.65 (0.9%) stddev-sans-first:1.50 15:53:55 INFO - PROCESS | 1900 | Values: 181.0 183.0 185.0 181.0 183.0 186.0 183.0 185.0 184.0 183.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#3] audio-fft Cycles:10 Average:64.60 Median:59.00 stddev:12.29 (20.8%) stddev-sans-first:11.08 15:53:55 INFO - PROCESS | 1900 | Values: 83.0 59.0 58.0 89.0 59.0 57.0 56.0 57.0 72.0 56.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#4] audio-oscillator Cycles:10 Average:73.30 Median:75.50 stddev:12.03 (15.9%) stddev-sans-first:11.52 15:53:55 INFO - PROCESS | 1900 | Values: 88.0 70.0 86.0 70.0 67.0 68.0 81.0 52.0 63.0 88.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:87.00 stddev:11.35 (13.0%) stddev-sans-first:12.01 15:53:55 INFO - PROCESS | 1900 | Values: 87.0 83.0 87.0 84.0 88.0 121.0 88.0 84.0 87.0 83.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:93.00 stddev:23.16 (24.9%) stddev-sans-first:24.06 15:53:55 INFO - PROCESS | 1900 | Values: 93.0 93.0 92.0 93.0 93.0 92.0 93.0 120.0 151.0 143.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:1.81 (2.1%) stddev-sans-first:1.62 15:53:55 INFO - PROCESS | 1900 | Values: 89.0 85.0 87.0 86.0 86.0 84.0 87.0 84.0 89.0 85.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.96 (3.6%) stddev-sans-first:2.07 15:53:55 INFO - PROCESS | 1900 | Values: 55.0 52.0 51.0 54.0 54.0 57.0 57.0 55.0 55.0 56.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.50 stddev:4.94 (7.1%) stddev-sans-first:4.31 15:53:55 INFO - PROCESS | 1900 | Values: 62.0 75.0 80.0 73.0 70.0 67.0 68.0 68.0 69.0 68.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:82.00 stddev:2.73 (3.3%) stddev-sans-first:2.80 15:53:55 INFO - PROCESS | 1900 | Values: 79.0 83.0 81.0 82.0 75.0 82.0 82.0 81.0 79.0 85.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:142.00 stddev:12.86 (9.1%) stddev-sans-first:13.64 15:53:55 INFO - PROCESS | 1900 | Values: 143.0 141.0 125.0 142.0 142.0 146.0 132.0 135.0 174.0 139.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:162.00 stddev:4.74 (2.9%) stddev-sans-first:5.01 15:53:55 INFO - PROCESS | 1900 | Values: 162.0 161.0 176.0 162.0 161.0 163.0 164.0 161.0 160.0 160.0 15:53:55 INFO - PROCESS | 1900 | 15:53:55 INFO - PROCESS | 1900 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:67.00 stddev:8.50 (12.7%) stddev-sans-first:9.02 15:53:55 INFO - PROCESS | 1900 | Values: 69.0 80.0 81.0 82.0 62.0 65.0 63.0 61.0 63.0 65.0 15:53:55 INFO - PROCESS | 1900 | -------- Summary: end -------- 15:53:55 INFO - PROCESS | 1900 | 15:53:56 INFO - TEST-INFO | 1900: exit 0 15:53:56 INFO - TEST-OK | kraken | took 58326ms 15:53:56 INFO - SUITE-END | took 1175s 15:53:56 INFO - Completed test suite (00:19:35) 15:53:56 INFO - javascript benchmark 15:53:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.5445714828493, 3431.4681224410224, 3437.999999999999, 3443.122003889008, 3487.3897068013093, 5734.025215713328, 5743.195952566644, 5749.856253593657, 5787.623804452718, 5791.478766910983, 5697.886042279162, 5801.796937107191, 5803.361630220672, 5814.854628634286, 5816.883662326751, 5166.819161329364, 5228.2680424740565, 5239.449857764937, 5263.0526505229045, 5302.973485132588, 5119.206522988924, 5149.897002059956, 5311.282976798141, 5313.867153321159, 5323.095073837438, 5148.639595228336, 5204.583633309345, 5260.894782104356, 5268.0, 5327.147656374981, 5263.6841789492755, 5279.445658205871, 5283.181106928432, 5298.97350513245, 5302.3106996090455, 4309.5690430956965, 5169.53474187325, 5207.270982062514, 5244.423113457517, 5274.683518988834, 5597.580181486404, 5645.915311270334, 5652.858678533028, 5672.631278966854, 5734.283214598176, 6251.968740156316, 6307.621542707452, 6315.5894866833505, 6324.367563243685, 6339.714712837887, 6253.749850005995, 6268.435840774307, 6269.467095296905, 6273.592216505913, 6277.7802776903045, 5674.829755107395, 5819.156222347736, 5824.825255242349, 5919.911201331984, 5940.198073260141, 6246.219222597176, 6300.527460440485, 6313.0, 6324.841878953063, 6340.795248902694, 6221.626702397871, 6268.373162683786, 6276.246850377893, 6290.591111577733, 6290.748370065146, 6221.129041934133, 6245.0632405139595, 6302.212223472066, 6320.936790632127, 6323.146375239376, 6174.413430724074, 6228.844278893064, 6260.123582698426, 6278.30938596754, 6352.968235158887, 6332.746690132435, 6332.968335158294, 6343.0, 6344.873102537924, 6346.333634968354, 5034.521720436553, 5072.797088116507, 5081.74591270435, 5093.083245015859, 5100.183970564692, 4459.175052615276, 4488.438945131858, 4491.348754430589, 4491.595756381876, 4518.774061296987, 5839.708014599253, 5862.443067908542, 5880.7353669085, 5893.469587737039, 5917.378675239038, 6286.748530058838, 6287.339829317856, 6295.055741638791, 6301.842453938597, 6303.180586523723, 5625.212470254168, 5652.63257888236, 5671.234383358276, 5867.0, 5874.0, 5370.758315875795, 5407.621466497386, 5428.674279543161, 5466.972665136728, 5470.9452905471235, 6252.812415627538, 6261.311255761862, 6264.185655864709, 6279.748810047547, 6326.620402775849, 5038.765502451776, 5985.790497332572, 6210.968945155426, 6317.96841015792, 6331.398517140864, 6198.783042593487, 6201.782937597162, 6211.65835879031, 6242.344553821965, 6293.37066293367, 6235.875282494234, 6266.655333956493, 6268.1851359323, 6283.0, 6293.779717709858, 6247.656378899204, 6303.716332765129, 6309.684515774285, 6311.2426508819235, 6324.810255692337, 5966.910496342472, 6080.087986802015, 6095.847603809941, 6127.7393367763425, 6146.078088286793, 5697.774978379668, 5702.885942281048, 6132.233470816148, 6180.690965451619, 6235.064740288993, 6088.817335479943, 6091.939080609137, 6107.786227482017, 6121.296050954019, 6133.509319254538, 6012.609180403259, 6109.404666050415, 6126.792505495216, 6130.8873626509085, 6236.594621349598, 6114.266954506099, 6115.471326262934, 6137.438273608381, 6140.688304616386, 6142.293636231891], "value": 5746.096037515669, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.6705306285601, 504.097665179329, 535.3522238091908, 536.8604162917641, 544.6405372454182, 32554.0, 42530.78734606326, 44271.77864110679, 44503.55496445043, 45751.084978300416, 45492.862678433055, 45858.312125318145, 45885.7705711471, 45914.31128533075, 45980.3102953456, 9580.233581313512, 9768.511574421285, 9779.951100244489, 9806.901930980706, 9812.215022798158, 9122.817543649124, 9269.860952085724, 9908.801823963517, 11819.172657913949, 12007.579734709287, 11833.526658933632, 11868.64394068175, 11936.582219622314, 11964.102692298113, 11967.281963082243, 11903.0, 11979.94010029953, 11997.760044799055, 12003.099767517471, 12009.699757506045, 11811.822822657667, 11880.168388212829, 11884.227525210834, 11898.048156147488, 11948.761024779456, 42303.78848105771, 42558.14883702339, 42618.0, 42705.57294427047, 42736.35895461571, 3998.7000974926996, 4002.139539998885, 4066.0648050948153, 4073.3279008963486, 4100.507939047304, 27508.44983100327, 30099.849500752356, 30226.69773302283, 30979.225519362197, 31145.53971971877, 3363.1928337199142, 3365.6970872621337, 3369.9560527367257, 3436.055084851661, 3477.3566890125408, 495006.52496737643, 497021.0, 498767.0, 499460.0, 500807.0, 63041.0, 63430.68284658547, 63517.0, 63559.68220158962, 63569.36430635727, 58472.415275846695, 71812.28187718161, 71983.0, 72074.675519469, 72140.2785972144, 17901.462956111336, 18116.90941545284, 18145.183466744027, 18191.089935556574, 18195.0, 13675.658108547366, 13761.17432954026, 13779.655508612164, 13802.861971380358, 13803.79294310566, 16818.07500587455, 16983.98096114237, 17007.23467443968, 19802.70295945562, 22973.770262297163, 8975.461472311552, 9144.451332920045, 9181.862272065791, 9199.77000574991, 9279.39683920543, 885.751989442957, 909.9909000910038, 913.794396260836, 933.5985526223789, 949.107838631684, 25447.69932982405, 26091.608625870627, 30647.0, 30658.54012189819, 31302.530462043087, 1075.3762817565794, 1105.701460605632, 1117.7373317270435, 1121.2319561100671, 1210.5473431881778, 15780.526584202493, 15799.763003554956, 16216.351345946267, 16287.104209268604, 16579.419720309732, 666508.0, 671474.0, 675960.0, 676832.5425355871, 678576.0, 50538.74730626397, 51644.48355516472, 57965.0, 59041.704791475764, 59130.70434647799, 1259.4647274908127, 1434.5624584501618, 1466.6846627974824, 1481.4962912609765, 1487.2638044168207, 28990.985315513855, 29819.850900745358, 29984.100476985725, 30350.984578176693, 30744.231394215323, 50096.24855627241, 50616.240756387946, 50933.74533127311, 50949.981000380525, 51095.489045109076, 480864.0, 481278.0, 482721.0, 483611.0, 485444.0, 26704.0, 26944.0, 26947.86526067357, 27049.323766905196, 27080.32299192536, 44549.73939499842, 45788.54211457976, 46583.76708116573, 47047.53048460391, 47229.81925451891, 25651.35871603225, 30779.0, 30883.536746949263, 31349.373012539167, 32422.351552968335, 30372.0, 30706.232344191572, 31319.0, 32142.03573892787, 32277.677223227467, 35468.11329716778, 36611.35248913752, 37108.443373348884, 37302.253954920205, 37320.44019339658, 30649.846750766104, 31461.056168314986, 31624.0, 32094.518582221754, 32522.51216231711, 21796.493403258828, 22227.222047228268, 22923.426914327276, 24707.62938555887, 24721.752782471944], "value": 20514.871010266583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.403915185949, 402.5049189496919, 411.2104758862983, 412.52971612361904, 433.4386968875306, 20866.582668346626, 20904.904685169204, 22086.0, 22225.2221172259, 22230.777692223073, 16483.752743708854, 17518.562035949075, 18355.908220458914, 21649.458763530918, 22331.883405829685, 5475.260839786628, 5834.124881267822, 5860.677662728548, 5863.442972917587, 5872.823815285548, 5712.8857422851515, 5715.0, 5754.942450575482, 5811.1283307504, 5851.327097383792, 6069.271687397519, 6174.35169307223, 6181.629102253857, 6182.8454288642915, 6189.195404597396, 5311.654742441768, 6132.049532322497, 6172.321044685081, 6650.966745166292, 6731.596104233761, 5991.880162396727, 5997.790077347316, 6010.278766548042, 6012.0380739081975, 6018.8495287617725, 11525.423728813526, 13245.47018119274, 13544.86455135446, 13656.317184140753, 13812.93093534536, 2659.7872170226337, 2679.6516452861197, 2703.0, 2704.5537486314734, 2719.2929838242003, 9906.306558540906, 10005.549750261256, 10162.288639795217, 10599.523021464052, 10663.893361066444, 1835.183343412182, 1859.1447933950399, 1860.6929856573784, 1898.0, 1904.8952307623076, 113692.0, 121603.99999999911, 130619.42832000834, 141160.0, 149161.50838491693, 11568.595099171489, 11687.88312116885, 12122.999410194614, 12130.150889437831, 12146.75706485883, 15673.137977411352, 16026.11856347912, 16105.838941610667, 16138.838611613968, 16196.0, 9018.278537716968, 9165.679201227926, 9193.448393096436, 9264.907350926405, 9349.345545811864, 7312.5246858954, 9020.819583608421, 9049.502277374675, 9195.448273103635, 9198.494082825375, 4857.878553036202, 4862.586680132157, 4871.5128487151005, 4872.7087321859735, 4948.38145231846, 1540.9752514577904, 1727.6199236168022, 1872.5412273992958, 1985.4738494299022, 2001.7597888253504, 1049.567912924732, 1050.6585359757955, 1073.350622873166, 1073.5544748929108, 1110.8722496912958, 21424.571508570054, 21648.0, 21726.674099888514, 21729.891350543145, 21826.236081737065, 1083.247143235444, 1085.1210519479089, 1110.8611423572054, 1121.2823792772633, 1123.5225029362653, 10831.2959657622, 10835.930238915264, 11359.772804543863, 11406.42967851604, 11411.42942852854, 763823.0, 778463.0, 781084.0, 794053.0, 801638.0, 106159.0, 140951.0, 156518.21740891223, 160925.0, 167800.0, 957.3872721458272, 1056.7358160459885, 1090.3948308688596, 1092.0608276881876, 1099.5381939585554, 19502.8049719501, 20021.09905054247, 20207.393778186677, 20501.58996820085, 20509.974501275174, 49463.25805112998, 62330.0, 62408.68795655993, 64355.35644643493, 64592.677036614514, 72228.63885680538, 89658.0, 92400.53799731228, 92710.14579708503, 95338.0, 8413.579321033802, 8426.831463370821, 8681.348898832486, 8706.042335343234, 8803.207711306013, 10095.596176153165, 13177.736445271232, 13242.0, 13459.259740714355, 13636.93181534086, 5739.598228123991, 8145.551994640115, 9093.818123637358, 9661.758456038655, 11530.423478826193, 9420.764480888032, 9894.109530142321, 10788.676339709822, 10945.726356841144, 11186.496607652838, 10589.947050265007, 11588.188826782045, 11653.0, 11961.700957476132, 12075.818862716891, 7378.5941773202985, 7739.690412383667, 7821.452498325063, 7877.133515313197, 8767.868481972648, 10848.783024339627, 11546.769064618493, 11568.363739994045, 11879.287242765462, 11910.464029118884], "value": 9882.776611570986, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.6375906023495, 1476.5791749351438, 1491.6196369925672, 1507.879369650428, 1508.4041803487623, 8267.421280510367, 8685.826283474327, 8686.739397818059, 8688.304935605152, 8701.042885282613, 7625.656845441955, 7887.921120788805, 8247.463914845532, 8426.36802239833, 8438.198371154731, 2024.210557882427, 2387.892544835478, 2423.9636405453934, 2430.307362401716, 2430.829841911067, 2412.7587241275905, 2439.621858611918, 2445.74319696432, 2449.608062709967, 2453.877306134695, 2403.170906037414, 2405.3505553500545, 2428.550718117154, 2436.3665446983823, 2437.3662847659557, 2384.344305316043, 2384.4873352229356, 2413.6500207469994, 2414.5291668124723, 2414.9275521734376, 2216.6035397699507, 2242.3048854855047, 2365.160368069328, 2384.0821283805685, 2401.5317013182434, 8473.406861519696, 8501.319894408432, 8597.4841509509, 8600.440971336906, 8603.31173506118, 5177.016366890316, 5334.253204551366, 5344.064788661969, 5345.492178243061, 5350.785968561292, 3337.03226064441, 3366.2425954160117, 3442.604100528421, 3516.806575638339, 3586.22896077342, 1218.9695257618541, 1225.8712835152269, 1267.1700036476122, 1291.7029083310797, 1314.6844757258284, 11112.388818614972, 11160.107191424666, 11168.106551475863, 11171.888281117166, 11194.944025279821, 4622.548519764791, 4744.383230180124, 4812.302216178635, 4849.612031037508, 4896.11869863428, 9730.562124704406, 9734.221262299, 9745.12293893553, 9753.170980466739, 9759.463229522302, 5394.514493695587, 5410.404855465896, 5411.485908838654, 5427.83716488506, 5431.592630552725, 4399.714018588846, 4440.7335559866515, 4869.878253043702, 4940.431850337185, 4962.60299176065, 3929.2534418460973, 3976.0, 4028.67770578353, 4066.1054567994993, 4083.530394004668, 1294.4627979388636, 1295.9870401296055, 1300.174389262825, 1306.9738605228033, 1315.1977293850744, 890.9910900891037, 919.2232563483846, 924.8843894513186, 927.4388994658269, 959.6689142245914, 5701.885962280814, 5745.368009518949, 5799.4490523401055, 5981.551383646244, 6045.516358691294, 964.6864768950119, 983.1102851919024, 995.865558149655, 1013.9797204055877, 1059.0838924330553, 3579.2483578448296, 3801.8024322338374, 3830.7893065881085, 3878.980605097013, 3923.0, 9957.800843983225, 10196.0, 10299.124574411258, 10303.690889273334, 10328.173746100294, 9733.124018838338, 10021.749456263506, 10142.137918276881, 10245.436500992368, 10278.33190842593, 7751.883721744066, 7990.960045199737, 8140.796480088045, 8144.552049637208, 8145.266925976691, 5446.482584154499, 5471.151971444432, 5581.609287350009, 5639.943600563942, 5672.858178545569, 9342.953285233802, 9357.39176953523, 9608.231341492525, 9614.95192524033, 9620.086091821266, 9149.725508234764, 9450.905490945277, 9475.763105922131, 9503.429794212369, 9566.521673916415, 6777.932220677927, 6983.266756990442, 7002.529468811606, 7353.5955522446775, 7391.8152046199275, 7652.1582625912215, 7719.652615632423, 7722.7297044603165, 7730.806729831799, 7834.725784597512, 6760.96619516919, 7108.218096009331, 7133.286671332825, 7177.210506844347, 7219.45854060958, 6058.515318774399, 6691.297413771484, 6978.930210697828, 7014.5440546364325, 7034.718611255493, 6352.0, 6424.325445828121, 6434.806955791334, 6523.739050437929, 6525.119108920235, 4949.836788354805, 4965.155923493087, 4972.353594032753, 5008.949910500848, 5089.956558905489, 4913.238448040559, 5032.521910418504, 5064.5441910228255, 5079.212722028092, 5132.666376685504], "value": 4526.136298642996, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.3154007385968, 364.28054592180445, 374.2720408804872, 375.8045816175589, 385.1334497380891, 4096.733712308698, 4601.884952876179, 5172.844814655557, 5190.351206099238, 5289.471052894709, 4315.805788739506, 4683.199720286708, 4862.29496722975, 5020.698758074509, 5224.955008998206, 3147.9611728129776, 3746.9625303746884, 3997.9200415991663, 4215.451991241134, 4231.4076029355765, 3834.2714884172055, 4058.959410405888, 4231.386448964899, 4247.405363249148, 4254.319308910575, 4126.401671757593, 4148.419221309019, 4163.916721665565, 4169.895752606194, 4186.727862688931, 3917.921641567167, 4125.278076336629, 4151.6886233532605, 4151.97924010381, 4192.559781222958, 3547.308274886398, 3632.527771389729, 3713.8645278964705, 3728.179800443925, 3733.663970242691, 4173.97913010433, 4511.8646440606835, 5114.488551144893, 5132.307138536325, 5169.353830771153, 4054.209429161315, 4090.7750073745933, 4419.41464243418, 4603.9769801151115, 4726.929096063562, 4190.455240818705, 4899.338589290472, 5153.458886816868, 5573.860653483695, 5611.344653327278, 3851.4607954886337, 4074.694397920168, 4118.670506359484, 4125.947883289772, 4130.153318569686, 5604.579656525736, 5859.296884373903, 5865.0615901455985, 5887.264091988502, 5889.381614930414, 4200.429634810448, 4232.449781528381, 4235.7670328131635, 4243.490781106287, 4247.320428731388, 3174.873005079817, 3928.6464218219926, 3998.8000599969887, 4054.8175332110127, 4296.5273819879785, 3730.7201959852578, 4374.993751437188, 4564.083085104264, 4609.746463944448, 4618.983823558811, 4906.754662266872, 5214.348206474191, 5283.682979021194, 5619.314205738262, 5639.379668236491, 995.9352642078387, 1088.2545456362418, 1174.653477224221, 1227.2023184929867, 1240.5782034108447, 840.9495430274203, 876.8027193881453, 881.6076845803556, 882.2544949517647, 897.2956229359921, 4547.590716835501, 4614.90022039971, 4917.041176970456, 4961.593627090858, 4962.7246017628195, 4727.290906364073, 5234.26720259164, 5351.010063138254, 5467.469108649584, 5490.917636235459, 4293.389978757966, 4706.035262771192, 4777.808887644455, 4918.631102667243, 4962.776675049631, 2543.262453888389, 2575.896964121414, 2824.1104052223895, 2867.483852906497, 2869.0, 4878.390201224847, 5238.694974211335, 5568.303962004749, 5570.6657600544095, 5631.352394474606, 5079.822206222764, 5238.856685988452, 5871.911921321183, 5896.7936122235515, 5920.8815823684145, 5480.835574932758, 5870.88648086697, 5944.375840536768, 5971.98476259037, 5986.0, 4934.950650493449, 5027.949720502748, 5212.426633070435, 5679.858003549944, 5772.163036359789, 5565.0, 5584.692841893735, 5698.914516282176, 5721.4552070941445, 5725.394945299795, 4746.691465054761, 5834.649921004753, 5961.284645842353, 5967.880642387041, 6003.399660034136, 3598.7660802047785, 3681.705463562855, 4214.388913607449, 4236.661067114562, 4251.617354438115, 4896.877578060435, 5779.739911704068, 5783.392743761844, 5786.392428794916, 5823.912641310469, 4334.739915605074, 5639.069553523623, 5641.548676105819, 5662.065759149694, 5672.092465205547, 4920.876978075434, 5168.715720635401, 5441.979701265677, 5585.944140558542, 5597.93639208549, 4700.0, 4823.0, 5243.580513558983, 5248.714065054086, 5509.917351239655, 5427.728613569227, 5583.860403489945, 5586.692731899784, 5602.887942241214, 5612.186232996274, 5019.716029206776, 5055.674389780742, 5073.847784566469, 5229.372475302988, 5464.371597266365], "value": 4059.682288815431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.6570982191412, 749.067411073214, 802.0175285275538, 868.5440143924438, 868.6525389844062, 15027.549173524798, 15633.140177290245, 15639.218039098028, 15648.608784780386, 15661.765073523906, 11888.702782430422, 14368.640783980405, 14376.562343765645, 14415.423383064664, 14445.205513696743, 706.7455715942257, 884.0231544143709, 888.8177923525694, 890.0565400675305, 894.4365050018512, 724.5688815155, 729.095921057887, 859.9422710066622, 887.742554659148, 889.6130183370223, 958.0850287975002, 960.1742501448748, 960.9423434593912, 961.3847137831793, 963.1957315641413, 951.219999600328, 952.7570469530294, 953.8044700836347, 954.1889394015067, 955.0497255231089, 703.595432626242, 704.7568588836843, 706.4348521183084, 706.6078326528774, 708.7023450150949, 13154.408051637603, 14939.028963117362, 15261.847381526153, 15308.464203752816, 15515.069095854173, 14527.78208326876, 14805.333759980827, 14931.0, 15023.399064037425, 15221.0, 11229.494672739746, 11642.126840486997, 11801.17391782567, 11837.230580012272, 12277.140600157993, 4525.615322697575, 4546.454425468932, 4636.09596128755, 4650.674452788307, 4727.621790256806, 103437.48281258621, 105568.0, 106272.0, 107007.92992070057, 107813.0, 11013.2841365311, 11202.21584489078, 11278.605248816251, 11334.036606888341, 11465.0, 21156.894215528824, 21867.562648747255, 21959.34121976343, 21968.670469942965, 22050.0, 7472.887906681404, 7772.183920688246, 7842.5686587237105, 7958.6816527339415, 8083.797905052303, 4351.477822661301, 4481.484629267611, 4504.436945381827, 4508.932366014513, 4521.253993091169, 3507.9649203508147, 3579.6420357964516, 3580.9820950895078, 3592.4072528033103, 3597.9280414391565, 663.1743479368217, 673.2795908378087, 673.6362364323309, 676.3101636330915, 693.3724978894109, 579.9130130480378, 593.5459373579215, 597.2116805816368, 601.4316470934924, 615.6398506873439, 9422.670206542874, 9432.953904092119, 9694.22446204302, 10660.733481662865, 10934.56261749521, 540.753956949587, 541.2882060090968, 567.9176519404746, 577.6043410263983, 578.3840210176149, 4854.150523658345, 5086.793349639012, 5128.358955130609, 5246.058958185419, 5275.683458992473, 99177.0, 99425.0, 99530.0, 103812.0, 104782.4760876206, 81971.0, 82335.17664823275, 83315.5834220825, 85576.57211714025, 89527.0, 76344.61827690827, 76685.0, 77715.0, 78494.21505784869, 78630.46162922682, 9694.56374463165, 10061.597536098474, 10101.797964040825, 10142.746431338981, 10183.185345172516, 48274.0, 48516.5148348512, 50124.74937625288, 50400.0, 50570.0, 67221.0, 67949.32050679627, 68444.0, 69938.0, 70885.6455717718, 13321.933390333374, 13510.662233444242, 13593.184408935496, 13842.238676872466, 13852.238126903118, 14938.850611494181, 15127.39490420415, 15167.848321517085, 15229.466968656045, 15512.0, 13283.867161328262, 13451.663708407368, 14105.365258563184, 14290.857091428952, 14485.420583176976, 11616.477258523219, 11903.226290291102, 11904.940475297568, 12495.93752031234, 13580.592582222549, 14199.787003194753, 14209.360578774187, 14337.928310358382, 14416.42334306616, 14973.251337433303, 9945.502724863873, 10070.8489372658, 10156.695299141038, 10290.485475726333, 10340.586376544854, 9878.135276291265, 10480.794708608608, 10680.145588353069, 11945.581904633644, 11982.281063135892], "value": 7581.13266040891, "unit": "score"}], "name": "dromaeo_css", "value": 7385.622126024605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 110.0, 110.0, 111.0, 111.0, 112.0, 110.0, 112.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 126.0, 137.0, 175.0, 110.0, 111.0, 88.0, 113.0, 159.0, 138.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 185.0, 181.0, 183.0, 186.0, 183.0, 185.0, 184.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 89.0, 59.0, 57.0, 56.0, 57.0, 72.0, 56.0], "value": 64.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 86.0, 70.0, 67.0, 68.0, 81.0, 52.0, 63.0, 88.0], "value": 73.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 84.0, 88.0, 121.0, 88.0, 84.0, 87.0, 83.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 93.0, 92.0, 93.0, 120.0, 151.0, 143.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 87.0, 86.0, 86.0, 84.0, 87.0, 84.0, 89.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 51.0, 54.0, 54.0, 57.0, 57.0, 55.0, 55.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 75.0, 80.0, 73.0, 70.0, 67.0, 68.0, 68.0, 69.0, 68.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 81.0, 82.0, 75.0, 82.0, 82.0, 81.0, 79.0, 85.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 125.0, 142.0, 142.0, 146.0, 132.0, 135.0, 174.0, 139.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 176.0, 162.0, 161.0, 163.0, 164.0, 161.0, 160.0, 160.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 81.0, 82.0, 62.0, 65.0, 63.0, 61.0, 63.0, 65.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1422.2, "alertThreshold": 2.0}]} 15:53:57 INFO - Return code: 0 15:53:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:53:57 INFO - # TBPL SUCCESS # 15:53:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:57 INFO - 2017-04-11 15:53:57.116 screenresolution[1904:10626] starting screenresolution argv=screenresolution get 15:53:57 INFO - 2017-04-11 15:53:57.119 screenresolution[1904:10626] Display 0: 1600x1200x32@60 15:53:57 INFO - 2017-04-11 15:53:57.125 screenresolution[1905:10629] starting screenresolution argv=screenresolution list 15:53:57 INFO - Available Modes on Display 0 15:53:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:57 INFO - Intel Iris: 15:53:57 INFO - Chipset Model: Intel Iris 15:53:57 INFO - Type: GPU 15:53:57 INFO - Bus: Built-In 15:53:57 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:57 INFO - Vendor: Intel (0x8086) 15:53:57 INFO - Device ID: 0x0a2e 15:53:57 INFO - Revision ID: 0x0009 15:53:57 INFO - Displays: 15:53:57 INFO - Display: 15:53:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:57 INFO - Display Serial Number: 1600x1200 60 15:53:57 INFO - Main Display: Yes 15:53:57 INFO - Mirror: Off 15:53:57 INFO - Online: Yes 15:53:57 INFO - Rotation: Supported 15:53:57 INFO - Return code: 0 15:53:57 INFO - Running post-action listener: _resource_record_post_action 15:53:57 INFO - [mozharness: 2017-04-11 22:53:57.360293Z] Finished run-tests step (success) 15:53:57 INFO - Running post-run listener: _resource_record_post_run 15:53:57 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 2060288; Write bytes: 420361728; Read time: 21; Write time: 1365 15:53:57 INFO - TinderboxPrint: CPU usage
53.5% 15:53:57 INFO - TinderboxPrint: I/O read bytes / time
2,060,288 / 21 15:53:57 INFO - TinderboxPrint: I/O write bytes / time
420,361,728 / 1,365 15:53:57 INFO - TinderboxPrint: CPU idle
2,213.1 (46.5%) 15:53:57 INFO - TinderboxPrint: CPU system
951.5 (20.0%) 15:53:57 INFO - TinderboxPrint: CPU user
1,597.2 (33.5%) 15:53:57 INFO - TinderboxPrint: Swap in / out
123,637,760 / 0 15:53:57 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 112583168; Write bytes: 115247104; Read time: 10212; Write time: 270 15:53:57 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 2060288; Write bytes: 295222784; Read time: 21; Write time: 1060 15:53:57 INFO - Running post-run listener: _upload_blobber_files 15:53:57 INFO - Blob upload gear active. 15:53:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:57 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 15:53:57 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'] 15:53:57 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 15:53:58 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:58 INFO - (blobuploader) - INFO - Done attempting. 15:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:53:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:59 INFO - (blobuploader) - INFO - Done attempting. 15:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:00 INFO - (blobuploader) - INFO - Done attempting. 15:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:03 INFO - (blobuploader) - INFO - Done attempting. 15:54:03 INFO - (blobuploader) - INFO - Iteration through files over. 15:54:03 INFO - Return code: 0 15:54:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:54:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:54:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e0c39dcfaeb832e3b47dd0a4403361bd36ab86cb2ca00f01b8ffbcbce6845ad9ce51e99db54505b9123000497e5295c3a14212f82a364c2eff15679838c382c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3c454dc4f09fc41ce46620cd038a3ee79f8ba02ca85a75fd48f7d715ea0f4dad06147c3be36c0ad0c591d902120972e317c5ae48325c3c0b84393065d0fc20f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a563140189486a476b123aa53d517d85b03357abe315b31a0135b8992eec20d8f8b45709fa4622587de9c3837e756d1df3c9f4fc750e1230a364a94b97a1bf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5ebba29033c022de176a5b014c842d8a57b7edb5bb36f1468cc7ae9708818d46bf7043383b1606c1be93aa760da86b269fc5da1c8f773d4de5a7bf7209f4fbb"} 15:54:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:54:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:54:03 INFO - Contents: 15:54:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e0c39dcfaeb832e3b47dd0a4403361bd36ab86cb2ca00f01b8ffbcbce6845ad9ce51e99db54505b9123000497e5295c3a14212f82a364c2eff15679838c382c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3c454dc4f09fc41ce46620cd038a3ee79f8ba02ca85a75fd48f7d715ea0f4dad06147c3be36c0ad0c591d902120972e317c5ae48325c3c0b84393065d0fc20f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a563140189486a476b123aa53d517d85b03357abe315b31a0135b8992eec20d8f8b45709fa4622587de9c3837e756d1df3c9f4fc750e1230a364a94b97a1bf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5ebba29033c022de176a5b014c842d8a57b7edb5bb36f1468cc7ae9708818d46bf7043383b1606c1be93aa760da86b269fc5da1c8f773d4de5a7bf7209f4fbb"} 15:54:03 INFO - Running post-run listener: copy_logs_to_upload_dir 15:54:03 INFO - Copying logs to upload dir... 15:54:03 INFO - mkdir: /builds/slave/test/build/upload/logs 15:54:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.222301 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-04-11 15:54:03.116649) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 15:54:03.120163) ========= 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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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/e0c39dcfaeb832e3b47dd0a4403361bd36ab86cb2ca00f01b8ffbcbce6845ad9ce51e99db54505b9123000497e5295c3a14212f82a364c2eff15679838c382c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3c454dc4f09fc41ce46620cd038a3ee79f8ba02ca85a75fd48f7d715ea0f4dad06147c3be36c0ad0c591d902120972e317c5ae48325c3c0b84393065d0fc20f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a563140189486a476b123aa53d517d85b03357abe315b31a0135b8992eec20d8f8b45709fa4622587de9c3837e756d1df3c9f4fc750e1230a364a94b97a1bf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5ebba29033c022de176a5b014c842d8a57b7edb5bb36f1468cc7ae9708818d46bf7043383b1606c1be93aa760da86b269fc5da1c8f773d4de5a7bf7209f4fbb"} build_url:https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/LaVhRhNhT_uwF8-Zm0tQag/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e0c39dcfaeb832e3b47dd0a4403361bd36ab86cb2ca00f01b8ffbcbce6845ad9ce51e99db54505b9123000497e5295c3a14212f82a364c2eff15679838c382c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3c454dc4f09fc41ce46620cd038a3ee79f8ba02ca85a75fd48f7d715ea0f4dad06147c3be36c0ad0c591d902120972e317c5ae48325c3c0b84393065d0fc20f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a563140189486a476b123aa53d517d85b03357abe315b31a0135b8992eec20d8f8b45709fa4622587de9c3837e756d1df3c9f4fc750e1230a364a94b97a1bf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5ebba29033c022de176a5b014c842d8a57b7edb5bb36f1468cc7ae9708818d46bf7043383b1606c1be93aa760da86b269fc5da1c8f773d4de5a7bf7209f4fbb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 15:54:03.156785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:54:03.157116) ========= 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.Fv25xtbgF1/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.Cu9nYtPHeI/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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.005283 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 15:54:03.206306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 15:54:03.206626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 15:54:03.206951) ========= ========= Total master_lag: 0.19 =========