builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0122 starttime: 1493168543.91 results: success (0) buildid: 20170425163425 builduid: ff4f33c4f9c0404e826307343053285f revision: 68fe3cab6553b08d23a2e6dbbfb63f1a0a54fff6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:23.908898) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:23.909380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:23.909682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:23.936528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:23.936935) ========= 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.xZ0jxfcYFC/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.VQfTijawxU/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-25 18:02:23-- 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% 161M=0s 2017-04-25 18:02:24 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142767 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:24.105054) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:24.105554) ========= 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.xZ0jxfcYFC/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.VQfTijawxU/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.021373 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:24.154825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 18:02:24.157893) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 68fe3cab6553b08d23a2e6dbbfb63f1a0a54fff6 --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 68fe3cab6553b08d23a2e6dbbfb63f1a0a54fff6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xZ0jxfcYFC/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.VQfTijawxU/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-25 18:02:24,251 truncating revision to first 12 chars 2017-04-25 18:02:24,251 Setting DEBUG logging. 2017-04-25 18:02:24,251 attempt 1/10 2017-04-25 18:02:24,251 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/68fe3cab6553?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 18:02:25,695 unpacking tar archive at: mozilla-beta-68fe3cab6553/testing/mozharness/ program finished with exit code 0 elapsedTime=1.688509 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 18:02:25.871446) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:25.871816) ========= script_repo_revision: 68fe3cab6553b08d23a2e6dbbfb63f1a0a54fff6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:25.872295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:25.872585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 18:02:25.893622) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-25 18:02:25.894075) ========= /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.xZ0jxfcYFC/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.VQfTijawxU/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:02:26 INFO - MultiFileLogger online at 20170425 18:02:26 in /builds/slave/test 18:02:26 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 18:02:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:02:26 INFO - {'append_to_log': False, 18:02:26 INFO - 'base_work_dir': '/builds/slave/test', 18:02:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:02:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:02:26 INFO - 'branch': 'Mozilla-Beta', 18:02:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:02:26 INFO - 'config_files': ('talos/mac_config.py',), 18:02:26 INFO - 'default_actions': ('clobber', 18:02:26 INFO - 'read-buildbot-config', 18:02:26 INFO - 'download-and-extract', 18:02:26 INFO - 'populate-webroot', 18:02:26 INFO - 'create-virtualenv', 18:02:26 INFO - 'install', 18:02:26 INFO - 'run-tests'), 18:02:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:02:26 INFO - 'download_minidump_stackwalk': True, 18:02:26 INFO - 'download_symbols': 'ondemand', 18:02:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:02:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:02:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:02:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:02:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:02:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:02:26 INFO - 'gecko_profile': False, 18:02:26 INFO - 'gecko_profile_interval': 0, 18:02:26 INFO - 'installer_path': 'installer.exe', 18:02:26 INFO - 'log_level': 'info', 18:02:26 INFO - 'log_name': 'talos', 18:02:26 INFO - 'log_to_console': True, 18:02:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:02:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:02:26 INFO - 'opt_config_files': (), 18:02:26 INFO - 'pip_index': False, 18:02:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:02:26 INFO - 'cmd': ('bash', 18:02:26 INFO - '-c', 18:02:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:02:26 INFO - 'enabled': True, 18:02:26 INFO - 'halt_on_failure': False, 18:02:26 INFO - 'name': 'check_screen_resolution'},), 18:02:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:02:26 INFO - 'cmd': ('bash', 18:02:26 INFO - '-c', 18:02:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:02:26 INFO - 'enabled': True, 18:02:26 INFO - 'halt_on_failure': False, 18:02:26 INFO - 'name': 'check_screen_resolution'},), 18:02:26 INFO - 'run_cmd_checks_enabled': True, 18:02:26 INFO - 'suite': 'dromaeojs', 18:02:26 INFO - 'system_bits': '32', 18:02:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:02:26 INFO - 'title': 't-yosemite-r7-0122', 18:02:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:02:26 INFO - 'use_talos_json': True, 18:02:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:02:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:02:26 INFO - 'work_dir': 'build'} 18:02:26 INFO - [mozharness: 2017-04-26 01:02:26.116534Z] Running clobber step. 18:02:26 INFO - Running pre-action listener: _resource_record_pre_action 18:02:26 INFO - Running main action method: clobber 18:02:26 INFO - rmtree: /builds/slave/test/build 18:02:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:02:28 INFO - Running post-action listener: _resource_record_post_action 18:02:28 INFO - [mozharness: 2017-04-26 01:02:28.170899Z] Finished clobber step (success) 18:02:28 INFO - [mozharness: 2017-04-26 01:02:28.171027Z] Running read-buildbot-config step. 18:02:28 INFO - Running pre-action listener: _resource_record_pre_action 18:02:28 INFO - Running main action method: read_buildbot_config 18:02:28 INFO - Using buildbot properties: 18:02:28 INFO - { 18:02:28 INFO - "project": "", 18:02:28 INFO - "product": "firefox", 18:02:28 INFO - "script_repo_revision": "production", 18:02:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 18:02:28 INFO - "repository": "", 18:02:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 18:02:28 INFO - "buildid": "20170425163425", 18:02:28 INFO - "pgo_build": "False", 18:02:28 INFO - "basedir": "/builds/slave/test", 18:02:28 INFO - "buildnumber": 12, 18:02:28 INFO - "slavename": "t-yosemite-r7-0122", 18:02:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:02:28 INFO - "platform": "yosemite_r7", 18:02:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 18:02:28 INFO - "branch": "mozilla-beta", 18:02:28 INFO - "repo_path": "releases/mozilla-beta", 18:02:28 INFO - "revision": "68fe3cab6553b08d23a2e6dbbfb63f1a0a54fff6", 18:02:28 INFO - "stage_platform": "macosx64", 18:02:28 INFO - "builduid": "ff4f33c4f9c0404e826307343053285f", 18:02:28 INFO - "slavebuilddir": "test" 18:02:28 INFO - } 18:02:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 18:02:28 INFO - Running post-action listener: _resource_record_post_action 18:02:28 INFO - [mozharness: 2017-04-26 01:02:28.174411Z] Finished read-buildbot-config step (success) 18:02:28 INFO - [mozharness: 2017-04-26 01:02:28.174542Z] Running download-and-extract step. 18:02:28 INFO - Running pre-action listener: _resource_record_pre_action 18:02:28 INFO - Running main action method: download_and_extract 18:02:28 INFO - mkdir: /builds/slave/test/build/tests 18:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:02:28 INFO - trying https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 18:02:28 INFO - Downloading https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 18:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 18:02:29 INFO - Downloaded 1165 bytes. 18:02:29 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 18:02:29 INFO - Using the following test package requirements: 18:02:29 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 18:02:29 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:02:29 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 18:02:29 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:02:29 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 18:02:29 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 18:02:29 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:02:29 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 18:02:29 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 18:02:29 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:02:29 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 18:02:29 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:02:29 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 18:02:29 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:02:29 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 18:02:29 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:02:29 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 18:02:29 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 18:02:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 18:02:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 18:02:29 INFO - Fetch https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 18:02:30 INFO - Expected file size: 51223550 18:02:30 INFO - Obtained file size: 51223550 18:02:46 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 18:02:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 18:02:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 18:02:46 INFO - Fetch https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 18:02:48 INFO - Expected file size: 51223550 18:02:48 INFO - Obtained file size: 51223550 18:03:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 18:03:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 18:03:04 INFO - Fetch https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 18:03:05 INFO - Expected file size: 14404449 18:03:05 INFO - Obtained file size: 14404449 18:03: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')]} 18:03:05 INFO - trying https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 18:03:05 INFO - Downloading https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 18:03:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 18:03:07 INFO - Downloaded 59531849 bytes. 18:03:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 18:03:07 INFO - mkdir: /builds/slave/test/properties 18:03:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:03:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:03:07 INFO - Contents: 18:03:07 INFO - build_url:https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 18:03:07 INFO - Running post-action listener: _resource_record_post_action 18:03:07 INFO - Running post-action listener: set_extra_try_arguments 18:03:07 INFO - [mozharness: 2017-04-26 01:03:07.744066Z] Finished download-and-extract step (success) 18:03:07 INFO - [mozharness: 2017-04-26 01:03:07.744221Z] Running populate-webroot step. 18:03:07 INFO - Running pre-action listener: _resource_record_pre_action 18:03:07 INFO - Running main action method: populate_webroot 18:03:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:03:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:03:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:03:07 INFO - '--tppagecycles', 18:03:07 INFO - '7'], 18:03:07 INFO - 'tests': ['tsvgm']}}, 18:03:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:03:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:03:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:03:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:03:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:03:07 INFO - 'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:03:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:03:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:03:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:03:07 INFO - 'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['damp', 'tps']}, 18:03:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:03:07 INFO - 'tests': ['damp', 'tps']}, 18:03:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['dromaeo_dom']}, 18:03:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:03:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['basic_compositor_video']}, 18:03:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:03:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['a11yr', 18:03:07 INFO - 'ts_paint', 18:03:07 INFO - 'tpaint', 18:03:07 INFO - 'sessionrestore', 18:03:07 INFO - 'sessionrestore_no_auto_restore', 18:03:07 INFO - 'tabpaint']}, 18:03:07 INFO - 'other-e10s': {'tests': ['a11yr', 18:03:07 INFO - 'ts_paint', 18:03:07 INFO - 'tpaint', 18:03:07 INFO - 'sessionrestore', 18:03:07 INFO - 'sessionrestore_no_auto_restore', 18:03:07 INFO - 'tabpaint']}, 18:03:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:03:07 INFO - 'ts_paint', 18:03:07 INFO - 'tpaint', 18:03:07 INFO - 'sessionrestore', 18:03:07 INFO - 'sessionrestore_no_auto_restore', 18:03:07 INFO - 'tabpaint']}, 18:03:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:03:07 INFO - 'ts_paint', 18:03:07 INFO - 'tpaint', 18:03:07 INFO - 'sessionrestore', 18:03:07 INFO - 'sessionrestore_no_auto_restore', 18:03:07 INFO - 'tabpaint']}, 18:03:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['a11yr', 18:03:07 INFO - 'ts_paint', 18:03:07 INFO - 'tpaint', 18:03:07 INFO - 'sessionrestore', 18:03:07 INFO - 'sessionrestore_no_auto_restore', 18:03:07 INFO - 'tabpaint']}, 18:03:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['a11yr', 18:03:07 INFO - 'ts_paint', 18:03:07 INFO - 'tpaint', 18:03:07 INFO - 'sessionrestore', 18:03:07 INFO - 'sessionrestore_no_auto_restore', 18:03:07 INFO - 'tabpaint']}, 18:03:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['tsvgx', 18:03:07 INFO - 'tsvgr_opacity', 18:03:07 INFO - 'tart', 18:03:07 INFO - 'tscrollx', 18:03:07 INFO - 'cart', 18:03:07 INFO - 'tsvg_static']}, 18:03:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:03:07 INFO - 'tsvgr_opacity', 18:03:07 INFO - 'tart', 18:03:07 INFO - 'tscrollx', 18:03:07 INFO - 'cart', 18:03:07 INFO - 'tsvg_static']}, 18:03:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:03:07 INFO - 'talos_options': ['--disable-e10s'], 18:03:07 INFO - 'tests': ['tp5o']}, 18:03:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:03:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:03:07 INFO - 'talos_options': ['--disable-e10s', 18:03:07 INFO - '--xperf_path', 18:03:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:03:07 INFO - 'tests': ['tp5n']}, 18:03:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:03:07 INFO - 'talos_options': ['--xperf_path', 18:03:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:03:07 INFO - 'tests': ['tp5n']}}, 18:03:07 INFO - 'talos.zip': {'path': '', 18:03:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:03:07 INFO - Running post-action listener: _resource_record_post_action 18:03:07 INFO - [mozharness: 2017-04-26 01:03:07.764276Z] Finished populate-webroot step (success) 18:03:07 INFO - [mozharness: 2017-04-26 01:03:07.764401Z] Running create-virtualenv step. 18:03:07 INFO - Running pre-action listener: _resource_record_pre_action 18:03:07 INFO - Running main action method: create_virtualenv 18:03:07 INFO - Creating virtualenv /builds/slave/test/build/venv 18:03:07 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 18:03:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:03:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:03:07 INFO - Using real prefix '/tools/python27' 18:03:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:03:08 INFO - Installing distribute.............................................................................................................................................................................................done. 18:03:11 INFO - Installing pip.................done. 18:03:11 INFO - Return code: 0 18:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:03:11 INFO - Reading from file tmpfile_stdout 18:03:11 INFO - Output received: 18:03:11 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) 18:03:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:11 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:11 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 18:03:11 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 18:03:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:11 INFO - 'HOME': '/Users/cltbld', 18:03:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:11 INFO - 'LOGNAME': 'cltbld', 18:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:11 INFO - 'MOZ_NO_REMOTE': '1', 18:03:11 INFO - 'NO_EM_RESTART': '1', 18:03:11 INFO - 'PAGER': '/bin/cat', 18:03:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:11 INFO - 'PWD': '/builds/slave/test', 18:03:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:11 INFO - 'SHELL': '/bin/bash', 18:03:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:11 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:11 INFO - 'USER': 'cltbld', 18:03:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:11 INFO - 'XPC_FLAGS': '0x0', 18:03:11 INFO - 'XPC_SERVICE_NAME': '0', 18:03:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:11 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 18:03:11 INFO - Cleaning up... 18:03:11 INFO - Return code: 0 18:03:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:12 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:12 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 18:03:12 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 18:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:12 INFO - 'HOME': '/Users/cltbld', 18:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:12 INFO - 'LOGNAME': 'cltbld', 18:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:12 INFO - 'MOZ_NO_REMOTE': '1', 18:03:12 INFO - 'NO_EM_RESTART': '1', 18:03:12 INFO - 'PAGER': '/bin/cat', 18:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:12 INFO - 'PWD': '/builds/slave/test', 18:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:12 INFO - 'SHELL': '/bin/bash', 18:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:12 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:12 INFO - 'USER': 'cltbld', 18:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:12 INFO - 'XPC_FLAGS': '0x0', 18:03:12 INFO - 'XPC_SERVICE_NAME': '0', 18:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:12 INFO - Downloading/unpacking psutil>=3.1.1 18:03:12 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 18:03:12 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 18:03:12 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 18:03:12 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 18:03:12 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 18:03:12 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 18:03:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:03:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:03:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:03:15 INFO - Installing collected packages: psutil 18:03:15 INFO - Running setup.py install for psutil 18:03:15 INFO - building 'psutil._psutil_osx' extension 18:03:15 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 18:03:16 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 18:03:16 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 18:03:16 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 18:03:16 INFO - building 'psutil._psutil_posix' extension 18:03:16 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 18:03:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:03:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:03:16 INFO - ^ 18:03:16 INFO - 1 warning generated. 18:03:16 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 18:03:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:03:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:03:16 INFO - Successfully installed psutil 18:03:16 INFO - Cleaning up... 18:03:16 INFO - Return code: 0 18:03:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:03:16 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')]} 18:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:16 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')]} 18:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:16 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:16 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 18:03:16 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 18:03:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:16 INFO - 'HOME': '/Users/cltbld', 18:03:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:16 INFO - 'LOGNAME': 'cltbld', 18:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:16 INFO - 'MOZ_NO_REMOTE': '1', 18:03:16 INFO - 'NO_EM_RESTART': '1', 18:03:16 INFO - 'PAGER': '/bin/cat', 18:03:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:16 INFO - 'PWD': '/builds/slave/test', 18:03:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:16 INFO - 'SHELL': '/bin/bash', 18:03:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:16 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:16 INFO - 'USER': 'cltbld', 18:03:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:16 INFO - 'XPC_FLAGS': '0x0', 18:03:16 INFO - 'XPC_SERVICE_NAME': '0', 18:03:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:03:16 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 18:03:16 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 18:03:16 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 18:03:16 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 18:03:16 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 18:03:16 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 18:03:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:03:19 INFO - Installing collected packages: mozsystemmonitor 18:03:19 INFO - Running setup.py install for mozsystemmonitor 18:03:19 INFO - Successfully installed mozsystemmonitor 18:03:19 INFO - Cleaning up... 18:03:19 INFO - Return code: 0 18:03:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:20 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')]} 18:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:20 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:20 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 18:03:20 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 18:03:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:20 INFO - 'HOME': '/Users/cltbld', 18:03:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:20 INFO - 'LOGNAME': 'cltbld', 18:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:20 INFO - 'MOZ_NO_REMOTE': '1', 18:03:20 INFO - 'NO_EM_RESTART': '1', 18:03:20 INFO - 'PAGER': '/bin/cat', 18:03:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:20 INFO - 'PWD': '/builds/slave/test', 18:03:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:20 INFO - 'SHELL': '/bin/bash', 18:03:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:20 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:20 INFO - 'USER': 'cltbld', 18:03:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:20 INFO - 'XPC_FLAGS': '0x0', 18:03:20 INFO - 'XPC_SERVICE_NAME': '0', 18:03:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:21 INFO - Downloading/unpacking jsonschema==2.5.1 18:03:21 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 18:03:21 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 18:03:21 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 18:03:21 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 18:03:21 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 18:03:21 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 18:03:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:03:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:03:24 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 18:03:24 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 18:03:24 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 18:03:24 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 18:03:24 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 18:03:24 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 18:03:24 INFO - Downloading functools32-3.2.3-2.tar.gz 18:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:03:24 INFO - warning: no files found matching '*.txt' 18:03:24 INFO - no previously-included directories found matching 'build' 18:03:24 INFO - no previously-included directories found matching 'dist' 18:03:24 INFO - no previously-included directories found matching '.git*' 18:03:24 INFO - Installing collected packages: jsonschema, functools32 18:03:24 INFO - Running setup.py install for functools32 18:03:24 INFO - warning: no files found matching '*.txt' 18:03:24 INFO - no previously-included directories found matching 'build' 18:03:24 INFO - no previously-included directories found matching 'dist' 18:03:24 INFO - no previously-included directories found matching '.git*' 18:03:24 INFO - Successfully installed jsonschema functools32 18:03:24 INFO - Cleaning up... 18:03:24 INFO - Return code: 0 18:03:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:03:24 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')]} 18:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:24 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')]} 18:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:24 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:24 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 18:03:24 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 18:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:24 INFO - 'HOME': '/Users/cltbld', 18:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:24 INFO - 'LOGNAME': 'cltbld', 18:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:24 INFO - 'MOZ_NO_REMOTE': '1', 18:03:24 INFO - 'NO_EM_RESTART': '1', 18:03:24 INFO - 'PAGER': '/bin/cat', 18:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:24 INFO - 'PWD': '/builds/slave/test', 18:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:24 INFO - 'SHELL': '/bin/bash', 18:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:24 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:24 INFO - 'USER': 'cltbld', 18:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:24 INFO - 'XPC_FLAGS': '0x0', 18:03:24 INFO - 'XPC_SERVICE_NAME': '0', 18:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:03:25 INFO - Cleaning up... 18:03:25 INFO - Return code: 0 18:03:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:03:25 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')]} 18:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:25 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')]} 18:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:25 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:25 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 18:03:25 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 18:03:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:25 INFO - 'HOME': '/Users/cltbld', 18:03:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:25 INFO - 'LOGNAME': 'cltbld', 18:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:25 INFO - 'MOZ_NO_REMOTE': '1', 18:03:25 INFO - 'NO_EM_RESTART': '1', 18:03:25 INFO - 'PAGER': '/bin/cat', 18:03:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:25 INFO - 'PWD': '/builds/slave/test', 18:03:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:25 INFO - 'SHELL': '/bin/bash', 18:03:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:25 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:25 INFO - 'USER': 'cltbld', 18:03:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:25 INFO - 'XPC_FLAGS': '0x0', 18:03:25 INFO - 'XPC_SERVICE_NAME': '0', 18:03:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:25 INFO - Downloading/unpacking blobuploader==1.2.4 18:03:25 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 18:03:25 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 18:03:25 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 18:03:25 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 18:03:25 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 18:03:25 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 18:03:28 INFO - Downloading blobuploader-1.2.4.tar.gz 18:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:03:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:03:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:29 INFO - Downloading docopt-0.6.1.tar.gz 18:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:03:29 INFO - Installing collected packages: blobuploader, requests, docopt 18:03:29 INFO - Running setup.py install for blobuploader 18:03:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:03:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:03:29 INFO - Running setup.py install for requests 18:03:30 INFO - Running setup.py install for docopt 18:03:30 INFO - Successfully installed blobuploader requests docopt 18:03:30 INFO - Cleaning up... 18:03:30 INFO - Return code: 0 18:03:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:30 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:30 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 18:03:30 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 18:03:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:30 INFO - 'HOME': '/Users/cltbld', 18:03:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:30 INFO - 'LOGNAME': 'cltbld', 18:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:30 INFO - 'MOZ_NO_REMOTE': '1', 18:03:30 INFO - 'NO_EM_RESTART': '1', 18:03:30 INFO - 'PAGER': '/bin/cat', 18:03:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:30 INFO - 'PWD': '/builds/slave/test', 18:03:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:30 INFO - 'SHELL': '/bin/bash', 18:03:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:30 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:30 INFO - 'USER': 'cltbld', 18:03:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:30 INFO - 'XPC_FLAGS': '0x0', 18:03:30 INFO - 'XPC_SERVICE_NAME': '0', 18:03:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:03:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-XfV4R4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:03:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-B5Mwvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:03:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-cGAyqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:03:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-2RaECB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:03:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-mQVYPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-eyj7jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-LIFqSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-qC0dTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-XPK7cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-A_VuJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-se1qgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-O9K0Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-lQUnSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:03:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-QKrsJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:32 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Nma_Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:03:32 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-KFZMd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:03:32 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-xh3CgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:03:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:03:32 INFO - Running setup.py install for manifestparser 18:03:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:03:32 INFO - Running setup.py install for mozcrash 18:03:32 INFO - Running setup.py install for mozdebug 18:03:32 INFO - Running setup.py install for mozdevice 18:03:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:03:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:03:32 INFO - Running setup.py install for mozfile 18:03:33 INFO - Running setup.py install for mozhttpd 18:03:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:03:33 INFO - Running setup.py install for mozinfo 18:03:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:03:33 INFO - Running setup.py install for mozInstall 18:03:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:03:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:03:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:03:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:03:33 INFO - Running setup.py install for mozleak 18:03:33 INFO - Running setup.py install for mozlog 18:03:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:03:33 INFO - Running setup.py install for moznetwork 18:03:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:03:33 INFO - Running setup.py install for mozprocess 18:03:34 INFO - Running setup.py install for mozprofile 18:03:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:03:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:03:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:03:34 INFO - Running setup.py install for mozrunner 18:03:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:03:34 INFO - Running setup.py install for mozscreenshot 18:03:34 INFO - Running setup.py install for moztest 18:03:34 INFO - Running setup.py install for mozversion 18:03:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:03:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:03:34 INFO - Cleaning up... 18:03:34 INFO - Return code: 0 18:03:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:34 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:34 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 18:03:34 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 18:03:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:34 INFO - 'HOME': '/Users/cltbld', 18:03:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:34 INFO - 'LOGNAME': 'cltbld', 18:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:34 INFO - 'MOZ_NO_REMOTE': '1', 18:03:34 INFO - 'NO_EM_RESTART': '1', 18:03:34 INFO - 'PAGER': '/bin/cat', 18:03:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:34 INFO - 'PWD': '/builds/slave/test', 18:03:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:34 INFO - 'SHELL': '/bin/bash', 18:03:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:34 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:34 INFO - 'USER': 'cltbld', 18:03:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:34 INFO - 'XPC_FLAGS': '0x0', 18:03:34 INFO - 'XPC_SERVICE_NAME': '0', 18:03:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:03:35 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-apQaTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:03:35 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)) 18:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:03:35 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-xYnKZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:03:35 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)) 18:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:03:35 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-8GTiLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:03:35 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)) 18:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:03:35 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-rlcqSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:03:35 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)) 18:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:03:35 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-LXT1M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:03:35 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)) 18:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:03:35 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Eyei7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:03:35 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)) 18:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:03:35 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-SwmZje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:03:35 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)) 18:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:03:35 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-_Uhx4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:03:36 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)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-S2VRaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:03:36 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)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-55mukd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:03:36 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)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-1yb5ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:03:36 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)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-b9DPEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-fa5puv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:03:36 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)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-OOWTAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:03:36 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)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Sv_nNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:03:36 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)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-M1ltml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:03:36 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)) 18:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:03:36 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-M2SwvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:03:36 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)) 18:03:36 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)) 18:03:36 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)) 18:03:36 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)) 18:03:36 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)) 18:03:36 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)) 18:03:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:39 INFO - Downloading blessings-1.6.tar.gz 18:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:03:39 INFO - Installing collected packages: blessings 18:03:39 INFO - Running setup.py install for blessings 18:03:39 INFO - Successfully installed blessings 18:03:39 INFO - Cleaning up... 18:03:39 INFO - Return code: 0 18:03:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:03:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:03:40 INFO - Reading from file tmpfile_stdout 18:03:40 INFO - Current package versions: 18:03:40 INFO - blessings == 1.6 18:03:40 INFO - blobuploader == 1.2.4 18:03:40 INFO - docopt == 0.6.1 18:03:40 INFO - functools32 == 3.2.3-2 18:03:40 INFO - jsonschema == 2.5.1 18:03:40 INFO - manifestparser == 1.1 18:03:40 INFO - mozInstall == 1.12 18:03:40 INFO - mozcrash == 1.0 18:03:40 INFO - mozdebug == 0.1 18:03:40 INFO - mozdevice == 0.49 18:03:40 INFO - mozfile == 1.2 18:03:40 INFO - mozhttpd == 0.7 18:03:40 INFO - mozinfo == 0.9 18:03:40 INFO - mozleak == 0.1 18:03:40 INFO - mozlog == 3.4 18:03:40 INFO - moznetwork == 0.27 18:03:40 INFO - mozprocess == 0.25 18:03:40 INFO - mozprofile == 0.28 18:03:40 INFO - mozrunner == 6.13 18:03:40 INFO - mozscreenshot == 0.1 18:03:40 INFO - mozsystemmonitor == 0.3 18:03:40 INFO - moztest == 0.8 18:03:40 INFO - mozversion == 1.4 18:03:40 INFO - psutil == 3.1.1 18:03:40 INFO - requests == 1.2.3 18:03:40 INFO - wsgiref == 0.1.2 18:03:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:40 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:40 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 18:03:40 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 18:03:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:40 INFO - 'HOME': '/Users/cltbld', 18:03:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:40 INFO - 'LOGNAME': 'cltbld', 18:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:40 INFO - 'MOZ_NO_REMOTE': '1', 18:03:40 INFO - 'NO_EM_RESTART': '1', 18:03:40 INFO - 'PAGER': '/bin/cat', 18:03:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:40 INFO - 'PWD': '/builds/slave/test', 18:03:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:40 INFO - 'SHELL': '/bin/bash', 18:03:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:40 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:40 INFO - 'USER': 'cltbld', 18:03:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:40 INFO - 'XPC_FLAGS': '0x0', 18:03:40 INFO - 'XPC_SERVICE_NAME': '0', 18:03:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 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)) 18:03:40 INFO - Cleaning up... 18:03:40 INFO - Return code: 0 18:03:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:40 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 0x108638b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10863b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9000cd1af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, '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.xZ0jxfcYFC/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.VQfTijawxU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 18:03:40 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 18:03:40 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 18:03:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:40 INFO - 'HOME': '/Users/cltbld', 18:03:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:40 INFO - 'LOGNAME': 'cltbld', 18:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:40 INFO - 'MOZ_NO_REMOTE': '1', 18:03:40 INFO - 'NO_EM_RESTART': '1', 18:03:40 INFO - 'PAGER': '/bin/cat', 18:03:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:40 INFO - 'PWD': '/builds/slave/test', 18:03:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:40 INFO - 'SHELL': '/bin/bash', 18:03:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:40 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:40 INFO - 'USER': 'cltbld', 18:03:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:40 INFO - 'XPC_FLAGS': '0x0', 18:03:40 INFO - 'XPC_SERVICE_NAME': '0', 18:03:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:03:40 INFO - Cleaning up... 18:03:40 INFO - Return code: 0 18:03:40 INFO - Running post-action listener: _resource_record_post_action 18:03:40 INFO - Running post-action listener: _start_resource_monitoring 18:03:40 INFO - Starting resource monitoring. 18:03:40 INFO - [mozharness: 2017-04-26 01:03:40.823430Z] Finished create-virtualenv step (success) 18:03:40 INFO - [mozharness: 2017-04-26 01:03:40.824386Z] Running install step. 18:03:40 INFO - Running pre-action listener: _resource_record_pre_action 18:03:40 INFO - Running main action method: install 18:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:03:41 INFO - Reading from file tmpfile_stdout 18:03:41 INFO - Detecting whether we're running mozinstall >=1.0... 18:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:03:41 INFO - Reading from file tmpfile_stdout 18:03:41 INFO - Output received: 18:03:41 INFO - Usage: mozinstall [options] installer 18:03:41 INFO - Options: 18:03:41 INFO - -h, --help show this help message and exit 18:03:41 INFO - -d DEST, --destination=DEST 18:03:41 INFO - Directory to install application into. [default: 18:03:41 INFO - "/builds/slave/test"] 18:03:41 INFO - --app=APP Application being installed. [default: firefox] 18:03:41 INFO - mkdir: /builds/slave/test/build/application 18:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 18:03:55 INFO - Reading from file tmpfile_stdout 18:03:55 INFO - Output received: 18:03:55 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 18:03:55 INFO - Running post-action listener: _resource_record_post_action 18:03:55 INFO - [mozharness: 2017-04-26 01:03:55.924952Z] Finished install step (success) 18:03:55 INFO - [mozharness: 2017-04-26 01:03:55.925087Z] Running run-tests step. 18:03:55 INFO - Running pre-action listener: _resource_record_pre_action 18:03:55 INFO - Running main action method: run_tests 18:03:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:03:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:03:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:03:55 INFO - 2017-04-25 18:03:55.940 screenresolution[1990:15943] starting screenresolution argv=screenresolution get 18:03:55 INFO - 2017-04-25 18:03:55.942 screenresolution[1990:15943] Display 0: 1600x1200x32@60 18:03:55 INFO - 2017-04-25 18:03:55.948 screenresolution[1991:15945] starting screenresolution argv=screenresolution list 18:03:55 INFO - Available Modes on Display 0 18:03:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:03:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:03:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:03:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:03:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:03:56 INFO - Intel Iris: 18:03:56 INFO - Chipset Model: Intel Iris 18:03:56 INFO - Type: GPU 18:03:56 INFO - Bus: Built-In 18:03:56 INFO - VRAM (Dynamic, Max): 1536 MB 18:03:56 INFO - Vendor: Intel (0x8086) 18:03:56 INFO - Device ID: 0x0a2e 18:03:56 INFO - Revision ID: 0x0009 18:03:56 INFO - Displays: 18:03:56 INFO - Display: 18:03:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:03:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:03:56 INFO - Display Serial Number: 1600x1200 60 18:03:56 INFO - Main Display: Yes 18:03:56 INFO - Mirror: Off 18:03:56 INFO - Online: Yes 18:03:56 INFO - Rotation: Supported 18:03:56 INFO - Return code: 0 18:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:03:56 INFO - Python 2.7.3 18:03:56 INFO - Return code: 0 18:03:56 INFO - grabbing minidump binary from tooltool 18:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:56 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 0x108416d30>, '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 0x10833ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10840bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:03:56 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 18:03:56 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 18:03:56 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 18:03:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:03:56 INFO - Return code: 0 18:03:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:03:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:03:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:03:56 INFO - ENV: RUST_BACKTRACE is now 1 18:03:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:03:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:03:56 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/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--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 18:03:56 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/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0122 --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 18:03:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZ0jxfcYFC/Render', 18:03:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:56 INFO - 'HOME': '/Users/cltbld', 18:03:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:56 INFO - 'LOGNAME': 'cltbld', 18:03:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:03:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:56 INFO - 'MOZ_NO_REMOTE': '1', 18:03:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:03:56 INFO - 'NO_EM_RESTART': '1', 18:03:56 INFO - 'PAGER': '/bin/cat', 18:03:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:56 INFO - 'PWD': '/builds/slave/test', 18:03:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:03:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:56 INFO - 'RUST_BACKTRACE': '1', 18:03:56 INFO - 'SHELL': '/bin/bash', 18:03:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VQfTijawxU/Listeners', 18:03:56 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 18:03:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:56 INFO - 'USER': 'cltbld', 18:03:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:56 INFO - 'XPC_FLAGS': '0x0', 18:03:56 INFO - 'XPC_SERVICE_NAME': '0', 18:03:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:56 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/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--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 18:03:56 INFO - mozversion application_buildid: 20170425163425 18:03:56 INFO - mozversion application_changeset: 68fe3cab6553b08d23a2e6dbbfb63f1a0a54fff6 18:03:56 INFO - mozversion application_display_name: Firefox 18:03:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:03:56 INFO - mozversion application_name: Firefox 18:03:56 INFO - mozversion application_remotingname: firefox 18:03:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:03:56 INFO - mozversion application_vendor: Mozilla 18:03:56 INFO - mozversion application_version: 54.0 18:03:56 INFO - mozversion platform_buildid: 20170425163425 18:03:56 INFO - mozversion platform_changeset: 68fe3cab6553b08d23a2e6dbbfb63f1a0a54fff6 18:03:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:03:56 INFO - mozversion platform_version: 54.0 18:03:56 INFO - using testdate: 1493168636 18:03:56 INFO - actual date: 1493168636 18:03:56 INFO - starting webserver on 'localhost:49540' 18:03:56 INFO - SUITE-START | Running 2 tests 18:03:56 INFO - TEST-START | dromaeo_css 18:03:56 INFO - operating with platform_type : mac_ 18:03:56 INFO - Initialising browser for dromaeo_css test... 18:03:56 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpH3keVc/profile http://localhost:49540/getInfo.html) 18:03:58 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 18:03:58 INFO - PROCESS | 2001 | colorDepth:24 18:03:58 INFO - PROCESS | 2001 | Browser inner width/height: 1024/689 18:03:58 INFO - PROCESS | 2001 | __metrics 18:03:58 INFO - PROCESS | 2001 | 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" 18:03:58 INFO - PROCESS | 2001 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:03:59 INFO - TEST-INFO | 2001: exit 0 18:03:59 INFO - Browser initialized. 18:03:59 INFO - Running cycle 1/1 for dromaeo_css test... 18:03:59 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpH3keVc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:04:11 INFO - PROCESS | 2004 | RSS: Main: 169361408 18:04:11 INFO - PROCESS | 2004 | 18:07:15 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49540/tests/dromaeo/cssquery-ext.html) 18:07:17 INFO - PROCESS | 2004 | RSS: Main: 342728704 18:07:17 INFO - PROCESS | 2004 | 18:10:20 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-ext.html (next: http://localhost:49540/tests/dromaeo/cssquery-jquery.html) 18:10:20 INFO - PROCESS | 2004 | RSS: Main: 304926720 18:10:20 INFO - PROCESS | 2004 | 18:13:23 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49540/tests/dromaeo/cssquery-mootools.html) 18:13:23 INFO - PROCESS | 2004 | RSS: Main: 296423424 18:13:23 INFO - PROCESS | 2004 | 18:16:26 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49540/tests/dromaeo/cssquery-prototype.html) 18:16:26 INFO - PROCESS | 2004 | RSS: Main: 283824128 18:16:26 INFO - PROCESS | 2004 | 18:19:30 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49540/tests/dromaeo/cssquery-yui.html) 18:19:30 INFO - PROCESS | 2004 | RSS: Main: 268443648 18:19:30 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-yui.html (next: http://localhost:49540/tests/dromaeo/cssquery-dojo.html) 18:22:34 INFO - PROCESS | 2004 | RSS: Main: 329814016 18:22:34 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | __start_tp_report 18:22:34 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 18:22:34 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 18:22:34 INFO - PROCESS | 2004 | |i|pagename|runs| 18:22:34 INFO - PROCESS | 2004 | |0;dojo.html;2978.3298757779503;3505.3690335739566;3517.103138699631;3519.0850378901478;3558.6619271169247;6073.864879377891;6119.99004232014;6126.02013091576;6126.314740042873;6143.2628084629905;4911.877203069925;6124.479419249358;6134.877302453949;6144.784932527363;6149.754009839612;5406.621536492457;5432.456754324556;5441.700706461143;5446.891062178754;5560.888782224353;5324.148136298193;5330.840074797743;5343.7328133593355;5536.058869992111;5545.694986775726;5399.1091469907415;5413.404525502211;5419.59353048521;5420.756065977021;5423.457654234585;5400.351957765054;5458.344998600193;5504.422035686235;5536.280283563151;5537.418571050022;4255.3829694694095;5334.3598768147685;5441.59188060893;5441.619086663935;5443.319585051869;6171.382861713838;6197.659128747917;6205.5345849061505;6207.751689932397;6217.595856269328;6219.564630475868;6246.531510136712;6313.558050936436;6407.391297826699;6555.147830781968;6355.777547785805;6407.231132264112;6420.1974753155855;6428.485721142344;6433.613983160979;6218.191635087455;6263.123162757218;6267.467265282502;6275.780347687809;6286;6617.371349721769;6624.86750264992;6642.535022548375;6651.201855777241;6844.486663500257;6224.62652240867;6271.78048768291;6278.183836101278;6282.308946015934;6346.936530634634;6440.130582371414;6457.870842583122;6481.449076828428;6496.155499785093;6496.577722448026;6301.4328710416285;6433.839154021093;6440.066190402459;6442.710078046499;6450.967745161244;6218.533609979179;6272.435480806749;6287.937120628827;6420.711068001951;6447.516436267299;4793.9280910786365;4871.074495845778;4998.575121114746;5056.570191533688;5063.696178229245;4614.515475875052;4615.446146462379;4649.907001860011;4653.557911998355;4664.323673067386;6060;6140.570160088841;6186.969065154645;6203.658798766111;6207.037909124093;6237.688115594293;6497.64262965532;6529.7388104475285;6536.182977127859;6542.869142617216;6058.545609079337;6128.958077126899;6139.938600613937;6156.538259630545;6170;5687.51656109227;5691.971540142273;5693.572982026365;5714.142878568248;5715.971420142872;6670.999350097524;6681.498887583353;6684.064231007663;6704.296048914794;6726.831829204309;5327.840164795062;6179.443850053517;6257.186565746606;6320.399562041599;6327.588706734232;6671.566348187353;6690.431313338421;6698.062271282122;6698.162729658793;6698.497612678971;6389.393007664265;6393.520485963479;6398.456131228898;6404.423601875854;6405.743770249138;6137.662428566472;6192.318844927145;6343.143675603919;6468.094466774562;6488.805335839932;6234.064890266496;6249.78125765596;6350.714217860115;6352.650604216812;6371.171747672773;6329.367063293634;6329.8734025320155;6331.651759153291;6334.746610135543;6357.205349331333;6132.78535251264;6240.219972503437;6299.590526615755;6331.2085989251345;6339;6211.65835879031;6251.593646412968;6304;6340.048992651139;6344.96827515878;6280.654563999024;6286.151369565233;6293;6293.181886354744;6311.053341998737 18:22:34 INFO - PROCESS | 2004 | |1;ext.html;747.5215861848415;810.6392655268405;828.1180542722001;885.6855816185254;895.6686026170318;29222.26944326393;29607.851960740194;30562.847185764094;30704.69295307049;40160.995975100566;41530;41720.37419438711;41726.7913660432;41785.373219401736;41823.37264941028;9604.087611676898;9768.755781105458;9778.266630002743;9784.119429251366;9787.90212097877;7789.143194248628;7948.9602551987155;9623.133917947383;9718.951405242964;9733.367331123454;11550;11714.824277635842;11888.346140962243;11994.820077698841;12029.699257518545;9791.118799308026;9805.705828825146;11744.7651046979;11814.704632384217;11832.70418239551;11546.422678866107;11562.826557601642;11601.477933493014;11602.303861768321;11607.941960290229;39740.60259397398;39934;39991.40012899809;40045.39931901024;40106.799466002776;3976.1451287973223;4019.698522610816;4024.476818013669;4035.152617950234;4091.1204091120553;28133.85933070342;30240.395192096035;30311.24221894448;30375.848120759474;30410.54384184239;3123.453395655751;3197.536357228189;3206.6633003534757;3420.3330350581646;3426.109211604976;355015;355125;355385.669214962;355762;357214;53018;53204.66988325323;53239;53302.46697532975;53359.46640533545;54373.72813135909;54753.45246547563;54809.17786233209;54830;54949;15287.847121528643;15382.461613843461;15392.615184620474;15393.153376564396;15399.92200545951;13070.738585228242;13075.673108172372;13091.541796037092;13092.214467132002;13095.410706518229;10944.343339399662;11150.832737508943;11183.161262905152;11255.606053788078;12544;5384.865378365494;5565.30433695788;5594.790057927177;5600.243967064475;5604.187392828098;1119.1662211652208;1122.7810576937418;1128.2835399521364;1154.32648532462;1163.2962057954985;27692.16923492258;27693.913562144215;28137.296567585974;28172.01397951103;28333.716662833107;922.4280945813639;1088.3524303039678;1096.7916095941746;1140.4696815980442;1270.9046821488425;11503.654890353302;11877.277794719717;12706.682332941751;12786;12863;464293;465321;465940;466702;467170;38911;39221.41167882484;47356.52643473521;47544;50077.74961125171;1455.8471360507206;1500.7598784194477;1501.8573235542606;1513.2433783108445;1514.5532068040175;27042.729572704022;28496.69576245164;28570.14289571316;28907.42185156327;29001.854990725755;43639.781801090794;43802.12395752131;43895;43914;43974.99999999872;472735.6363218162;483643;489080;510464;516423;37853.728776273514;38929.6107038926;39702.40446393364;39739.40390894081;39986.400203997546;49168.50831491639;49171.298282727286;49846.75076624594;49857.75071124621;50466.73833154201;32886.177845554055;33076.503852441754;33078.338433231685;33175.33649327048;33943.83028084844;31169.8441507791;32888.67111328856;33471.16322091967;33822.83088584541;33935.98192054242;40427.39358909678;40476.78569642916;40524.79737601293;40667.59332406638;42155.789221054925;27653.58519622167;29133.7086629131;31020;33577;34609.30781384408;20763;25802.870985644953;26595.33511662224;26862;27176.864115680088 18:22:34 INFO - PROCESS | 2004 | |2;jquery.html;392.7584535510661;420.24146415719633;428;436.20392783170723;464.6399040743423;18383;19952.60094798103;21014.474638134034;22159.889200554015;22433;16976.236069376875;22756.997906747885;23717.407064823386;23915.64126538099;23918.684472354013;5938.940610593882;7152.821179470503;7210.603416812073;7221.927780722178;7246.963765181193;6693.933060669404;7075;7131.322524360177;7140.5001649884525;7155.642217889111;6886;6906.482013848957;7100.502964792467;7159.463040271974;7163;6504.089427480157;7058.85882282354;7102.786916392516;7107.395871350941;7139.9286007140045;5915.792947246869;6919.965400173017;6931.930680693179;6941.167059952788;6944.965275173592;24272.757272427403;25515.362115947064;26486.47027059448;27448.764805583796;27546.44907101847;2970.376220993594;3003.819770813758;3047.2686555226805;3050.206946193983;3066.9079927602206;14187.85812141886;15881.126538040404;16431.342746290135;16481.587960300967;16873;2046.7748547659746;2052.835773138145;2076.200662744839;2084.6768750843644;2118;98776;144514;156581;167199;173933.52132957397;16230.594235143979;18741.625167496575;20497.59004819925;20655.79344206569;20694.379168624964;32256.677433225366;32622;32704.83647581747;32735;32736.345273094405;10448.73878153037;10649.680509584725;10895.509702063426;10895.891041089646;11033;8994.370394072483;9002.369834111549;9022.548872556346;9166.312526560401;9197.586108624993;9549.809003820024;9637.951810240904;9670.178034866974;9762.414255144715;9785.657501987538;3800.5106655140926;4115.279826030433;4152.958470415318;4165.5009791775055;4173.561776013475;1065.4193464561677;1081.6700906223678;1093.3986307530986;1106.4025426269725;1127.5320741892187;21802.34592962182;22483.775162248166;23087.422814429774;23195.188168414363;23440.06239750425;1089.9455027248605;1090.8472813805915;1112.1547623805966;1123.3316176874746;1133.7505748735266;11341.886581134248;11700.829917008232;12075.939620302019;12094.818577721342;12113.939430302793;709301;784163;785550;790458.0477097578;807158;94121.5293923526;111619;133626;140473;173809.7499762532;1227.4967263422134;1241.7702724995725;1263.7914744067125;1268.7462507498537;1273.4842388832537;19704.310349138286;21076.473088172304;21183;21198.682019769407;21206.04572794259;64414.677926610064;64438;64743.67628162017;64816;64865.67567162134;89640.96615652442;90489.54755226182;91043;92993.53503232711;93122.603160954;11541.307521548733;11565.942170289094;11951.820722688994;12015.339156346485;12092.637220883387;13141.868581314448;13179.934100329438;13400.530981415604;13546.458141674617;13548.796768048684;11251.493682784458;11401.372924489233;11696.824547631963;11752.23610465317;11839.467223975114;10176.982301769764;10711.785764284827;10748.570057197938;10822.296550724177;11021.173411993972;9711.36876103051;11513.366764828015;11695.473703683185;11871.287722736319;11983.28100313984;11555.653330400102;11611.709707257387;11709.941450292694;11713.648590542298;11925.880741192477;11195.552177913118;11411.543538258376;11466.484008219817;11834.822477663014;11856.703582410164 18:22:34 INFO - PROCESS | 2004 | |3;mootools.html;1491.9481765355426;1576.2749135397717;1602.751573506107;1635.043499552762;1657.3701993242566;9808.215342772579;10988.615398461056;11676.941615291911;11687.649370518888;11691.356975366352;11143.554257829677;11551.13366497512;11807.11446641501;11810.7637847243;11856.051515878731;2458.4591389894194;2500.1374525788665;2500.174942269056;2501.874156629515;2507.7743003129713;2439.865807380593;2458.791002764767;2475.9133430329944;2482.391814005571;2484.304394769458;2447.229122826304;2461.889214985321;2468.7160976487753;2488.427661637815;2493.9750602493923;2416.927492175229;2423.9757602423924;2446.510697860435;2463.310273123528;2477.0834791127218;2422.91519796808;2440.365504968703;2451.240115564163;2452;2457.9676535854983;10050.396976181379;10057.145142662883;10064.849027264523;10066.245031622657;10074.546645400975;5960.701964901781;6128.938710612926;6132.969335153341;6137.447629713347;6141.416565426277;3609.5668519777532;3719.6652301292743;3766.0584853786554;3801.6768574671187;3826.1582451860545;1236.746466974268;1239.5723475401062;1260.0927332320714;1282.4100913579764;1296.0733075850717;13868.861311386858;14162.504312349121;14544.200068996306;15640;15697.058176509447;4496.4154659894;4654.674172807939;4731.432228132646;4920.581750551171;4930.580900623487;10269.7432564185;11964.282143071443;11986.101042421853;11987.400629968466;11993.820092698617;5125.692458452505;5822.505087067562;5945.316288626776;6035.758569657252;6043.516518678495;5363.865903352447;5490.505854473116;5532.2531458253425;5621.269234999424;5623.606347555714;3995.5604883462797;4019.8995025124023;4054.1486287879284;4092.570280120604;4110.7328023678365;1064.5475672839168;1068.7862427514528;1069.8127827630133;1084.143526613982;1086.7446150154708;950.1306304731231;952.9380590261611;961.7307153996892;971.1162841813915;1000.5997600959674;5618.634788738719;6594.10979517759;6622.2715501294815;6694.230163531256;6786.151731033621;979.329159525713;990.7451352634071;1016.0323935033705;1021.6526381030485;1022.7852151048214;4169.353750168729;4191.140816132746;4201.579842015774;4275.40144379787;4291.291936830388;13484.730305394034;14076.71846563063;14086;14097;14119.78820317696;13111.344432778515;13569.728605427836;13997.650058748613;14022.789658155136;14023.719525609431;10085.546150423248;10365.481725913674;10393.792124157626;10411.687649370531;10413.53139108742;6711.161104861892;6786.3892249697765;7073.752418665322;7080.752173673896;7118.074650295428;10915;11470.369129697947;12669.429875655802;12685.873141268468;12724.109312348417;12358.258504489759;12706.30115343665;12721.93639031799;12835.229886206858;12971.962243020724;9057.320700947323;9402.43585384879;9594.232461403211;9595.040495950629;9595.184409325006;10676.519556619816;10714.785704285714;10767.784644307227;10795;10804.027637512661;8560.657573697232;8716.38985271025;8784;8799.252063574668;8805.603747831236;7345.3021962913435;8559.786005349666;8593.097724738813;8665.610047547749;8676.479411235347;8140.348772098099;8338.791530211793;8342.290905272877;8342.666293348198;8372.539510326991;4994.450610432922;5975.970120149545;5986.700664966647;6176.413240742122;6208.689565521616;5415.6479828811;5978.192943952685;6039.939600603938;6161.383861613803;6247.5939063960695 18:22:34 INFO - PROCESS | 2004 | |4;prototype.html;368.3847973883614;382.7779887665154;383.6432118130138;386.8742658635943;393.55135145933633;4629.513901040393;5206.973965130173;5258.92111618326;5298.311219541464;5365.719569183101;4609.962758379363;4713.552212539812;4917.139500587401;5074.731317170707;5155.978336897217;4226.098255784894;4247.638950689196;4290.348215936863;4295.355696645497;4306.461692288464;4281.7002809803325;4296.591823776736;4299.763513006784;4316.568343165674;4330.935035974463;3474.513568100468;3837.846486140551;3841.635044670752;4271.881526485668;4285.228658841407;3635.72732045095;3920.529536455615;4212.6629869610515;4290.892727681801;4325.805338759764;3648.087978005499;3744.5319335083113;3918.3142949983926;3961.7028722845903;3986.006996501749;4214.883055990165;4417.955820441786;4771.856844294677;5068.847934561969;5143.537081662668;4087.3868919662286;4970.850874473772;4980.377452818398;4991.201407774739;5070.619703522214;4739.175417464301;5059.671121377099;5487.5884308677005;5500.80747173847;5513.7794488220425;4321.611055005064;4449.332600109977;4472.463304403493;4476.306172543228;4496.280595104768;4536.707038494013;4656.697314674535;5241.6674579812;5374.328208973879;5455.972720136414;4299.54854740254;4399.560043995575;4468.285074388083;4517.954820451819;4610.2623580227;4102.897427564335;4464.611432883392;4688.648351373592;4726.432828060655;4728.290756386501;3588.5693716753635;4365.519792822851;4780.041231349764;4846.273059041172;4934.777934992934;4931.827386041543;5434.864128396822;5459.372172200247;5463.945360546423;5465.836024919259;1555.401170549324;1568.3648122510401;1571.787808645841;1571.921403929799;1574.9370025199094;1078.8510236597997;1079.9568017279378;1170.4206417823061;1192.7256730951929;1207.2454715802623;5126.4617215191865;5159;5164.295782391801;5170.405403378584;5356.625036247503;5451.890962180734;5578.944210557924;5608.242887210256;5686.886262274731;5699.430056994267;4644;4773.522647735268;4943.6786608871025;5057.928367664066;5143.485651434901;2573.6654234949337;2613.529564678376;2639.6568446101883;2874.3820078683184;2910.359720861407;5152.105499775229;5585.609007369445;5637.56242158247;5896.262967129109;5899.793507227227;5144.897102057937;5323.9884421959705;5532.75102620383;5636.408177141341;5681.460261275172;5270.23581580661;5328.364323038903;5493.890122197614;5856.853578660568;5923.555733320019;4526.705764125321;4805.495422980676;5466.387415712295;5568.916466252928;5737.9139312911175;4850.636202284913;5460.2800117962715;5565.02612042899;5585.636933599466;5594.86012849682;5255.553277971415;5670.347909990239;5799.710014499343;5813.4828428799965;5930.614510056833;3976.0258736609717;4014.6386825185873;4168.91662166761;4188.832446702219;4461.933071003873;4912.067325139881;5009.023240468074;5744.712764361681;5761.942380576141;5798.623089499169;4761.190747515921;5185.948140518546;5191.935653191012;5510.768138903751;5567.972160139173;5037.5214354636255;5405.945940540544;5516.07647946589;5525;5546.916796247979;4760.6191504678845;5195.636305458582;5426.891462170814;5454.727263636723;5470.972645136749;5068.087744206078;5160.793568257228;5278.709670968134;5533.944660553343;5548.973439913629;5032.421271553818;5216.582673386196;5335.546478549367;5392.649477784088;5448.264484294569 18:22:34 INFO - PROCESS | 2004 | |5;yui.html;776.2780614028951;798.4291231769286;812.4921923797626;850.506706110456;904.5703290936804;15773.921130394347;17442.2151003205;17452.214650340735;17466.388676396327;17569.47291581253;14626.122432654049;14668.706625867477;14691.706165876676;14818.407263709465;14819.407223711065;991.4348821171935;993.2897977945768;1025.6461520775358;1036.3263878478974;1054.2093429927554;1049.3861091261622;1051.4269723000982;1052.8420736889452;1052.9684109476727;1053.8419237114417;1076.8007918535056;1081.864766904137;1082.1775450657478;1086;1088.3143619519692;1076.364944682637;1076.7469644633584;1077.7413420779035;1078.250615822004;1081.5457507846722;802.7310850864967;804.264098350009;805.1264378149715;806.2501873257868;810.1979040749616;13394.665133371744;16678.58303542409;17118.229679664444;17148.657026859517;17306.48080557585;14700.48548300815;14770.778438323434;14829;14849.48026819067;14910.403583856632;12075.93962030193;12208.633740987785;12312.630621081382;12334.5066197352;12614;3834.7699138051807;3856.5179352580926;3911;3931.783751893645;3987.8205480753436;65516;69850.65074674595;102639;106898;119394.40302798517;11110.888891111146;11278.943605281922;11356.886431135748;11676.70808229801;11851.46668399924;23117;23160.65259021116;23228.76771232266;23316.53366932652;23395.41511462193;8334.374921880762;8354.665813367397;8410.831783364421;8486.830263394697;8488;4550.567696068868;4622.976885115553;4657.464391594942;4683.672142949961;4709.740964246999;3558.2349794794245;3651.5253017107607;3659;3660.5790334111916;3662.322470342995;654.4764188649061;663.8805015097232;676.212212772115;695.6139342664869;695.7669180824379;602.105872778923;603.604638961481;607.8693080987609;611.4832966143601;627.8116565030473;9032.909670903207;10613.310134841211;10619.415932123808;10734.892651073389;11080.445977701083;690.4510913823523;714.886668558431;715.3311653603897;725.5465334166146;735.4961851131992;4927.827526036572;5245.344331958505;5248.265242866002;5255.763490642854;5256.106461901486;111571;113255;113927.2910906337;116008;116281;90412;91067.08932910586;92394;93307.53346233226;93638;70387.64806175936;79820.20179798244;81127;82412.17587824164;83082.75375869367;9104.499252541174;10434.68695939123;10819.404932728776;10979.780404391708;11103.666889993314;29296.707032929397;43992.78003609961;49367.27214547474;50952.74523627358;51042.744786275834;64310.67844660747;64778.02832957604;65159;65726;66744.6662766683;12688.429020693906;12932.676683082622;13029.869701302865;13148.671283217996;13286.80069798973;15647.452339168074;15674.13792241392;15754.448594299145;16224.594385140466;16794.83205167933;14106.647333816327;14291.642708931944;14725.484608038667;14975.251237438302;15440.922795385952;13583.32083395846;14457;14607.780883286972;14618.195999220145;14792.186429746467;13501.548479313873;14283;14486.782698259745;14643.12141271527;14703.338349774072;9906.026639058593;10435.426051567236;10464.895351046393;10607.787844243227;10889.401082940514;11210.887891120985;11716.882831171579;12005.13791914276;12009.279443233434;12103.81844272319 18:22:34 INFO - PROCESS | 2004 | __end_tp_report 18:22:34 INFO - PROCESS | 2004 | __start_cc_report 18:22:34 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,1990 18:22:34 INFO - PROCESS | 2004 | __end_cc_report 18:22:34 INFO - PROCESS | 2004 | __startTimestamp1493169754388__endTimestamp 18:22:34 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | ------- Summary: start ------- 18:22:34 INFO - PROCESS | 2004 | Number of tests: 6 18:22:34 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | [#0] dojo.html Cycles:165 Average:5985.71 Median:6240.22 stddev:693.70 (11.1%) stddev-sans-first:654.48 18:22:34 INFO - PROCESS | 2004 | Values: 2978.3 3505.4 3517.1 3519.1 3558.7 6073.9 6120.0 6126.0 6126.3 6143.3 4911.9 6124.5 6134.9 6144.8 6149.8 5406.6 5432.5 5441.7 5446.9 5560.9 5324.1 5330.8 5343.7 5536.1 5545.7 5399.1 5413.4 5419.6 5420.8 5423.5 5400.4 5458.3 5504.4 5536.3 5537.4 4255.4 5334.4 5441.6 5441.6 5443.3 6171.4 6197.7 6205.5 6207.8 6217.6 6219.6 6246.5 6313.6 6407.4 6555.1 6355.8 6407.2 6420.2 6428.5 6433.6 6218.2 6263.1 6267.5 6275.8 6286.0 6617.4 6624.9 6642.5 6651.2 6844.5 6224.6 6271.8 6278.2 6282.3 6346.9 6440.1 6457.9 6481.4 6496.2 6496.6 6301.4 6433.8 6440.1 6442.7 6451.0 6218.5 6272.4 6287.9 6420.7 6447.5 4793.9 4871.1 4998.6 5056.6 5063.7 4614.5 4615.4 4649.9 4653.6 4664.3 6060.0 6140.6 6187.0 6203.7 6207.0 6237.7 6497.6 6529.7 6536.2 6542.9 6058.5 6129.0 6139.9 6156.5 6170.0 5687.5 5692.0 5693.6 5714.1 5716.0 6671.0 6681.5 6684.1 6704.3 6726.8 5327.8 6179.4 6257.2 6320.4 6327.6 6671.6 6690.4 6698.1 6698.2 6698.5 6389.4 6393.5 6398.5 6404.4 6405.7 6137.7 6192.3 6343.1 6468.1 6488.8 6234.1 6249.8 6350.7 6352.7 6371.2 6329.4 6329.9 6331.7 6334.7 6357.2 6132.8 6240.2 6299.6 6331.2 6339.0 6211.7 6251.6 6304.0 6340.0 6345.0 6280.7 6286.2 6293.0 6293.2 6311.1 18:22:34 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | [#1] ext.html Cycles:180 Average:58000.56 Median:194812.15 stddev:117552.88 (60.3%) stddev-sans-first:117804.05 18:22:34 INFO - PROCESS | 2004 | Values: 747.5 810.6 828.1 885.7 895.7 29222.3 29607.9 30562.8 30704.7 40161.0 41530.0 41720.4 41726.8 41785.4 41823.4 9604.1 9768.8 9778.3 9784.1 9787.9 7789.1 7949.0 9623.1 9719.0 9733.4 11550.0 11714.8 11888.3 11994.8 12029.7 9791.1 9805.7 11744.8 11814.7 11832.7 11546.4 11562.8 11601.5 11602.3 11607.9 39740.6 39934.0 39991.4 40045.4 40106.8 3976.1 4019.7 4024.5 4035.2 4091.1 28133.9 30240.4 30311.2 30375.8 30410.5 3123.5 3197.5 3206.7 3420.3 3426.1 355015.0 355125.0 355385.7 355762.0 357214.0 53018.0 53204.7 53239.0 53302.5 53359.5 54373.7 54753.5 54809.2 54830.0 54949.0 15287.8 15382.5 15392.6 15393.2 15399.9 13070.7 13075.7 13091.5 13092.2 13095.4 10944.3 11150.8 11183.2 11255.6 12544.0 5384.9 5565.3 5594.8 5600.2 5604.2 1119.2 1122.8 1128.3 1154.3 1163.3 27692.2 27693.9 28137.3 28172.0 28333.7 922.4 1088.4 1096.8 1140.5 1270.9 11503.7 11877.3 12706.7 12786.0 12863.0 464293.0 465321.0 465940.0 466702.0 467170.0 38911.0 39221.4 47356.5 47544.0 50077.7 1455.8 1500.8 1501.9 1513.2 1514.6 27042.7 28496.7 28570.1 28907.4 29001.9 43639.8 43802.1 43895.0 43914.0 43975.0 472735.6 483643.0 489080.0 510464.0 516423.0 37853.7 38929.6 39702.4 39739.4 39986.4 49168.5 49171.3 49846.8 49857.8 50466.7 32886.2 33076.5 33078.3 33175.3 33943.8 31169.8 32888.7 33471.2 33822.8 33936.0 40427.4 40476.8 40524.8 40667.6 42155.8 27653.6 29133.7 31020.0 33577.0 34609.3 20763.0 25802.9 26595.3 26862.0 27176.9 18:22:34 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | [#2] jquery.html Cycles:180 Average:43405.97 Median:21504.20 stddev:128752.38 (598.7%) stddev-sans-first:129073.05 18:22:34 INFO - PROCESS | 2004 | Values: 392.8 420.2 428.0 436.2 464.6 18383.0 19952.6 21014.5 22159.9 22433.0 16976.2 22757.0 23717.4 23915.6 23918.7 5938.9 7152.8 7210.6 7221.9 7247.0 6693.9 7075.0 7131.3 7140.5 7155.6 6886.0 6906.5 7100.5 7159.5 7163.0 6504.1 7058.9 7102.8 7107.4 7139.9 5915.8 6920.0 6931.9 6941.2 6945.0 24272.8 25515.4 26486.5 27448.8 27546.4 2970.4 3003.8 3047.3 3050.2 3066.9 14187.9 15881.1 16431.3 16481.6 16873.0 2046.8 2052.8 2076.2 2084.7 2118.0 98776.0 144514.0 156581.0 167199.0 173933.5 16230.6 18741.6 20497.6 20655.8 20694.4 32256.7 32622.0 32704.8 32735.0 32736.3 10448.7 10649.7 10895.5 10895.9 11033.0 8994.4 9002.4 9022.5 9166.3 9197.6 9549.8 9638.0 9670.2 9762.4 9785.7 3800.5 4115.3 4153.0 4165.5 4173.6 1065.4 1081.7 1093.4 1106.4 1127.5 21802.3 22483.8 23087.4 23195.2 23440.1 1089.9 1090.8 1112.2 1123.3 1133.8 11341.9 11700.8 12075.9 12094.8 12113.9 709301.0 784163.0 785550.0 790458.0 807158.0 94121.5 111619.0 133626.0 140473.0 173809.7 1227.5 1241.8 1263.8 1268.7 1273.5 19704.3 21076.5 21183.0 21198.7 21206.0 64414.7 64438.0 64743.7 64816.0 64865.7 89641.0 90489.5 91043.0 92993.5 93122.6 11541.3 11565.9 11951.8 12015.3 12092.6 13141.9 13179.9 13400.5 13546.5 13548.8 11251.5 11401.4 11696.8 11752.2 11839.5 10177.0 10711.8 10748.6 10822.3 11021.2 9711.4 11513.4 11695.5 11871.3 11983.3 11555.7 11611.7 11709.9 11713.6 11925.9 11195.6 11411.5 11466.5 11834.8 11856.7 18:22:34 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | [#3] mootools.html Cycles:180 Average:6817.71 Median:2483.35 stddev:4210.51 (169.5%) stddev-sans-first:4203.30 18:22:34 INFO - PROCESS | 2004 | Values: 1491.9 1576.3 1602.8 1635.0 1657.4 9808.2 10988.6 11676.9 11687.6 11691.4 11143.6 11551.1 11807.1 11810.8 11856.1 2458.5 2500.1 2500.2 2501.9 2507.8 2439.9 2458.8 2475.9 2482.4 2484.3 2447.2 2461.9 2468.7 2488.4 2494.0 2416.9 2424.0 2446.5 2463.3 2477.1 2422.9 2440.4 2451.2 2452.0 2458.0 10050.4 10057.1 10064.8 10066.2 10074.5 5960.7 6128.9 6133.0 6137.4 6141.4 3609.6 3719.7 3766.1 3801.7 3826.2 1236.7 1239.6 1260.1 1282.4 1296.1 13868.9 14162.5 14544.2 15640.0 15697.1 4496.4 4654.7 4731.4 4920.6 4930.6 10269.7 11964.3 11986.1 11987.4 11993.8 5125.7 5822.5 5945.3 6035.8 6043.5 5363.9 5490.5 5532.3 5621.3 5623.6 3995.6 4019.9 4054.1 4092.6 4110.7 1064.5 1068.8 1069.8 1084.1 1086.7 950.1 952.9 961.7 971.1 1000.6 5618.6 6594.1 6622.3 6694.2 6786.2 979.3 990.7 1016.0 1021.7 1022.8 4169.4 4191.1 4201.6 4275.4 4291.3 13484.7 14076.7 14086.0 14097.0 14119.8 13111.3 13569.7 13997.7 14022.8 14023.7 10085.5 10365.5 10393.8 10411.7 10413.5 6711.2 6786.4 7073.8 7080.8 7118.1 10915.0 11470.4 12669.4 12685.9 12724.1 12358.3 12706.3 12721.9 12835.2 12972.0 9057.3 9402.4 9594.2 9595.0 9595.2 10676.5 10714.8 10767.8 10795.0 10804.0 8560.7 8716.4 8784.0 8799.3 8805.6 7345.3 8559.8 8593.1 8665.6 8676.5 8140.3 8338.8 8342.3 8342.7 8372.5 4994.5 5976.0 5986.7 6176.4 6208.7 5415.6 5978.2 6039.9 6161.4 6247.6 18:22:34 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | [#4] prototype.html Cycles:180 Average:4564.02 Median:4957.26 stddev:1268.92 (25.6%) stddev-sans-first:1232.78 18:22:34 INFO - PROCESS | 2004 | Values: 368.4 382.8 383.6 386.9 393.6 4629.5 5207.0 5258.9 5298.3 5365.7 4610.0 4713.6 4917.1 5074.7 5156.0 4226.1 4247.6 4290.3 4295.4 4306.5 4281.7 4296.6 4299.8 4316.6 4330.9 3474.5 3837.8 3841.6 4271.9 4285.2 3635.7 3920.5 4212.7 4290.9 4325.8 3648.1 3744.5 3918.3 3961.7 3986.0 4214.9 4418.0 4771.9 5068.8 5143.5 4087.4 4970.9 4980.4 4991.2 5070.6 4739.2 5059.7 5487.6 5500.8 5513.8 4321.6 4449.3 4472.5 4476.3 4496.3 4536.7 4656.7 5241.7 5374.3 5456.0 4299.5 4399.6 4468.3 4518.0 4610.3 4102.9 4464.6 4688.6 4726.4 4728.3 3588.6 4365.5 4780.0 4846.3 4934.8 4931.8 5434.9 5459.4 5463.9 5465.8 1555.4 1568.4 1571.8 1571.9 1574.9 1078.9 1080.0 1170.4 1192.7 1207.2 5126.5 5159.0 5164.3 5170.4 5356.6 5451.9 5578.9 5608.2 5686.9 5699.4 4644.0 4773.5 4943.7 5057.9 5143.5 2573.7 2613.5 2639.7 2874.4 2910.4 5152.1 5585.6 5637.6 5896.3 5899.8 5144.9 5324.0 5532.8 5636.4 5681.5 5270.2 5328.4 5493.9 5856.9 5923.6 4526.7 4805.5 5466.4 5568.9 5737.9 4850.6 5460.3 5565.0 5585.6 5594.9 5255.6 5670.3 5799.7 5813.5 5930.6 3976.0 4014.6 4168.9 4188.8 4461.9 4912.1 5009.0 5744.7 5761.9 5798.6 4761.2 5185.9 5191.9 5510.8 5568.0 5037.5 5405.9 5516.1 5525.0 5546.9 4760.6 5195.6 5426.9 5454.7 5471.0 5068.1 5160.8 5278.7 5533.9 5549.0 5032.4 5216.6 5335.5 5392.6 5448.3 18:22:34 INFO - PROCESS | 2004 | 18:22:34 INFO - PROCESS | 2004 | [#5] yui.html Cycles:180 Average:20783.38 Median:16956.53 stddev:29544.67 (174.2%) stddev-sans-first:29589.36 18:22:34 INFO - PROCESS | 2004 | Values: 776.3 798.4 812.5 850.5 904.6 15773.9 17442.2 17452.2 17466.4 17569.5 14626.1 14668.7 14691.7 14818.4 14819.4 991.4 993.3 1025.6 1036.3 1054.2 1049.4 1051.4 1052.8 1053.0 1053.8 1076.8 1081.9 1082.2 1086.0 1088.3 1076.4 1076.7 1077.7 1078.3 1081.5 802.7 804.3 805.1 806.3 810.2 13394.7 16678.6 17118.2 17148.7 17306.5 14700.5 14770.8 14829.0 14849.5 14910.4 12075.9 12208.6 12312.6 12334.5 12614.0 3834.8 3856.5 3911.0 3931.8 3987.8 65516.0 69850.7 102639.0 106898.0 119394.4 11110.9 11278.9 11356.9 11676.7 11851.5 23117.0 23160.7 23228.8 23316.5 23395.4 8334.4 8354.7 8410.8 8486.8 8488.0 4550.6 4623.0 4657.5 4683.7 4709.7 3558.2 3651.5 3659.0 3660.6 3662.3 654.5 663.9 676.2 695.6 695.8 602.1 603.6 607.9 611.5 627.8 9032.9 10613.3 10619.4 10734.9 11080.4 690.5 714.9 715.3 725.5 735.5 4927.8 5245.3 5248.3 5255.8 5256.1 111571.0 113255.0 113927.3 116008.0 116281.0 90412.0 91067.1 92394.0 93307.5 93638.0 70387.6 79820.2 81127.0 82412.2 83082.8 9104.5 10434.7 10819.4 10979.8 11103.7 29296.7 43992.8 49367.3 50952.7 51042.7 64310.7 64778.0 65159.0 65726.0 66744.7 12688.4 12932.7 13029.9 13148.7 13286.8 15647.5 15674.1 15754.4 16224.6 16794.8 14106.6 14291.6 14725.5 14975.3 15440.9 13583.3 14457.0 14607.8 14618.2 14792.2 13501.5 14283.0 14486.8 14643.1 14703.3 9906.0 10435.4 10464.9 10607.8 10889.4 11210.9 11716.9 12005.1 12009.3 12103.8 18:22:34 INFO - PROCESS | 2004 | -------- Summary: end -------- 18:22:34 INFO - PROCESS | 2004 | 18:22:35 INFO - TEST-INFO | 2004: exit 0 18:22:35 INFO - TEST-OK | dromaeo_css | took 1118496ms 18:22:35 INFO - TEST-START | kraken 18:22:35 INFO - operating with platform_type : mac_ 18:22:35 INFO - Initialising browser for kraken test... 18:22:35 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpiRX7JV/profile http://localhost:49540/getInfo.html) 18:22:37 INFO - PROCESS | 2007 | __metrics Screen width/height:1600/1200 18:22:37 INFO - PROCESS | 2007 | colorDepth:24 18:22:37 INFO - PROCESS | 2007 | Browser inner width/height: 1024/689 18:22:37 INFO - PROCESS | 2007 | __metrics 18:22:37 INFO - PROCESS | 2007 | 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" 18:22:37 INFO - PROCESS | 2007 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:22:38 INFO - TEST-INFO | 2007: exit 0 18:22:38 INFO - Browser initialized. 18:22:38 INFO - Running cycle 1/1 for kraken test... 18:22:38 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpiRX7JV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:50 INFO - PROCESS | 2009 | RSS: Main: 165158912 18:22:50 INFO - PROCESS | 2009 | 18:22:52 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49540/tests/kraken/driver.html?testName=audio-beat-detection) 18:22:53 INFO - PROCESS | 2009 | RSS: Main: 215576576 18:22:53 INFO - PROCESS | 2009 | 18:22:56 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49540/tests/kraken/driver.html?testName=audio-dft) 18:22:57 INFO - PROCESS | 2009 | RSS: Main: 231202816 18:22:57 INFO - PROCESS | 2009 | 18:23:00 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49540/tests/kraken/driver.html?testName=audio-fft) 18:23:00 INFO - PROCESS | 2009 | RSS: Main: 327503872 18:23:00 INFO - PROCESS | 2009 | 18:23:02 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49540/tests/kraken/driver.html?testName=audio-oscillator) 18:23:03 INFO - PROCESS | 2009 | RSS: Main: 229212160 18:23:03 INFO - PROCESS | 2009 | 18:23:05 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49540/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:23:06 INFO - PROCESS | 2009 | RSS: Main: 230690816 18:23:06 INFO - PROCESS | 2009 | 18:23:09 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49540/tests/kraken/driver.html?testName=imaging-darkroom) 18:23:09 INFO - PROCESS | 2009 | RSS: Main: 272936960 18:23:09 INFO - PROCESS | 2009 | 18:23:12 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49540/tests/kraken/driver.html?testName=imaging-desaturate) 18:23:13 INFO - PROCESS | 2009 | RSS: Main: 272322560 18:23:13 INFO - PROCESS | 2009 | 18:23:16 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49540/tests/kraken/driver.html?testName=json-parse-financial) 18:23:17 INFO - PROCESS | 2009 | RSS: Main: 272105472 18:23:17 INFO - PROCESS | 2009 | 18:23:18 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49540/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:23:19 INFO - PROCESS | 2009 | RSS: Main: 247291904 18:23:19 INFO - PROCESS | 2009 | 18:23:21 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:23:21 INFO - PROCESS | 2009 | RSS: Main: 251273216 18:23:21 INFO - PROCESS | 2009 | 18:23:24 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:23:24 INFO - PROCESS | 2009 | RSS: Main: 259678208 18:23:24 INFO - PROCESS | 2009 | 18:23:27 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:23:28 INFO - PROCESS | 2009 | RSS: Main: 273555456 18:23:28 INFO - PROCESS | 2009 | 18:23:31 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:23:31 INFO - PROCESS | 2009 | RSS: Main: 267042816 18:23:31 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49540/tests/kraken/driver.html?testName=ai-astar) 18:23:33 INFO - PROCESS | 2009 | RSS: Main: 312045568 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | __start_tp_report 18:23:33 INFO - PROCESS | 2009 | _x_x_mozilla_page_load 18:23:33 INFO - PROCESS | 2009 | _x_x_mozilla_page_load_details 18:23:33 INFO - PROCESS | 2009 | |i|pagename|runs| 18:23:33 INFO - PROCESS | 2009 | |0;ai-astar;107;160;173;118;118;117;119;118;118;118 18:23:33 INFO - PROCESS | 2009 | |1;audio-beat-detection;168;93;107;139;128;134;136;114;125;108 18:23:33 INFO - PROCESS | 2009 | |2;audio-dft;188;183;186;190;256;219;186;187;188;186 18:23:33 INFO - PROCESS | 2009 | |3;audio-fft;82;60;61;92;61;62;59;58;73;59 18:23:33 INFO - PROCESS | 2009 | |4;audio-oscillator;90;69;85;69;69;67;82;69;68;83 18:23:33 INFO - PROCESS | 2009 | |5;imaging-gaussian-blur;87;87;87;87;87;87;88;87;93;134 18:23:33 INFO - PROCESS | 2009 | |6;imaging-darkroom;94;108;149;103;94;95;118;90;134;149 18:23:33 INFO - PROCESS | 2009 | |7;imaging-desaturate;84;87;83;83;86;96;132;110;85;87 18:23:33 INFO - PROCESS | 2009 | |8;json-parse-financial;63;61;58;59;60;64;65;64;62;62 18:23:33 INFO - PROCESS | 2009 | |9;json-stringify-tinderbox;55;56;66;64;61;58;58;57;58;58 18:23:33 INFO - PROCESS | 2009 | |10;stanford-crypto-aes;80;81;83;85;82;82;79;84;92;101 18:23:33 INFO - PROCESS | 2009 | |11;stanford-crypto-ccm;135;134;132;133;131;137;127;156;190;168 18:23:33 INFO - PROCESS | 2009 | |12;stanford-crypto-pbkdf2;162;161;160;166;159;160;158;185;212;161 18:23:33 INFO - PROCESS | 2009 | |13;stanford-crypto-sha256-iterative;64;65;62;63;64;62;61;69;76;79 18:23:33 INFO - PROCESS | 2009 | __end_tp_report 18:23:33 INFO - PROCESS | 2009 | __start_cc_report 18:23:33 INFO - PROCESS | 2009 | _x_x_mozilla_cycle_collect,2030 18:23:33 INFO - PROCESS | 2009 | __end_cc_report 18:23:33 INFO - PROCESS | 2009 | __startTimestamp1493169813733__endTimestamp 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | ------- Summary: start ------- 18:23:33 INFO - PROCESS | 2009 | Number of tests: 14 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#0] ai-astar Cycles:10 Average:126.60 Median:118.00 stddev:21.53 (18.2%) stddev-sans-first:21.64 18:23:33 INFO - PROCESS | 2009 | Values: 107.0 160.0 173.0 118.0 118.0 117.0 119.0 118.0 118.0 118.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:135.00 stddev:21.12 (15.6%) stddev-sans-first:15.73 18:23:33 INFO - PROCESS | 2009 | Values: 168.0 93.0 107.0 139.0 128.0 134.0 136.0 114.0 125.0 108.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#2] audio-dft Cycles:10 Average:196.90 Median:188.00 stddev:23.18 (12.3%) stddev-sans-first:24.36 18:23:33 INFO - PROCESS | 2009 | Values: 188.0 183.0 186.0 190.0 256.0 219.0 186.0 187.0 188.0 186.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#3] audio-fft Cycles:10 Average:66.70 Median:61.50 stddev:11.74 (19.1%) stddev-sans-first:11.07 18:23:33 INFO - PROCESS | 2009 | Values: 82.0 60.0 61.0 92.0 61.0 62.0 59.0 58.0 73.0 59.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:75.50 stddev:8.79 (11.6%) stddev-sans-first:7.49 18:23:33 INFO - PROCESS | 2009 | Values: 90.0 69.0 85.0 69.0 69.0 67.0 82.0 69.0 68.0 83.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:87.00 stddev:14.74 (16.9%) stddev-sans-first:15.50 18:23:33 INFO - PROCESS | 2009 | Values: 87.0 87.0 87.0 87.0 87.0 87.0 88.0 87.0 93.0 134.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:119.50 stddev:22.99 (19.2%) stddev-sans-first:23.29 18:23:33 INFO - PROCESS | 2009 | Values: 94.0 108.0 149.0 103.0 94.0 95.0 118.0 90.0 134.0 149.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:85.50 stddev:15.93 (18.6%) stddev-sans-first:16.54 18:23:33 INFO - PROCESS | 2009 | Values: 84.0 87.0 83.0 83.0 86.0 96.0 132.0 110.0 85.0 87.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.50 stddev:2.30 (3.7%) stddev-sans-first:2.40 18:23:33 INFO - PROCESS | 2009 | Values: 63.0 61.0 58.0 59.0 60.0 64.0 65.0 64.0 62.0 62.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:58.00 stddev:3.51 (6.1%) stddev-sans-first:3.40 18:23:33 INFO - PROCESS | 2009 | Values: 55.0 56.0 66.0 64.0 61.0 58.0 58.0 57.0 58.0 58.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:82.50 stddev:6.71 (8.1%) stddev-sans-first:6.88 18:23:33 INFO - PROCESS | 2009 | Values: 80.0 81.0 83.0 85.0 82.0 82.0 79.0 84.0 92.0 101.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:136.00 stddev:20.52 (15.1%) stddev-sans-first:21.48 18:23:33 INFO - PROCESS | 2009 | Values: 135.0 134.0 132.0 133.0 131.0 137.0 127.0 156.0 190.0 168.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:161.50 stddev:17.23 (10.7%) stddev-sans-first:18.11 18:23:33 INFO - PROCESS | 2009 | Values: 162.0 161.0 160.0 166.0 159.0 160.0 158.0 185.0 212.0 161.0 18:23:33 INFO - PROCESS | 2009 | 18:23:33 INFO - PROCESS | 2009 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:64.50 stddev:6.24 (9.7%) stddev-sans-first:6.55 18:23:33 INFO - PROCESS | 2009 | Values: 64.0 65.0 62.0 63.0 64.0 62.0 61.0 69.0 76.0 79.0 18:23:33 INFO - PROCESS | 2009 | -------- Summary: end -------- 18:23:33 INFO - PROCESS | 2009 | 18:23:34 INFO - TEST-INFO | 2009: exit 0 18:23:34 INFO - TEST-OK | kraken | took 59536ms 18:23:34 INFO - SUITE-END | took 1178s 18:23:34 INFO - Completed test suite (00:19:38) 18:23:34 INFO - javascript benchmark 18:23:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7870.73079890953, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2978.3298757779503, 3505.3690335739566, 3517.103138699631, 3519.0850378901478, 3558.6619271169247, 6073.864879377891, 6119.99004232014, 6126.02013091576, 6126.314740042873, 6143.2628084629905, 4911.877203069925, 6124.479419249358, 6134.877302453949, 6144.784932527363, 6149.754009839612, 5406.621536492457, 5432.456754324556, 5441.700706461143, 5446.891062178754, 5560.888782224353, 5324.148136298193, 5330.840074797743, 5343.7328133593355, 5536.058869992111, 5545.694986775726, 5399.1091469907415, 5413.404525502211, 5419.59353048521, 5420.756065977021, 5423.457654234585, 5400.351957765054, 5458.344998600193, 5504.422035686235, 5536.280283563151, 5537.418571050022, 4255.3829694694095, 5334.3598768147685, 5441.59188060893, 5441.619086663935, 5443.319585051869, 6171.382861713838, 6197.659128747917, 6205.5345849061505, 6207.751689932397, 6217.595856269328, 6219.564630475868, 6246.531510136712, 6313.558050936436, 6407.391297826699, 6555.147830781968, 6355.777547785805, 6407.231132264112, 6420.1974753155855, 6428.485721142344, 6433.613983160979, 6218.191635087455, 6263.123162757218, 6267.467265282502, 6275.780347687809, 6286.0, 6617.371349721769, 6624.86750264992, 6642.535022548375, 6651.201855777241, 6844.486663500257, 6224.62652240867, 6271.78048768291, 6278.183836101278, 6282.308946015934, 6346.936530634634, 6440.130582371414, 6457.870842583122, 6481.449076828428, 6496.155499785093, 6496.577722448026, 6301.4328710416285, 6433.839154021093, 6440.066190402459, 6442.710078046499, 6450.967745161244, 6218.533609979179, 6272.435480806749, 6287.937120628827, 6420.711068001951, 6447.516436267299, 4793.9280910786365, 4871.074495845778, 4998.575121114746, 5056.570191533688, 5063.696178229245, 4614.515475875052, 4615.446146462379, 4649.907001860011, 4653.557911998355, 4664.323673067386, 6060.0, 6140.570160088841, 6186.969065154645, 6203.658798766111, 6207.037909124093, 6237.688115594293, 6497.64262965532, 6529.7388104475285, 6536.182977127859, 6542.869142617216, 6058.545609079337, 6128.958077126899, 6139.938600613937, 6156.538259630545, 6170.0, 5687.51656109227, 5691.971540142273, 5693.572982026365, 5714.142878568248, 5715.971420142872, 6670.999350097524, 6681.498887583353, 6684.064231007663, 6704.296048914794, 6726.831829204309, 5327.840164795062, 6179.443850053517, 6257.186565746606, 6320.399562041599, 6327.588706734232, 6671.566348187353, 6690.431313338421, 6698.062271282122, 6698.162729658793, 6698.497612678971, 6389.393007664265, 6393.520485963479, 6398.456131228898, 6404.423601875854, 6405.743770249138, 6137.662428566472, 6192.318844927145, 6343.143675603919, 6468.094466774562, 6488.805335839932, 6234.064890266496, 6249.78125765596, 6350.714217860115, 6352.650604216812, 6371.171747672773, 6329.367063293634, 6329.8734025320155, 6331.651759153291, 6334.746610135543, 6357.205349331333, 6132.78535251264, 6240.219972503437, 6299.590526615755, 6331.2085989251345, 6339.0, 6211.65835879031, 6251.593646412968, 6304.0, 6340.048992651139, 6344.96827515878, 6280.654563999024, 6286.151369565233, 6293.0, 6293.181886354744, 6311.053341998737], "value": 5939.671794752702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.5215861848415, 810.6392655268405, 828.1180542722001, 885.6855816185254, 895.6686026170318, 29222.26944326393, 29607.851960740194, 30562.847185764094, 30704.69295307049, 40160.995975100566, 41530.0, 41720.37419438711, 41726.7913660432, 41785.373219401736, 41823.37264941028, 9604.087611676898, 9768.755781105458, 9778.266630002743, 9784.119429251366, 9787.90212097877, 7789.143194248628, 7948.9602551987155, 9623.133917947383, 9718.951405242964, 9733.367331123454, 11550.0, 11714.824277635842, 11888.346140962243, 11994.820077698841, 12029.699257518545, 9791.118799308026, 9805.705828825146, 11744.7651046979, 11814.704632384217, 11832.70418239551, 11546.422678866107, 11562.826557601642, 11601.477933493014, 11602.303861768321, 11607.941960290229, 39740.60259397398, 39934.0, 39991.40012899809, 40045.39931901024, 40106.799466002776, 3976.1451287973223, 4019.698522610816, 4024.476818013669, 4035.152617950234, 4091.1204091120553, 28133.85933070342, 30240.395192096035, 30311.24221894448, 30375.848120759474, 30410.54384184239, 3123.453395655751, 3197.536357228189, 3206.6633003534757, 3420.3330350581646, 3426.109211604976, 355015.0, 355125.0, 355385.669214962, 355762.0, 357214.0, 53018.0, 53204.66988325323, 53239.0, 53302.46697532975, 53359.46640533545, 54373.72813135909, 54753.45246547563, 54809.17786233209, 54830.0, 54949.0, 15287.847121528643, 15382.461613843461, 15392.615184620474, 15393.153376564396, 15399.92200545951, 13070.738585228242, 13075.673108172372, 13091.541796037092, 13092.214467132002, 13095.410706518229, 10944.343339399662, 11150.832737508943, 11183.161262905152, 11255.606053788078, 12544.0, 5384.865378365494, 5565.30433695788, 5594.790057927177, 5600.243967064475, 5604.187392828098, 1119.1662211652208, 1122.7810576937418, 1128.2835399521364, 1154.32648532462, 1163.2962057954985, 27692.16923492258, 27693.913562144215, 28137.296567585974, 28172.01397951103, 28333.716662833107, 922.4280945813639, 1088.3524303039678, 1096.7916095941746, 1140.4696815980442, 1270.9046821488425, 11503.654890353302, 11877.277794719717, 12706.682332941751, 12786.0, 12863.0, 464293.0, 465321.0, 465940.0, 466702.0, 467170.0, 38911.0, 39221.41167882484, 47356.52643473521, 47544.0, 50077.74961125171, 1455.8471360507206, 1500.7598784194477, 1501.8573235542606, 1513.2433783108445, 1514.5532068040175, 27042.729572704022, 28496.69576245164, 28570.14289571316, 28907.42185156327, 29001.854990725755, 43639.781801090794, 43802.12395752131, 43895.0, 43914.0, 43974.99999999872, 472735.6363218162, 483643.0, 489080.0, 510464.0, 516423.0, 37853.728776273514, 38929.6107038926, 39702.40446393364, 39739.40390894081, 39986.400203997546, 49168.50831491639, 49171.298282727286, 49846.75076624594, 49857.75071124621, 50466.73833154201, 32886.177845554055, 33076.503852441754, 33078.338433231685, 33175.33649327048, 33943.83028084844, 31169.8441507791, 32888.67111328856, 33471.16322091967, 33822.83088584541, 33935.98192054242, 40427.39358909678, 40476.78569642916, 40524.79737601293, 40667.59332406638, 42155.789221054925, 27653.58519622167, 29133.7086629131, 31020.0, 33577.0, 34609.30781384408, 20763.0, 25802.870985644953, 26595.33511662224, 26862.0, 27176.864115680088], "value": 19261.465773635697, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.7584535510661, 420.24146415719633, 428.0, 436.20392783170723, 464.6399040743423, 18383.0, 19952.60094798103, 21014.474638134034, 22159.889200554015, 22433.0, 16976.236069376875, 22756.997906747885, 23717.407064823386, 23915.64126538099, 23918.684472354013, 5938.940610593882, 7152.821179470503, 7210.603416812073, 7221.927780722178, 7246.963765181193, 6693.933060669404, 7075.0, 7131.322524360177, 7140.5001649884525, 7155.642217889111, 6886.0, 6906.482013848957, 7100.502964792467, 7159.463040271974, 7163.0, 6504.089427480157, 7058.85882282354, 7102.786916392516, 7107.395871350941, 7139.9286007140045, 5915.792947246869, 6919.965400173017, 6931.930680693179, 6941.167059952788, 6944.965275173592, 24272.757272427403, 25515.362115947064, 26486.47027059448, 27448.764805583796, 27546.44907101847, 2970.376220993594, 3003.819770813758, 3047.2686555226805, 3050.206946193983, 3066.9079927602206, 14187.85812141886, 15881.126538040404, 16431.342746290135, 16481.587960300967, 16873.0, 2046.7748547659746, 2052.835773138145, 2076.200662744839, 2084.6768750843644, 2118.0, 98776.0, 144514.0, 156581.0, 167199.0, 173933.52132957397, 16230.594235143979, 18741.625167496575, 20497.59004819925, 20655.79344206569, 20694.379168624964, 32256.677433225366, 32622.0, 32704.83647581747, 32735.0, 32736.345273094405, 10448.73878153037, 10649.680509584725, 10895.509702063426, 10895.891041089646, 11033.0, 8994.370394072483, 9002.369834111549, 9022.548872556346, 9166.312526560401, 9197.586108624993, 9549.809003820024, 9637.951810240904, 9670.178034866974, 9762.414255144715, 9785.657501987538, 3800.5106655140926, 4115.279826030433, 4152.958470415318, 4165.5009791775055, 4173.561776013475, 1065.4193464561677, 1081.6700906223678, 1093.3986307530986, 1106.4025426269725, 1127.5320741892187, 21802.34592962182, 22483.775162248166, 23087.422814429774, 23195.188168414363, 23440.06239750425, 1089.9455027248605, 1090.8472813805915, 1112.1547623805966, 1123.3316176874746, 1133.7505748735266, 11341.886581134248, 11700.829917008232, 12075.939620302019, 12094.818577721342, 12113.939430302793, 709301.0, 784163.0, 785550.0, 790458.0477097578, 807158.0, 94121.5293923526, 111619.0, 133626.0, 140473.0, 173809.7499762532, 1227.4967263422134, 1241.7702724995725, 1263.7914744067125, 1268.7462507498537, 1273.4842388832537, 19704.310349138286, 21076.473088172304, 21183.0, 21198.682019769407, 21206.04572794259, 64414.677926610064, 64438.0, 64743.67628162017, 64816.0, 64865.67567162134, 89640.96615652442, 90489.54755226182, 91043.0, 92993.53503232711, 93122.603160954, 11541.307521548733, 11565.942170289094, 11951.820722688994, 12015.339156346485, 12092.637220883387, 13141.868581314448, 13179.934100329438, 13400.530981415604, 13546.458141674617, 13548.796768048684, 11251.493682784458, 11401.372924489233, 11696.824547631963, 11752.23610465317, 11839.467223975114, 10176.982301769764, 10711.785764284827, 10748.570057197938, 10822.296550724177, 11021.173411993972, 9711.36876103051, 11513.366764828015, 11695.473703683185, 11871.287722736319, 11983.28100313984, 11555.653330400102, 11611.709707257387, 11709.941450292694, 11713.648590542298, 11925.880741192477, 11195.552177913118, 11411.543538258376, 11466.484008219817, 11834.822477663014, 11856.703582410164], "value": 11869.681549613768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.9481765355426, 1576.2749135397717, 1602.751573506107, 1635.043499552762, 1657.3701993242566, 9808.215342772579, 10988.615398461056, 11676.941615291911, 11687.649370518888, 11691.356975366352, 11143.554257829677, 11551.13366497512, 11807.11446641501, 11810.7637847243, 11856.051515878731, 2458.4591389894194, 2500.1374525788665, 2500.174942269056, 2501.874156629515, 2507.7743003129713, 2439.865807380593, 2458.791002764767, 2475.9133430329944, 2482.391814005571, 2484.304394769458, 2447.229122826304, 2461.889214985321, 2468.7160976487753, 2488.427661637815, 2493.9750602493923, 2416.927492175229, 2423.9757602423924, 2446.510697860435, 2463.310273123528, 2477.0834791127218, 2422.91519796808, 2440.365504968703, 2451.240115564163, 2452.0, 2457.9676535854983, 10050.396976181379, 10057.145142662883, 10064.849027264523, 10066.245031622657, 10074.546645400975, 5960.701964901781, 6128.938710612926, 6132.969335153341, 6137.447629713347, 6141.416565426277, 3609.5668519777532, 3719.6652301292743, 3766.0584853786554, 3801.6768574671187, 3826.1582451860545, 1236.746466974268, 1239.5723475401062, 1260.0927332320714, 1282.4100913579764, 1296.0733075850717, 13868.861311386858, 14162.504312349121, 14544.200068996306, 15640.0, 15697.058176509447, 4496.4154659894, 4654.674172807939, 4731.432228132646, 4920.581750551171, 4930.580900623487, 10269.7432564185, 11964.282143071443, 11986.101042421853, 11987.400629968466, 11993.820092698617, 5125.692458452505, 5822.505087067562, 5945.316288626776, 6035.758569657252, 6043.516518678495, 5363.865903352447, 5490.505854473116, 5532.2531458253425, 5621.269234999424, 5623.606347555714, 3995.5604883462797, 4019.8995025124023, 4054.1486287879284, 4092.570280120604, 4110.7328023678365, 1064.5475672839168, 1068.7862427514528, 1069.8127827630133, 1084.143526613982, 1086.7446150154708, 950.1306304731231, 952.9380590261611, 961.7307153996892, 971.1162841813915, 1000.5997600959674, 5618.634788738719, 6594.10979517759, 6622.2715501294815, 6694.230163531256, 6786.151731033621, 979.329159525713, 990.7451352634071, 1016.0323935033705, 1021.6526381030485, 1022.7852151048214, 4169.353750168729, 4191.140816132746, 4201.579842015774, 4275.40144379787, 4291.291936830388, 13484.730305394034, 14076.71846563063, 14086.0, 14097.0, 14119.78820317696, 13111.344432778515, 13569.728605427836, 13997.650058748613, 14022.789658155136, 14023.719525609431, 10085.546150423248, 10365.481725913674, 10393.792124157626, 10411.687649370531, 10413.53139108742, 6711.161104861892, 6786.3892249697765, 7073.752418665322, 7080.752173673896, 7118.074650295428, 10915.0, 11470.369129697947, 12669.429875655802, 12685.873141268468, 12724.109312348417, 12358.258504489759, 12706.30115343665, 12721.93639031799, 12835.229886206858, 12971.962243020724, 9057.320700947323, 9402.43585384879, 9594.232461403211, 9595.040495950629, 9595.184409325006, 10676.519556619816, 10714.785704285714, 10767.784644307227, 10795.0, 10804.027637512661, 8560.657573697232, 8716.38985271025, 8784.0, 8799.252063574668, 8805.603747831236, 7345.3021962913435, 8559.786005349666, 8593.097724738813, 8665.610047547749, 8676.479411235347, 8140.348772098099, 8338.791530211793, 8342.290905272877, 8342.666293348198, 8372.539510326991, 4994.450610432922, 5975.970120149545, 5986.700664966647, 6176.413240742122, 6208.689565521616, 5415.6479828811, 5978.192943952685, 6039.939600603938, 6161.383861613803, 6247.5939063960695], "value": 5235.279484606036, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3847973883614, 382.7779887665154, 383.6432118130138, 386.8742658635943, 393.55135145933633, 4629.513901040393, 5206.973965130173, 5258.92111618326, 5298.311219541464, 5365.719569183101, 4609.962758379363, 4713.552212539812, 4917.139500587401, 5074.731317170707, 5155.978336897217, 4226.098255784894, 4247.638950689196, 4290.348215936863, 4295.355696645497, 4306.461692288464, 4281.7002809803325, 4296.591823776736, 4299.763513006784, 4316.568343165674, 4330.935035974463, 3474.513568100468, 3837.846486140551, 3841.635044670752, 4271.881526485668, 4285.228658841407, 3635.72732045095, 3920.529536455615, 4212.6629869610515, 4290.892727681801, 4325.805338759764, 3648.087978005499, 3744.5319335083113, 3918.3142949983926, 3961.7028722845903, 3986.006996501749, 4214.883055990165, 4417.955820441786, 4771.856844294677, 5068.847934561969, 5143.537081662668, 4087.3868919662286, 4970.850874473772, 4980.377452818398, 4991.201407774739, 5070.619703522214, 4739.175417464301, 5059.671121377099, 5487.5884308677005, 5500.80747173847, 5513.7794488220425, 4321.611055005064, 4449.332600109977, 4472.463304403493, 4476.306172543228, 4496.280595104768, 4536.707038494013, 4656.697314674535, 5241.6674579812, 5374.328208973879, 5455.972720136414, 4299.54854740254, 4399.560043995575, 4468.285074388083, 4517.954820451819, 4610.2623580227, 4102.897427564335, 4464.611432883392, 4688.648351373592, 4726.432828060655, 4728.290756386501, 3588.5693716753635, 4365.519792822851, 4780.041231349764, 4846.273059041172, 4934.777934992934, 4931.827386041543, 5434.864128396822, 5459.372172200247, 5463.945360546423, 5465.836024919259, 1555.401170549324, 1568.3648122510401, 1571.787808645841, 1571.921403929799, 1574.9370025199094, 1078.8510236597997, 1079.9568017279378, 1170.4206417823061, 1192.7256730951929, 1207.2454715802623, 5126.4617215191865, 5159.0, 5164.295782391801, 5170.405403378584, 5356.625036247503, 5451.890962180734, 5578.944210557924, 5608.242887210256, 5686.886262274731, 5699.430056994267, 4644.0, 4773.522647735268, 4943.6786608871025, 5057.928367664066, 5143.485651434901, 2573.6654234949337, 2613.529564678376, 2639.6568446101883, 2874.3820078683184, 2910.359720861407, 5152.105499775229, 5585.609007369445, 5637.56242158247, 5896.262967129109, 5899.793507227227, 5144.897102057937, 5323.9884421959705, 5532.75102620383, 5636.408177141341, 5681.460261275172, 5270.23581580661, 5328.364323038903, 5493.890122197614, 5856.853578660568, 5923.555733320019, 4526.705764125321, 4805.495422980676, 5466.387415712295, 5568.916466252928, 5737.9139312911175, 4850.636202284913, 5460.2800117962715, 5565.02612042899, 5585.636933599466, 5594.86012849682, 5255.553277971415, 5670.347909990239, 5799.710014499343, 5813.4828428799965, 5930.614510056833, 3976.0258736609717, 4014.6386825185873, 4168.91662166761, 4188.832446702219, 4461.933071003873, 4912.067325139881, 5009.023240468074, 5744.712764361681, 5761.942380576141, 5798.623089499169, 4761.190747515921, 5185.948140518546, 5191.935653191012, 5510.768138903751, 5567.972160139173, 5037.5214354636255, 5405.945940540544, 5516.07647946589, 5525.0, 5546.916796247979, 4760.6191504678845, 5195.636305458582, 5426.891462170814, 5454.727263636723, 5470.972645136749, 5068.087744206078, 5160.793568257228, 5278.709670968134, 5533.944660553343, 5548.973439913629, 5032.421271553818, 5216.582673386196, 5335.546478549367, 5392.649477784088, 5448.264484294569], "value": 4196.611386959269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.2780614028951, 798.4291231769286, 812.4921923797626, 850.506706110456, 904.5703290936804, 15773.921130394347, 17442.2151003205, 17452.214650340735, 17466.388676396327, 17569.47291581253, 14626.122432654049, 14668.706625867477, 14691.706165876676, 14818.407263709465, 14819.407223711065, 991.4348821171935, 993.2897977945768, 1025.6461520775358, 1036.3263878478974, 1054.2093429927554, 1049.3861091261622, 1051.4269723000982, 1052.8420736889452, 1052.9684109476727, 1053.8419237114417, 1076.8007918535056, 1081.864766904137, 1082.1775450657478, 1086.0, 1088.3143619519692, 1076.364944682637, 1076.7469644633584, 1077.7413420779035, 1078.250615822004, 1081.5457507846722, 802.7310850864967, 804.264098350009, 805.1264378149715, 806.2501873257868, 810.1979040749616, 13394.665133371744, 16678.58303542409, 17118.229679664444, 17148.657026859517, 17306.48080557585, 14700.48548300815, 14770.778438323434, 14829.0, 14849.48026819067, 14910.403583856632, 12075.93962030193, 12208.633740987785, 12312.630621081382, 12334.5066197352, 12614.0, 3834.7699138051807, 3856.5179352580926, 3911.0, 3931.783751893645, 3987.8205480753436, 65516.0, 69850.65074674595, 102639.0, 106898.0, 119394.40302798517, 11110.888891111146, 11278.943605281922, 11356.886431135748, 11676.70808229801, 11851.46668399924, 23117.0, 23160.65259021116, 23228.76771232266, 23316.53366932652, 23395.41511462193, 8334.374921880762, 8354.665813367397, 8410.831783364421, 8486.830263394697, 8488.0, 4550.567696068868, 4622.976885115553, 4657.464391594942, 4683.672142949961, 4709.740964246999, 3558.2349794794245, 3651.5253017107607, 3659.0, 3660.5790334111916, 3662.322470342995, 654.4764188649061, 663.8805015097232, 676.212212772115, 695.6139342664869, 695.7669180824379, 602.105872778923, 603.604638961481, 607.8693080987609, 611.4832966143601, 627.8116565030473, 9032.909670903207, 10613.310134841211, 10619.415932123808, 10734.892651073389, 11080.445977701083, 690.4510913823523, 714.886668558431, 715.3311653603897, 725.5465334166146, 735.4961851131992, 4927.827526036572, 5245.344331958505, 5248.265242866002, 5255.763490642854, 5256.106461901486, 111571.0, 113255.0, 113927.2910906337, 116008.0, 116281.0, 90412.0, 91067.08932910586, 92394.0, 93307.53346233226, 93638.0, 70387.64806175936, 79820.20179798244, 81127.0, 82412.17587824164, 83082.75375869367, 9104.499252541174, 10434.68695939123, 10819.404932728776, 10979.780404391708, 11103.666889993314, 29296.707032929397, 43992.78003609961, 49367.27214547474, 50952.74523627358, 51042.744786275834, 64310.67844660747, 64778.02832957604, 65159.0, 65726.0, 66744.6662766683, 12688.429020693906, 12932.676683082622, 13029.869701302865, 13148.671283217996, 13286.80069798973, 15647.452339168074, 15674.13792241392, 15754.448594299145, 16224.594385140466, 16794.83205167933, 14106.647333816327, 14291.642708931944, 14725.484608038667, 14975.251237438302, 15440.922795385952, 13583.32083395846, 14457.0, 14607.780883286972, 14618.195999220145, 14792.186429746467, 13501.548479313873, 14283.0, 14486.782698259745, 14643.12141271527, 14703.338349774072, 9906.026639058593, 10435.426051567236, 10464.895351046393, 10607.787844243227, 10889.401082940514, 11210.887891120985, 11716.882831171579, 12005.13791914276, 12009.279443233434, 12103.81844272319], "value": 7967.439115524151, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1474.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 160.0, 173.0, 118.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 93.0, 107.0, 139.0, 128.0, 134.0, 136.0, 114.0, 125.0, 108.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 186.0, 190.0, 256.0, 219.0, 186.0, 187.0, 188.0, 186.0], "value": 196.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 61.0, 92.0, 61.0, 62.0, 59.0, 58.0, 73.0, 59.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 69.0, 69.0, 67.0, 82.0, 69.0, 68.0, 83.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 87.0, 87.0, 87.0, 88.0, 87.0, 93.0, 134.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 108.0, 149.0, 103.0, 94.0, 95.0, 118.0, 90.0, 134.0, 149.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 83.0, 83.0, 86.0, 96.0, 132.0, 110.0, 85.0, 87.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 58.0, 59.0, 60.0, 64.0, 65.0, 64.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 66.0, 64.0, 61.0, 58.0, 58.0, 57.0, 58.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 83.0, 85.0, 82.0, 82.0, 79.0, 84.0, 92.0, 101.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 132.0, 133.0, 131.0, 137.0, 127.0, 156.0, 190.0, 168.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 166.0, 159.0, 160.0, 158.0, 185.0, 212.0, 161.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 62.0, 63.0, 64.0, 62.0, 61.0, 69.0, 76.0, 79.0], "value": 66.5, "unit": "score"}]}]} 18:23:34 INFO - Return code: 0 18:23:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:23:35 INFO - # TBPL SUCCESS # 18:23:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:23:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:23:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:23:35 INFO - 2017-04-25 18:23:35.042 screenresolution[2013:18006] starting screenresolution argv=screenresolution get 18:23:35 INFO - 2017-04-25 18:23:35.044 screenresolution[2013:18006] Display 0: 1600x1200x32@60 18:23:35 INFO - 2017-04-25 18:23:35.050 screenresolution[2014:18009] starting screenresolution argv=screenresolution list 18:23:35 INFO - Available Modes on Display 0 18:23:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:23:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:23:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:23:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:23:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:23:35 INFO - Intel Iris: 18:23:35 INFO - Chipset Model: Intel Iris 18:23:35 INFO - Type: GPU 18:23:35 INFO - Bus: Built-In 18:23:35 INFO - VRAM (Dynamic, Max): 1536 MB 18:23:35 INFO - Vendor: Intel (0x8086) 18:23:35 INFO - Device ID: 0x0a2e 18:23:35 INFO - Revision ID: 0x0009 18:23:35 INFO - Displays: 18:23:35 INFO - Display: 18:23:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:23:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:23:35 INFO - Display Serial Number: 1600x1200 60 18:23:35 INFO - Main Display: Yes 18:23:35 INFO - Mirror: Off 18:23:35 INFO - Online: Yes 18:23:35 INFO - Rotation: Supported 18:23:35 INFO - Return code: 0 18:23:35 INFO - Running post-action listener: _resource_record_post_action 18:23:35 INFO - [mozharness: 2017-04-26 01:23:35.285667Z] Finished run-tests step (success) 18:23:35 INFO - Running post-run listener: _resource_record_post_run 18:23:35 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 3596288; Write bytes: 422287360; Read time: 19; Write time: 1508 18:23:35 INFO - TinderboxPrint: CPU usage
53.9% 18:23:35 INFO - TinderboxPrint: I/O read bytes / time
3,596,288 / 19 18:23:35 INFO - TinderboxPrint: I/O write bytes / time
422,287,360 / 1,508 18:23:35 INFO - TinderboxPrint: CPU idle
2,203.0 (46.1%) 18:23:35 INFO - TinderboxPrint: CPU system
954.4 (20.0%) 18:23:35 INFO - TinderboxPrint: CPU user
1,620.2 (33.9%) 18:23:35 INFO - TinderboxPrint: Swap in / out
125,857,792 / 0 18:23:35 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122710528; Write bytes: 122613760; Read time: 11098; Write time: 305 18:23:35 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 856064; Write bytes: 295129088; Read time: 10; Write time: 1130 18:23:35 INFO - Running post-run listener: _upload_blobber_files 18:23:35 INFO - Blob upload gear active. 18:23:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:23:35 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 18:23:35 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'] 18:23:35 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 18:23:36 INFO - (blobuploader) - INFO - Open directory for files ... 18:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:23:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:23:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:23:36 INFO - (blobuploader) - INFO - Done attempting. 18:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:23:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:23:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:23:38 INFO - (blobuploader) - INFO - Done attempting. 18:23:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:23:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:23:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:23:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:23:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:23:39 INFO - (blobuploader) - INFO - Done attempting. 18:23:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:23:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:23:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:23:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:23:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:23:42 INFO - (blobuploader) - INFO - Done attempting. 18:23:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:23:42 INFO - Return code: 0 18:23:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:23:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:23:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc47275724b3ce51d930eb3b1dd6f380031500f2c0120826329142a85c0c2a1230109fc4c82cd5f90c2c70224436d7d59c57748397c6894d2d6600e9be18e8a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afb97c5597c7dbd2d91c044ac236fa47e7fb3c267600079b1fd7340c4ba536b3bf9487007e5e7130a92e95a99e53a6539bd26a42b12b0f61d9601761a1198710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57e6141eb84c4ead20ece6a9579aca79c1214b2849fd980324885d6bf67ce80a2bfa8388be8c4ad4de6c77b35842b4ca93a916da022ff9415ee7700231088dd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3990493f5d81154c77d3f22e166917eaa0aad8ecc95e61d1afb7eff5f9e4044cee80c5aad479340dffd2fddf9164276adaf46610b9defd49e7aa1e7357ce76a4"} 18:23:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:23:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:23:42 INFO - Contents: 18:23:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc47275724b3ce51d930eb3b1dd6f380031500f2c0120826329142a85c0c2a1230109fc4c82cd5f90c2c70224436d7d59c57748397c6894d2d6600e9be18e8a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afb97c5597c7dbd2d91c044ac236fa47e7fb3c267600079b1fd7340c4ba536b3bf9487007e5e7130a92e95a99e53a6539bd26a42b12b0f61d9601761a1198710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57e6141eb84c4ead20ece6a9579aca79c1214b2849fd980324885d6bf67ce80a2bfa8388be8c4ad4de6c77b35842b4ca93a916da022ff9415ee7700231088dd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3990493f5d81154c77d3f22e166917eaa0aad8ecc95e61d1afb7eff5f9e4044cee80c5aad479340dffd2fddf9164276adaf46610b9defd49e7aa1e7357ce76a4"} 18:23:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:23:42 INFO - Copying logs to upload dir... 18:23:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:23:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.223057 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-25 18:23:42.160207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 18:23:42.163664) ========= 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.xZ0jxfcYFC/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.VQfTijawxU/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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/cc47275724b3ce51d930eb3b1dd6f380031500f2c0120826329142a85c0c2a1230109fc4c82cd5f90c2c70224436d7d59c57748397c6894d2d6600e9be18e8a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afb97c5597c7dbd2d91c044ac236fa47e7fb3c267600079b1fd7340c4ba536b3bf9487007e5e7130a92e95a99e53a6539bd26a42b12b0f61d9601761a1198710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57e6141eb84c4ead20ece6a9579aca79c1214b2849fd980324885d6bf67ce80a2bfa8388be8c4ad4de6c77b35842b4ca93a916da022ff9415ee7700231088dd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3990493f5d81154c77d3f22e166917eaa0aad8ecc95e61d1afb7eff5f9e4044cee80c5aad479340dffd2fddf9164276adaf46610b9defd49e7aa1e7357ce76a4"} build_url:https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010928 build_url: 'https://queue.taskcluster.net/v1/task/IvArxU-DSNmYIR-QqEboTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc47275724b3ce51d930eb3b1dd6f380031500f2c0120826329142a85c0c2a1230109fc4c82cd5f90c2c70224436d7d59c57748397c6894d2d6600e9be18e8a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afb97c5597c7dbd2d91c044ac236fa47e7fb3c267600079b1fd7340c4ba536b3bf9487007e5e7130a92e95a99e53a6539bd26a42b12b0f61d9601761a1198710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57e6141eb84c4ead20ece6a9579aca79c1214b2849fd980324885d6bf67ce80a2bfa8388be8c4ad4de6c77b35842b4ca93a916da022ff9415ee7700231088dd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3990493f5d81154c77d3f22e166917eaa0aad8ecc95e61d1afb7eff5f9e4044cee80c5aad479340dffd2fddf9164276adaf46610b9defd49e7aa1e7357ce76a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 18:23:42.198040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 18:23:42.198379) ========= 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.xZ0jxfcYFC/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.VQfTijawxU/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.005139 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 18:23:42.247097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 18:23:42.247413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 18:23:42.247729) ========= ========= Total master_lag: 0.19 =========