builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0294 starttime: 1481931385.58 results: success (0) buildid: 20161216134749 builduid: c1d5fd14e81344ddbda648eb43098927 revision: bfcf5b0b42992cec72a4728bb3a2145121aa86af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:25.578222) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:25.578595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:25.578862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:25.603601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:25.603892) ========= 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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 --2016-12-16 15:36:25-- 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% 157M=0s 2016-12-16 15:36:25 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115304 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:25.742335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:25.742643) ========= 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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.020108 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:25.790792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-16 15:36:25.791145) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bfcf5b0b42992cec72a4728bb3a2145121aa86af --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 bfcf5b0b42992cec72a4728bb3a2145121aa86af --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4z9LZNa9t1/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.zHuAjWfYLy/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 2016-12-16 15:36:25,873 truncating revision to first 12 chars 2016-12-16 15:36:25,873 Setting DEBUG logging. 2016-12-16 15:36:25,873 attempt 1/10 2016-12-16 15:36:25,873 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bfcf5b0b4299?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 15:36:27,266 unpacking tar archive at: mozilla-beta-bfcf5b0b4299/testing/mozharness/ program finished with exit code 0 elapsedTime=1.690664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-16 15:36:27.505241) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:27.505575) ========= script_repo_revision: bfcf5b0b42992cec72a4728bb3a2145121aa86af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:27.505953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:27.506233) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 15:36:27.526282) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-16 15:36:27.526678) ========= /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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:36:27 INFO - MultiFileLogger online at 20161216 15:36:27 in /builds/slave/test 15:36:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:36:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:36:27 INFO - {'append_to_log': False, 15:36:27 INFO - 'base_work_dir': '/builds/slave/test', 15:36:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:36:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:36:27 INFO - 'branch': 'Mozilla-Beta', 15:36:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:36:27 INFO - 'config_files': ('talos/mac_config.py',), 15:36:27 INFO - 'default_actions': ('clobber', 15:36:27 INFO - 'read-buildbot-config', 15:36:27 INFO - 'download-and-extract', 15:36:27 INFO - 'populate-webroot', 15:36:27 INFO - 'create-virtualenv', 15:36:27 INFO - 'install', 15:36:27 INFO - 'run-tests'), 15:36:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:36:27 INFO - 'download_minidump_stackwalk': True, 15:36:27 INFO - 'download_symbols': 'ondemand', 15:36:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:36:27 INFO - 'tooltool.py': '/tools/tooltool.py', 15:36:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:36:27 INFO - '/tools/misc-python/virtualenv.py')}, 15:36:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:36:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:36:27 INFO - 'installer_path': 'installer.exe', 15:36:27 INFO - 'log_level': 'info', 15:36:27 INFO - 'log_name': 'talos', 15:36:27 INFO - 'log_to_console': True, 15:36:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:36:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:36:27 INFO - 'opt_config_files': (), 15:36:27 INFO - 'pip_index': False, 15:36:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:36:27 INFO - 'cmd': ('bash', 15:36:27 INFO - '-c', 15:36:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:36:27 INFO - 'enabled': True, 15:36:27 INFO - 'halt_on_failure': False, 15:36:27 INFO - 'name': 'check_screen_resolution'},), 15:36:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:36:27 INFO - 'cmd': ('bash', 15:36:27 INFO - '-c', 15:36:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:36:27 INFO - 'enabled': True, 15:36:27 INFO - 'halt_on_failure': False, 15:36:27 INFO - 'name': 'check_screen_resolution'},), 15:36:27 INFO - 'run_cmd_checks_enabled': True, 15:36:27 INFO - 'sps_profile': False, 15:36:27 INFO - 'sps_profile_interval': 0, 15:36:27 INFO - 'suite': 'dromaeojs', 15:36:27 INFO - 'system_bits': '32', 15:36:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:36:27 INFO - 'title': 't-yosemite-r7-0294', 15:36:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:36:27 INFO - 'use_talos_json': True, 15:36:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:36:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:36:27 INFO - 'work_dir': 'build'} 15:36:27 INFO - [mozharness: 2016-12-16 23:36:27.719620Z] Running clobber step. 15:36:27 INFO - Running pre-action listener: _resource_record_pre_action 15:36:27 INFO - Running main action method: clobber 15:36:27 INFO - rmtree: /builds/slave/test/build 15:36:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:36:28 INFO - Running post-action listener: _resource_record_post_action 15:36:28 INFO - [mozharness: 2016-12-16 23:36:28.630536Z] Finished clobber step (success) 15:36:28 INFO - [mozharness: 2016-12-16 23:36:28.630656Z] Running read-buildbot-config step. 15:36:28 INFO - Running pre-action listener: _resource_record_pre_action 15:36:28 INFO - Running main action method: read_buildbot_config 15:36:28 INFO - Using buildbot properties: 15:36:28 INFO - { 15:36:28 INFO - "project": "", 15:36:28 INFO - "product": "firefox", 15:36:28 INFO - "script_repo_revision": "production", 15:36:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:36:28 INFO - "repository": "", 15:36:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:36:28 INFO - "buildid": "20161216134749", 15:36:28 INFO - "pgo_build": "False", 15:36:28 INFO - "basedir": "/builds/slave/test", 15:36:28 INFO - "buildnumber": 86, 15:36:28 INFO - "slavename": "t-yosemite-r7-0294", 15:36:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:36:28 INFO - "platform": "yosemite_r7", 15:36:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:36:28 INFO - "branch": "mozilla-beta", 15:36:28 INFO - "repo_path": "releases/mozilla-beta", 15:36:28 INFO - "revision": "bfcf5b0b42992cec72a4728bb3a2145121aa86af", 15:36:28 INFO - "stage_platform": "macosx64", 15:36:28 INFO - "builduid": "c1d5fd14e81344ddbda648eb43098927", 15:36:28 INFO - "slavebuilddir": "test" 15:36:28 INFO - } 15:36:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 15:36:28 INFO - Running post-action listener: _resource_record_post_action 15:36:28 INFO - [mozharness: 2016-12-16 23:36:28.633848Z] Finished read-buildbot-config step (success) 15:36:28 INFO - [mozharness: 2016-12-16 23:36:28.633946Z] Running download-and-extract step. 15:36:28 INFO - Running pre-action listener: _resource_record_pre_action 15:36:28 INFO - Running main action method: download_and_extract 15:36:28 INFO - mkdir: /builds/slave/test/build/tests 15:36: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')]} 15:36:28 INFO - trying https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 15:36:28 INFO - Downloading https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 15:36:29 INFO - Downloaded 1165 bytes. 15:36:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:36:29 INFO - Using the following test package requirements: 15:36:29 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:36:29 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:36:29 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 15:36:29 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:36:29 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 15:36:29 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:36:29 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:36:29 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 15:36:29 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:36:29 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:36:29 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 15:36:29 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:36:29 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 15:36:29 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:36:29 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 15:36:29 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:36:29 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 15:36:29 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 15:36:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:36:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:36:29 INFO - Fetch https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:36:30 INFO - Expected file size: 16232533 15:36:37 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:36:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:36:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:36:37 INFO - Fetch https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:36:37 INFO - Expected file size: 16232533 15:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 15:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 15:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 15:36:45 INFO - Expected file size: 14414089 15:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:45 INFO - trying https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:36:45 INFO - Downloading https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 15:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 15:36:47 INFO - Downloaded 86055744 bytes. 15:36:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:36:47 INFO - mkdir: /builds/slave/test/properties 15:36:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:36:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:36:47 INFO - Contents: 15:36:47 INFO - build_url:https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:36:48 INFO - Running post-action listener: _resource_record_post_action 15:36:48 INFO - Running post-action listener: set_extra_try_arguments 15:36:48 INFO - [mozharness: 2016-12-16 23:36:48.654361Z] Finished download-and-extract step (success) 15:36:48 INFO - [mozharness: 2016-12-16 23:36:48.654482Z] Running populate-webroot step. 15:36:48 INFO - Running pre-action listener: _resource_record_pre_action 15:36:48 INFO - Running main action method: populate_webroot 15:36:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:36:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:36:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:36:48 INFO - '--tppagecycles', 15:36:48 INFO - '7'], 15:36:48 INFO - 'tests': ['tsvgm']}}, 15:36:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:36:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:36:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:36:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:36:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:48 INFO - 'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:48 INFO - 'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['damp', 'tps']}, 15:36:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:48 INFO - 'tests': ['damp', 'tps']}, 15:36:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['dromaeo_dom']}, 15:36:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:36:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['basic_compositor_video']}, 15:36:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:36:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['a11yr', 15:36:48 INFO - 'ts_paint', 15:36:48 INFO - 'tpaint', 15:36:48 INFO - 'sessionrestore', 15:36:48 INFO - 'sessionrestore_no_auto_restore', 15:36:48 INFO - 'tabpaint']}, 15:36:48 INFO - 'other-e10s': {'tests': ['a11yr', 15:36:48 INFO - 'ts_paint', 15:36:48 INFO - 'tpaint', 15:36:48 INFO - 'sessionrestore', 15:36:48 INFO - 'sessionrestore_no_auto_restore', 15:36:48 INFO - 'tabpaint']}, 15:36:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:36:48 INFO - 'ts_paint', 15:36:48 INFO - 'tpaint', 15:36:48 INFO - 'sessionrestore', 15:36:48 INFO - 'sessionrestore_no_auto_restore', 15:36:48 INFO - 'tabpaint']}, 15:36:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:36:48 INFO - 'ts_paint', 15:36:48 INFO - 'tpaint', 15:36:48 INFO - 'sessionrestore', 15:36:48 INFO - 'sessionrestore_no_auto_restore', 15:36:48 INFO - 'tabpaint']}, 15:36:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['a11yr', 15:36:48 INFO - 'ts_paint', 15:36:48 INFO - 'tpaint', 15:36:48 INFO - 'sessionrestore', 15:36:48 INFO - 'sessionrestore_no_auto_restore', 15:36:48 INFO - 'tabpaint']}, 15:36:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['a11yr', 15:36:48 INFO - 'ts_paint', 15:36:48 INFO - 'tpaint', 15:36:48 INFO - 'sessionrestore', 15:36:48 INFO - 'sessionrestore_no_auto_restore', 15:36:48 INFO - 'tabpaint']}, 15:36:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['tsvgx', 15:36:48 INFO - 'tsvgr_opacity', 15:36:48 INFO - 'tart', 15:36:48 INFO - 'tscrollx', 15:36:48 INFO - 'cart']}, 15:36:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:36:48 INFO - 'tsvgr_opacity', 15:36:48 INFO - 'tart', 15:36:48 INFO - 'tscrollx', 15:36:48 INFO - 'cart']}, 15:36:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:48 INFO - 'talos_options': ['--disable-e10s'], 15:36:48 INFO - 'tests': ['tp5o']}, 15:36:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:48 INFO - 'tests': ['tp5o']}, 15:36:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:48 INFO - 'talos_options': ['--disable-e10s', 15:36:48 INFO - '--xperf_path', 15:36:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:48 INFO - 'tests': ['tp5n']}, 15:36:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:48 INFO - 'talos_options': ['--xperf_path', 15:36:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:48 INFO - 'tests': ['tp5n']}}, 15:36:48 INFO - 'talos.zip': {'path': '', 15:36:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:36:48 INFO - Running post-action listener: _resource_record_post_action 15:36:48 INFO - [mozharness: 2016-12-16 23:36:48.673175Z] Finished populate-webroot step (success) 15:36:48 INFO - [mozharness: 2016-12-16 23:36:48.673314Z] Running create-virtualenv step. 15:36:48 INFO - Running pre-action listener: _resource_record_pre_action 15:36:48 INFO - Running main action method: create_virtualenv 15:36:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:36:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:36:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:36:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:36:48 INFO - Using real prefix '/tools/python27' 15:36:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:36:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:36:52 INFO - Installing pip.................done. 15:36:52 INFO - Return code: 0 15:36:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:52 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 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:52 INFO - 'HOME': '/Users/cltbld', 15:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:52 INFO - 'LOGNAME': 'cltbld', 15:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:52 INFO - 'MOZ_NO_REMOTE': '1', 15:36:52 INFO - 'NO_EM_RESTART': '1', 15:36:52 INFO - 'PAGER': '/bin/cat', 15:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:52 INFO - 'PWD': '/builds/slave/test', 15:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:52 INFO - 'SHELL': '/bin/bash', 15:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:36:52 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:52 INFO - 'USER': 'cltbld', 15:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:52 INFO - 'XPC_FLAGS': '0x0', 15:36:52 INFO - 'XPC_SERVICE_NAME': '0', 15:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:36:52 INFO - Cleaning up... 15:36:52 INFO - Return code: 0 15:36:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:52 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 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:52 INFO - 'HOME': '/Users/cltbld', 15:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:52 INFO - 'LOGNAME': 'cltbld', 15:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:52 INFO - 'MOZ_NO_REMOTE': '1', 15:36:52 INFO - 'NO_EM_RESTART': '1', 15:36:52 INFO - 'PAGER': '/bin/cat', 15:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:52 INFO - 'PWD': '/builds/slave/test', 15:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:52 INFO - 'SHELL': '/bin/bash', 15:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:36:52 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:52 INFO - 'USER': 'cltbld', 15:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:52 INFO - 'XPC_FLAGS': '0x0', 15:36:52 INFO - 'XPC_SERVICE_NAME': '0', 15:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:53 INFO - Downloading/unpacking psutil>=3.1.1 15:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:36:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:56 INFO - Installing collected packages: psutil 15:36:56 INFO - Running setup.py install for psutil 15:36:56 INFO - building 'psutil._psutil_osx' extension 15:36:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:36:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:36:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:36:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:36:57 INFO - building 'psutil._psutil_posix' extension 15:36:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:36:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:36:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:36:57 INFO - ^ 15:36:57 INFO - 1 warning generated. 15:36:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:36:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:57 INFO - Successfully installed psutil 15:36:57 INFO - Cleaning up... 15:36:57 INFO - Return code: 0 15:36:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:57 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 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:57 INFO - 'HOME': '/Users/cltbld', 15:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:57 INFO - 'LOGNAME': 'cltbld', 15:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:57 INFO - 'MOZ_NO_REMOTE': '1', 15:36:57 INFO - 'NO_EM_RESTART': '1', 15:36:57 INFO - 'PAGER': '/bin/cat', 15:36:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:57 INFO - 'PWD': '/builds/slave/test', 15:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:57 INFO - 'SHELL': '/bin/bash', 15:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:36:57 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:57 INFO - 'USER': 'cltbld', 15:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:57 INFO - 'XPC_FLAGS': '0x0', 15:36:57 INFO - 'XPC_SERVICE_NAME': '0', 15:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:37:00 INFO - Installing collected packages: mozsystemmonitor 15:37:00 INFO - Running setup.py install for mozsystemmonitor 15:37:00 INFO - Successfully installed mozsystemmonitor 15:37:00 INFO - Cleaning up... 15:37:00 INFO - Return code: 0 15:37:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:00 INFO - 'HOME': '/Users/cltbld', 15:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:00 INFO - 'LOGNAME': 'cltbld', 15:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:00 INFO - 'MOZ_NO_REMOTE': '1', 15:37:00 INFO - 'NO_EM_RESTART': '1', 15:37:00 INFO - 'PAGER': '/bin/cat', 15:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:00 INFO - 'PWD': '/builds/slave/test', 15:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:00 INFO - 'SHELL': '/bin/bash', 15:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:37:00 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:00 INFO - 'USER': 'cltbld', 15:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:00 INFO - 'XPC_FLAGS': '0x0', 15:37:00 INFO - 'XPC_SERVICE_NAME': '0', 15:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:00 INFO - Downloading/unpacking jsonschema==2.5.1 15:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:37:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:37:03 INFO - warning: no files found matching '*.txt' 15:37:03 INFO - no previously-included directories found matching 'build' 15:37:03 INFO - no previously-included directories found matching 'dist' 15:37:03 INFO - no previously-included directories found matching '.git*' 15:37:03 INFO - Installing collected packages: jsonschema, functools32 15:37:03 INFO - Running setup.py install for functools32 15:37:04 INFO - warning: no files found matching '*.txt' 15:37:04 INFO - no previously-included directories found matching 'build' 15:37:04 INFO - no previously-included directories found matching 'dist' 15:37:04 INFO - no previously-included directories found matching '.git*' 15:37:04 INFO - Successfully installed jsonschema functools32 15:37:04 INFO - Cleaning up... 15:37:04 INFO - Return code: 0 15:37:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:04 INFO - 'HOME': '/Users/cltbld', 15:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:04 INFO - 'LOGNAME': 'cltbld', 15:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:04 INFO - 'MOZ_NO_REMOTE': '1', 15:37:04 INFO - 'NO_EM_RESTART': '1', 15:37:04 INFO - 'PAGER': '/bin/cat', 15:37:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:04 INFO - 'PWD': '/builds/slave/test', 15:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:04 INFO - 'SHELL': '/bin/bash', 15:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:37:04 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:04 INFO - 'USER': 'cltbld', 15:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:04 INFO - 'XPC_FLAGS': '0x0', 15:37:04 INFO - 'XPC_SERVICE_NAME': '0', 15:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:37:04 INFO - Cleaning up... 15:37:04 INFO - Return code: 0 15:37:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:04 INFO - 'HOME': '/Users/cltbld', 15:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:04 INFO - 'LOGNAME': 'cltbld', 15:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:04 INFO - 'MOZ_NO_REMOTE': '1', 15:37:04 INFO - 'NO_EM_RESTART': '1', 15:37:04 INFO - 'PAGER': '/bin/cat', 15:37:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:04 INFO - 'PWD': '/builds/slave/test', 15:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:04 INFO - 'SHELL': '/bin/bash', 15:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:37:04 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:04 INFO - 'USER': 'cltbld', 15:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:04 INFO - 'XPC_FLAGS': '0x0', 15:37:04 INFO - 'XPC_SERVICE_NAME': '0', 15:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:37:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:37:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:08 INFO - Downloading docopt-0.6.1.tar.gz 15:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:37:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:37:08 INFO - Running setup.py install for blobuploader 15:37:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:37:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:37:08 INFO - Running setup.py install for requests 15:37:09 INFO - Running setup.py install for docopt 15:37:09 INFO - Successfully installed blobuploader requests docopt 15:37:09 INFO - Cleaning up... 15:37:09 INFO - Return code: 0 15:37:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:09 INFO - 'HOME': '/Users/cltbld', 15:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:09 INFO - 'LOGNAME': 'cltbld', 15:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:09 INFO - 'MOZ_NO_REMOTE': '1', 15:37:09 INFO - 'NO_EM_RESTART': '1', 15:37:09 INFO - 'PAGER': '/bin/cat', 15:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:09 INFO - 'PWD': '/builds/slave/test', 15:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:09 INFO - 'SHELL': '/bin/bash', 15:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:37:09 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:09 INFO - 'USER': 'cltbld', 15:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:09 INFO - 'XPC_FLAGS': '0x0', 15:37:09 INFO - 'XPC_SERVICE_NAME': '0', 15:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:09 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-VY6p8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:09 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-E8V1m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:09 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-MYEp36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:09 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-OY4tyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-yIWxIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-PeiOSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-m6MEY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-UDltPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-uRKHrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Xopny2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Ogz9gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Z__0nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:37:10 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-faSoyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:37:11 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-gqngkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:11 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-c7pRfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:37:11 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-d3bdc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:37:11 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-YDnxmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:37:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:37:11 INFO - Running setup.py install for manifestparser 15:37:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:37:11 INFO - Running setup.py install for mozcrash 15:37:11 INFO - Running setup.py install for mozdebug 15:37:11 INFO - Running setup.py install for mozdevice 15:37:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:37:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:37:12 INFO - Running setup.py install for mozfile 15:37:12 INFO - Running setup.py install for mozhttpd 15:37:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:37:12 INFO - Running setup.py install for mozinfo 15:37:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:37:12 INFO - Running setup.py install for mozInstall 15:37:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:37:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:37:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:37:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:37:12 INFO - Running setup.py install for mozleak 15:37:12 INFO - Running setup.py install for mozlog 15:37:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:37:13 INFO - Running setup.py install for moznetwork 15:37:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:37:13 INFO - Running setup.py install for mozprocess 15:37:13 INFO - Running setup.py install for mozprofile 15:37:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:37:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:37:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:37:13 INFO - Running setup.py install for mozrunner 15:37:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:37:13 INFO - Running setup.py install for mozscreenshot 15:37:13 INFO - Running setup.py install for moztest 15:37:13 INFO - Running setup.py install for mozversion 15:37:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:37:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:37:14 INFO - Cleaning up... 15:37:14 INFO - Return code: 0 15:37:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:14 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 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:14 INFO - 'HOME': '/Users/cltbld', 15:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:14 INFO - 'LOGNAME': 'cltbld', 15:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:14 INFO - 'MOZ_NO_REMOTE': '1', 15:37:14 INFO - 'NO_EM_RESTART': '1', 15:37:14 INFO - 'PAGER': '/bin/cat', 15:37:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:14 INFO - 'PWD': '/builds/slave/test', 15:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:14 INFO - 'SHELL': '/bin/bash', 15:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:37:14 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:14 INFO - 'USER': 'cltbld', 15:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:14 INFO - 'XPC_FLAGS': '0x0', 15:37:14 INFO - 'XPC_SERVICE_NAME': '0', 15:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:14 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-1eNJ6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:14 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-uGvcQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:14 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-jmHBIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:14 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-0ZCpjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:14 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Ta86QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:37:14 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-MJo4Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-pA_kmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-otzNGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-PjmBik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Cu3dVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Ncrdy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-IKO1HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-WZqkdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-4xUgXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-ljDd2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:37:15 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-v2ddT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:37:16 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-5Nlvt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:37:16 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:37:16 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:37:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37:18 INFO - Downloading blessings-1.6.tar.gz 15:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:37:18 INFO - Installing collected packages: blessings 15:37:18 INFO - Running setup.py install for blessings 15:37:19 INFO - Successfully installed blessings 15:37:19 INFO - Cleaning up... 15:37:19 INFO - Return code: 0 15:37:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:37:19 INFO - Reading from file tmpfile_stdout 15:37:19 INFO - Current package versions: 15:37:19 INFO - blessings == 1.6 15:37:19 INFO - blobuploader == 1.2.4 15:37:19 INFO - docopt == 0.6.1 15:37:19 INFO - functools32 == 3.2.3-2 15:37:19 INFO - jsonschema == 2.5.1 15:37:19 INFO - manifestparser == 1.1 15:37:19 INFO - mozInstall == 1.12 15:37:19 INFO - mozcrash == 0.17 15:37:19 INFO - mozdebug == 0.1 15:37:19 INFO - mozdevice == 0.48 15:37:19 INFO - mozfile == 1.2 15:37:19 INFO - mozhttpd == 0.7 15:37:19 INFO - mozinfo == 0.9 15:37:19 INFO - mozleak == 0.1 15:37:19 INFO - mozlog == 3.4 15:37:19 INFO - moznetwork == 0.27 15:37:19 INFO - mozprocess == 0.23 15:37:19 INFO - mozprofile == 0.28 15:37:19 INFO - mozrunner == 6.12 15:37:19 INFO - mozscreenshot == 0.1 15:37:19 INFO - mozsystemmonitor == 0.3 15:37:19 INFO - moztest == 0.7 15:37:19 INFO - mozversion == 1.4 15:37:19 INFO - psutil == 3.1.1 15:37:19 INFO - requests == 1.2.3 15:37:19 INFO - wsgiref == 0.1.2 15:37:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37: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')]} 15:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37: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')]} 15:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:19 INFO - 'HOME': '/Users/cltbld', 15:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:19 INFO - 'LOGNAME': 'cltbld', 15:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:19 INFO - 'MOZ_NO_REMOTE': '1', 15:37:19 INFO - 'NO_EM_RESTART': '1', 15:37:19 INFO - 'PAGER': '/bin/cat', 15:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:19 INFO - 'PWD': '/builds/slave/test', 15:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:19 INFO - 'SHELL': '/bin/bash', 15:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:37:19 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:19 INFO - 'USER': 'cltbld', 15:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:19 INFO - 'XPC_FLAGS': '0x0', 15:37:19 INFO - 'XPC_SERVICE_NAME': '0', 15:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:37:19 INFO - Cleaning up... 15:37:19 INFO - Return code: 0 15:37:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:37: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')]} 15:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37: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')]} 15:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9f8cab500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, '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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:19 INFO - 'HOME': '/Users/cltbld', 15:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:19 INFO - 'LOGNAME': 'cltbld', 15:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:19 INFO - 'MOZ_NO_REMOTE': '1', 15:37:19 INFO - 'NO_EM_RESTART': '1', 15:37:19 INFO - 'PAGER': '/bin/cat', 15:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:19 INFO - 'PWD': '/builds/slave/test', 15:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:19 INFO - 'SHELL': '/bin/bash', 15:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:37:19 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:19 INFO - 'USER': 'cltbld', 15:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:19 INFO - 'XPC_FLAGS': '0x0', 15:37:19 INFO - 'XPC_SERVICE_NAME': '0', 15:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:37:19 INFO - Cleaning up... 15:37:19 INFO - Return code: 0 15:37:19 INFO - Running post-action listener: _resource_record_post_action 15:37:19 INFO - Running post-action listener: _start_resource_monitoring 15:37:19 INFO - Starting resource monitoring. 15:37:19 INFO - [mozharness: 2016-12-16 23:37:19.976354Z] Finished create-virtualenv step (success) 15:37:19 INFO - [mozharness: 2016-12-16 23:37:19.977351Z] Running install step. 15:37:19 INFO - Running pre-action listener: _resource_record_pre_action 15:37:19 INFO - Running main action method: install 15:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:37:20 INFO - Reading from file tmpfile_stdout 15:37:20 INFO - Detecting whether we're running mozinstall >=1.0... 15:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:37:20 INFO - Reading from file tmpfile_stdout 15:37:20 INFO - Output received: 15:37:20 INFO - Usage: mozinstall [options] installer 15:37:20 INFO - Options: 15:37:20 INFO - -h, --help show this help message and exit 15:37:20 INFO - -d DEST, --destination=DEST 15:37:20 INFO - Directory to install application into. [default: 15:37:20 INFO - "/builds/slave/test"] 15:37:20 INFO - --app=APP Application being installed. [default: firefox] 15:37:20 INFO - mkdir: /builds/slave/test/build/application 15:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:37:42 INFO - Reading from file tmpfile_stdout 15:37:42 INFO - Output received: 15:37:42 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:37:42 INFO - Running post-action listener: _resource_record_post_action 15:37:42 INFO - [mozharness: 2016-12-16 23:37:42.945429Z] Finished install step (success) 15:37:42 INFO - [mozharness: 2016-12-16 23:37:42.945594Z] Running run-tests step. 15:37:42 INFO - Running pre-action listener: _resource_record_pre_action 15:37:42 INFO - Running main action method: run_tests 15:37:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:37:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:37:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:37:42 INFO - 2016-12-16 15:37:42.960 screenresolution[2195:21025] starting screenresolution argv=screenresolution get 15:37:42 INFO - 2016-12-16 15:37:42.963 screenresolution[2195:21025] Display 0: 1600x1200x32@60 15:37:42 INFO - 2016-12-16 15:37:42.969 screenresolution[2196:21028] starting screenresolution argv=screenresolution list 15:37:42 INFO - Available Modes on Display 0 15:37:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:37:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:37:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:37:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:37:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:37:43 INFO - Intel Iris: 15:37:43 INFO - Chipset Model: Intel Iris 15:37:43 INFO - Type: GPU 15:37:43 INFO - Bus: Built-In 15:37:43 INFO - VRAM (Dynamic, Max): 1536 MB 15:37:43 INFO - Vendor: Intel (0x8086) 15:37:43 INFO - Device ID: 0x0a2e 15:37:43 INFO - Revision ID: 0x0009 15:37:43 INFO - Displays: 15:37:43 INFO - Display: 15:37:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:37:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:37:43 INFO - Display Serial Number: 1600x1200 60 15:37:43 INFO - Main Display: Yes 15:37:43 INFO - Mirror: Off 15:37:43 INFO - Online: Yes 15:37:43 INFO - Rotation: Supported 15:37:43 INFO - Return code: 0 15:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:37:43 INFO - Python 2.7.3 15:37:43 INFO - Return code: 0 15:37:43 INFO - grabbing minidump binary from tooltool 15:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:43 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 0x106a8cd30>, '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 0x1068f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a84b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:37:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:37:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:37:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:37:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:37:43 INFO - Return code: 0 15:37:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:37:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:37:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:37:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:37:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:37:43 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/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:37:43 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/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0294 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4z9LZNa9t1/Render', 15:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:43 INFO - 'HOME': '/Users/cltbld', 15:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:43 INFO - 'LOGNAME': 'cltbld', 15:37:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:37:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:43 INFO - 'MOZ_NO_REMOTE': '1', 15:37:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:37:43 INFO - 'NO_EM_RESTART': '1', 15:37:43 INFO - 'PAGER': '/bin/cat', 15:37:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:43 INFO - 'PWD': '/builds/slave/test', 15:37:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:43 INFO - 'SHELL': '/bin/bash', 15:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zHuAjWfYLy/Listeners', 15:37:43 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 15:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:43 INFO - 'USER': 'cltbld', 15:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:43 INFO - 'XPC_FLAGS': '0x0', 15:37:43 INFO - 'XPC_SERVICE_NAME': '0', 15:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:43 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/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:37:43 INFO - mozversion application_buildid: 20161216134749 15:37:43 INFO - mozversion application_changeset: bfcf5b0b42992cec72a4728bb3a2145121aa86af 15:37:43 INFO - mozversion application_display_name: Firefox 15:37:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:37:43 INFO - mozversion application_name: Firefox 15:37:43 INFO - mozversion application_remotingname: firefox 15:37:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:37:43 INFO - mozversion application_vendor: Mozilla 15:37:43 INFO - mozversion application_version: 51.0 15:37:43 INFO - mozversion platform_buildid: 20161216134749 15:37:43 INFO - mozversion platform_changeset: bfcf5b0b42992cec72a4728bb3a2145121aa86af 15:37:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:37:43 INFO - mozversion platform_version: 51.0 15:37:43 INFO - using testdate: 1481931463 15:37:43 INFO - actual date: 1481931463 15:37:43 INFO - starting webserver on 'localhost:52509' 15:37:43 INFO - SUITE-START | Running 2 tests 15:37:43 INFO - TEST-START | dromaeo_css 15:37:43 INFO - operating with platform_type : mac_ 15:37:43 INFO - Initialising browser for dromaeo_css test... 15:37:43 INFO - TEST-INFO | started process 2206 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpOxUcso/profile http://localhost:52509/getInfo.html) 15:37:45 INFO - PROCESS | 2206 | __metrics Screen width/height:1600/1200 15:37:45 INFO - PROCESS | 2206 | colorDepth:24 15:37:45 INFO - PROCESS | 2206 | Browser inner width/height: 1024/689 15:37:45 INFO - PROCESS | 2206 | __metrics 15:37:45 INFO - PROCESS | 2206 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:37:45 INFO - PROCESS | 2206 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:37:46 INFO - TEST-INFO | 2206: exit 0 15:37:46 INFO - Browser initialized. 15:37:46 INFO - Running cycle 1/1 for dromaeo_css test... 15:37:46 INFO - TEST-INFO | started process 2209 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpOxUcso/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:58 INFO - PROCESS | 2209 | RSS: Main: 168845312 15:37:58 INFO - PROCESS | 2209 | 15:38:49 INFO - PROCESS | 2209 | 1481931529573 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:41:00 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:52509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52509/tests/dromaeo/cssquery-ext.html) 15:41:02 INFO - PROCESS | 2209 | RSS: Main: 303656960 15:41:02 INFO - PROCESS | 2209 | 15:44:05 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:52509/tests/dromaeo/cssquery-ext.html (next: http://localhost:52509/tests/dromaeo/cssquery-jquery.html) 15:44:05 INFO - PROCESS | 2209 | RSS: Main: 301150208 15:44:05 INFO - PROCESS | 2209 | 15:47:07 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:52509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52509/tests/dromaeo/cssquery-mootools.html) 15:47:08 INFO - PROCESS | 2209 | RSS: Main: 274141184 15:47:08 INFO - PROCESS | 2209 | 15:50:10 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:52509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52509/tests/dromaeo/cssquery-prototype.html) 15:50:11 INFO - PROCESS | 2209 | RSS: Main: 260304896 15:50:11 INFO - PROCESS | 2209 | 15:53:14 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:52509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52509/tests/dromaeo/cssquery-yui.html) 15:53:15 INFO - PROCESS | 2209 | RSS: Main: 257736704 15:53:15 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:52509/tests/dromaeo/cssquery-yui.html (next: http://localhost:52509/tests/dromaeo/cssquery-dojo.html) 15:56:18 INFO - PROCESS | 2209 | RSS: Main: 351363072 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | __start_tp_report 15:56:18 INFO - PROCESS | 2209 | _x_x_mozilla_page_load 15:56:18 INFO - PROCESS | 2209 | _x_x_mozilla_page_load_details 15:56:18 INFO - PROCESS | 2209 | |i|pagename|runs| 15:56:18 INFO - PROCESS | 2209 | |0;dojo.html;3360.7983520988737;3367.2255381262307;3389.2035371687634;3421.743369247307;3456.1014136324566;5853.268341457318;5926.9999999999945;5936.970315148418;5945.286565612128;5959.851003724909;5891;5931.673757943311;5948.196993405889;5959.374265702104;5960.225170727799;4357.43353364063;5261.8704102162255;5320.733963301819;5342.492463215988;5342.759575819078;5239.161734122541;5241.554467870235;5247.737613119348;5261.289725886994;5342.225377320306;4535.886602834922;5200.29795977542;5361.303030606015;5363.785448582072;5366.758495867676;5358.169483730028;5362.3029006229135;5371.57027437804;5377.704226267554;5414.485623865727;5174.094533456668;5249.816256431007;5299.231611416323;5311.760970756325;5323.813666521653;4336.457942757155;5736.455036771542;5767;5867.618604790675;5886.499647529965;5154.484551544815;6210.844728881769;6240.719167637421;6252.124702541648;6267.059941008885;6220.720067596969;6244.500439964792;6245.7501699931945;6267.780627678055;6294.779682711083;4849.975750121227;5432.75552600134;5742.138679198112;5884.293884733859;5950.6132101413705;5696.287964004499;5808.3901190375245;6019.608725432833;6323.683815809191;6327.430531252117;6241.469475094668;6265.843353916189;6269.7492100316385;6278.529110316653;6278.780242691484;6200.689965501707;6233.812985610439;6254.749810007549;6255.624662520263;6273.0904018917;6301.653409062454;6303.905441418382;6305.558610897285;6322.652254125976;6330.303666596671;6240.656763878031;6288.056791481223;6297.464715499143;6331.398517140864;6339;4997.600191984632;5026.4973502649445;5036.7733451994745;5045.747712614355;5085.3134826797905;4460.77696115193;4532.7280363178315;4534.093181363741;4541.43232095988;4602.516735742765;5917.852053698606;5920.970395147997;5921.289445266596;5923;5932.525397968152;6112.807455516588;6249.875002499924;6252.499800015988;6264.749410023548;6292.559520833589;5789.652620842763;5807.361190269067;5865.384134665798;5889.087191485327;5894.204282421904;5524;5524.613277070647;5546.944530554642;5558.666480011212;5562.972185139049;6270.529710271748;6286.37136286386;6312.968435157794;6358.618482891041;6371.108044873721;6260.092286618506;6266.216722909637;6267.843303917439;6269.780557680459;6275.96862015687;6379.2344918608205;6387.520935929917;6393.392627700361;6401.103845461732;6429.067785171217;6131.315499379051;6172.629642221481;6220.098085777447;6220.502359811295;6261.62430254168;6245.28179259391;6277.96861015692;6279.874402511833;6285.811425657238;6299.897517934435;6269.843253918689;6274.278457977391;6274.498040156685;6286.811395658137;6300.086487459201;6103.267607887082;6115.388461153849;6142.867137759686;6263.311035786151;6272.905906411316;6045.637261764308;6145.125736650364;6155.630662160284;6161.691915404302;6169.2288463942;6253.030780229072;6255.093011513396;6255.218097737783;6261.154744109669;6278.874422511615;6012.428819262163;6049.727762250621;6112.449879510866;6113.786017489367;6133.294671112879 15:56:18 INFO - PROCESS | 2209 | |1;ext.html;476.3045952908754;497.7357511919724;532.7336331834083;543.2882923370382;568.3634329550904;31401.214969625744;33407.83296083516;33483.330333393315;33506.329873402516;41353.7932310338;43494;43851.56148438522;43865.34201986965;43890.7805460973;43927.560724392744;9961.900380996189;10122.342047766908;10142.594296228142;10143.23925705575;10157.238207134458;9387.342885997983;9612.951935240313;9757.073078057572;12240.44917978693;12565.623031309075;12460.750784984295;12494;12508.624741257778;12513.687157821081;12538.247705137675;12485.313307768069;12567.120301578892;12575.434105465185;12589.496420143183;12600.495980160782;12316.692082697915;12373.13388062836;12384.442700078518;12393.566225182076;12403.503859845596;41487;41762.791186043876;41772;41884.79057604692;41887;3384.830758462067;3462.0998540379433;3598.874039408608;3695.7043436525014;4171.499420069611;32055.83972080148;32063.19842003945;32084.03747887567;32411.675883241103;32901.50647740286;3121.2352973521633;3215.8070515769127;3290.93418131636;3303.620083690358;3349.9665003349896;482567;484266;485797;485852;486096.6951652403;61657.38342616606;62153;62183;62269.37730622636;62283.75432491415;35466.64533354685;36195.819020904724;36280.274394511966;37465;37522.62477375246;17478.563035924202;17674.558136046446;17675.027873467083;17684.557886052695;17696.91151544234;12332.938335308267;13495.797563036562;13548.390322435316;13590.59228223155;13597.184168949894;16850.915745421193;19428.805711942983;19727.802721972595;19728.70406943897;20121.893295868867;6957.408620267232;7696.230376962259;7886.250806173519;8000.35997120229;8002.439829212016;805.7864665863551;939.3424602778083;1024.9180065594883;1071.9464026798628;1085.755704966392;29868.9545865898;30244.697553024627;30334.78660853541;30959.0712278632;30999;1019.4698756646502;1104.745908441063;1122.0686829931137;1175.024729474534;1215.3619349841226;13079;15649.217539122998;15655.843441565667;15702.21488925572;16073.196340182943;614595;619969;621525;622985.8850705718;623233;57670.134947975814;58152.4184758147;58254.4174558249;58294.7085264571;58301.70849145727;1289.3939848271298;1336.0580790542838;1433.6200906759716;1437.5615437291517;1458.2344269258724;29493.967711130008;31996.20009499781;32244;32402.67597324091;32603.02190934276;49443.76390590264;50238.497615023385;50274.99450011052;50450.495495046045;50479;565581;572732;573396;575305;576632;30687.846560767055;37096.07259818418;37459.81270093741;41964.790176048926;45757.08485830198;46038.309425359315;46902.76548617235;47046.29430558476;47334.28998565093;47737.76131119322;34474;38629.806850965564;38802.6431016637;39880.80059599799;40767.59232407757;38898;39528.80235598804;40305.99235019031;40569.98575035648;40675.186496269314;37476.25047499089;38013.049673758374;38207;38263;38833;33105;34916.28569584935;34956.650433496354;35268.64731352653;35353;26023.349416264744;26039.218823435327;26097.347566310993;26225.475490490466;26637.334066648487 15:56:18 INFO - PROCESS | 2209 | |2;jquery.html;378.94884190634264;380.76012112369204;391.3405911039897;397.48724145851855;411.2782067471587;19861.20555177793;21547.24584639538;21551.13795448184;21868.562628747415;22764.54470910585;21239.469013274636;21449.785502144972;21852.781472185274;22066.44833879154;22203.888980555075;5753.194552762606;6278.905816412757;6340.8097757067135;6344.3655634436645;6353.8411539711415;5977.31260904995;6173.1048997895505;6219.471344935663;6263.906041409383;6279.654618995954;6211.689415529206;6216.658083805389;6225.408586184328;6227.470664993481;6237;5944.613600116;6158.353372895848;6199.256089269294;6233.906491402633;6235.064740288947;4948.901021979576;5307.071262529081;5458.1266997280645;5469.371022332403;5470.8085217017215;26370.868145659148;26724.599131013052;26741;27018.5947210792;27023;2092.696558998937;2346.917857874966;2604.4009877728226;2607.647967524379;3044.604201453819;15186.164760938143;15701.607459813482;15702.607434814106;16540.338386464526;16554.917225413796;1784.4361380626722;1992.2429476798868;1996.3611644273838;2011.8994050297426;2036.75558932929;89852;114197.42901285441;120803;120922.3953880225;121186;9553.952230238805;9624.230061595055;11027.44862756859;11506.76986460266;11518.078553715683;14594.197319147548;14605;14605.707885842436;14614.34235459407;14615;8659.004214515411;8916.19754222123;8970.775730606656;9080.593642684695;9098.363114582047;7351.852962940711;9000.594973226089;9003.594838232295;9158.587863546156;9171.037041110721;6348.206474190726;6368.5860419072615;6793.422559082434;6918.8962165567555;6935.861282774316;1702.6594681063837;1802.2790883646385;1823.601963418101;1841.4475657302755;1876.8310852023383;755.4560716284267;881.3962435731416;964.2960638733764;996.5216695985968;1093.2893619147458;22594.322170334915;23144.3056708299;23163.53672926532;23182.42043948915;23291.88354058219;881.7751473374249;902.873597696323;910.9180173784391;1011.1910471622673;1076.7577295108538;11766.705832354259;12119.818202726967;12183.390830458442;12312.753744925052;12400.255984640951;532896;590238;593273;606222;607788;65962.67018664876;79799;84861.57569212114;98605;113931.43034284776;982.189693502863;997.1922742578535;1037.8858325584179;1042.6038105519854;1044.38903241603;20662.380128596167;20885.477863052936;21237.030451432223;21424.464388390414;21590.784092158876;38465;41211.38182927199;53723;54005.729971349894;54435.45564544304;58803;70475.9428608561;72141;75295;76298;8059.274665280153;8212.260896519341;8437.11410301934;8486.448380855225;8615.82768344617;11695.657552888779;13562.254076025913;13732.862671373558;13959.23224222637;14190.432382704988;11423.200375973935;11596.594119205787;11666.76666466649;11802.468888899848;11890.227135236528;11478.426078696199;11492.770144597229;11675.182737208654;11937.28376297425;12120.030397567996;9958;11610.419479026184;11669.12481563903;11836.526538938346;12005.159638825198;8206.753797386087;8292.709755158781;8382.748517544484;8480.236778689947;8497.915020849712;11468.483918223867;11683.941580292045;11741.941290293495;11779.52881884715;12103.51585936588 15:56:18 INFO - PROCESS | 2209 | |3;mootools.html;1491.5823569400568;1530.5943924859914;1732.7227643577023;1898.9810101898977;1904.0194299935545;8601.741947741562;9183;9201.309901757362;9202.769930751734;9211.861822072666;8120.796980075501;8376.994760628719;8815.118488151182;9014.459132452057;9018.819623607524;2434.9269521914325;2453.031052734178;2460.4218008767925;2461.5569197544437;2466.124525793344;2405.822427865045;2460.7416221296776;2462.4090218347646;2462.704475462938;2462.827602067856;2429.8056155507516;2440.707115146185;2454.435479839638;2457;2457.8893949772305;2423.09134074722;2427.2839512343903;2438.8292819502553;2447.155731272708;2450.3261603059123;2319.0491898321775;2330.8018818400287;2331.1258278145697;2334.988325058364;2337.6610391493136;9035.954820225857;9123.315751318678;9131.81736365269;9138.68014619485;9138.725838224864;5350.678959262418;5514.944850551483;5515.7242137892945;5515.862103447446;5532.336119665666;3513.2797776455764;3635.4001589737663;3692.6307369263127;3709.1283548366114;3729.925401491982;1038.48075962019;1066.9253152279343;1071.266182664877;1083.3932997521413;1088.434014312561;12034.759304813855;12098.274103553815;12135.393230338448;12136;12172.2696638202;4797.7601119943865;4869.513048695173;4870.14772414826;4946.826861059845;4988.575971042429;10191.745206369751;10194.216012197836;10195.592176312864;10206.948965255126;10211.489425528694;5509.338879334506;5513;5516.062269414209;5529.806456773994;5533.861653458695;4595.241785105421;4719.787609557578;4763.69036012658;4986.376702912136;5055.34280543527;3560.3413368526903;4047.6238079053264;4052.5339585947404;4155.646770024582;4174.457320548309;1295.5530342031984;1304.5042883704132;1309.9017573682013;1318.604418674413;1323.4639970811836;819.0780655858179;849.562475325208;906.9863952040724;918.8089075065764;940.2524992630875;4877.6829506081995;5827.562932780059;5828.504577110908;5897.5576831736935;6170.691465426711;455.428437311179;457.07442429081374;462.99074018520116;465.2114665641705;468.412142760833;3917.7845218512684;3959.4456776051375;4008.5390180129075;4029.315016447211;4054.3715724062818;10839.67480975572;11114.833277500844;11244.66266012021;11262.943685281522;11267;11178.888211117785;11187.72030699239;11188.776224475465;11192.944035279772;11199.992000719974;8457.957710211533;8508;8509.021462531764;8514.148585141436;8520.616572254263;4711.952880471288;5338.786448542171;5421.430749771217;5623.803166889139;5639.266895303748;10101;10285.2800303978;10294.433806140734;10372.429516376671;10550.155987521133;10277.74305642365;10595.417252051211;10658.360498370123;10753.085987691135;10785.568577256821;6827.419669327964;7149.53528020677;7367.926320736724;7440.4419668524;7615.809604759926;8780.25367843715;8856.3800533962;8865.822683546421;8865.867011994955;8867.246284065926;7772.067351917806;7788.493747906595;7873.5275883447175;7961.9203807963495;8017.158198389086;7567.545947242963;7668.539887606761;7715.344195743424;7722.92277077222;7768.300852923264;7242.094738157731;7364;7364.742234021784;7389.963050184715;7389.96305018493;4938.259261110862;5027.949720502748;5038.664753840309;5185.248139019896;5307.575393968396;5041.949580504148;5145.819896303611;5206.635535512478;5247.4490178530705;5393.784248630168 15:56:18 INFO - PROCESS | 2209 | |4;prototype.html;268.303751764172;308.1126356094446;316.5046701911509;319.2099553604828;324.8245947188518;4314.82740690372;4917.80328786849;5389.272448219489;5389.676619402839;5459.563234941205;5246.580273578114;5270.393904700961;5304.832936753917;5355.410904800478;5396.163594642827;3461.9614115765294;3892.8832135035855;4015.7791321477307;4100.938485922714;4117.558854400951;3565.94651080234;3829.5021647185827;4096.549379568245;4099.098198396363;4102.318049599665;3392.914267434422;4046.0491784430783;4047.6964227682893;4073.7352072115364;4096.303628383167;3886.24218277436;4049.514058312992;4061.8172182251724;4066.6746660267404;4075.572064933199;2966.6859849317566;2984.4627966966154;3279.721223695965;3558.9110272243142;3593.658602432765;5023.6232282578585;5150.871228219287;5164.870878228036;5182.404023537304;5234.345706786652;3584.4981702561663;3754.3617585010616;4631.8147274109;4656.115338085753;4665.930011049837;4664.486906440289;4846.75766211688;5564.638298510584;5625.240592520039;5675.5459563234845;3292.571965644475;3767.190054138346;3909.648131668135;3976.9005774855573;3979.343408337621;5042.84871453857;5841.240638716939;5842.838149884527;5856.531477481792;5865.912011319833;4013.7591744495426;4039;4039.1921615676983;4045.3122969095325;4065.593440655911;3227.6288226854213;3253.089135042192;3431.9313613727586;4073.5315438724924;4139.336687031938;4051.1290072634524;4584.747838868894;4629.490756016836;4663.906721865612;4679.298105284234;4933.925991110136;5662.716864156858;5671.9864448120325;5702.800401985911;5743.253377060955;1212.090931801149;1254.3101294288106;1282.896708830405;1318.5648735917125;1344.8050032745198;901.2744740483843;919;921.8755468011867;924.8716565789725;933.2953620016843;5326.627136100436;5326.748214169667;5327.254184414185;5386.272853164851;5406.648567843077;5059.748411956718;5677.296810956696;5807.88384232313;5882.3529411764675;5926.259217597801;4388.802503887333;5257.579393648499;5377.973110134424;5385.6230063895155;5386.407495175527;2264.8074913632195;2456.3736247256834;2530.569803133472;2538.6699729035477;2543.7535607552168;4290.549492303326;4659.743714095757;4944.9258261126115;5001.524550257683;5036.388355726206;4368.432103826546;4563.178627846953;4886.511348865085;4901.779419926112;4906.509349065136;4505.797239124247;4868.707877527359;5017.84946451607;5072.691925174037;5125.974370128126;4411.588291746611;4668.253079507398;5263.842084737464;5956.285245770535;5998.360721282622;5631.436856314336;5702.495028927101;5909.970450147722;5912.290525137011;5922.970385148046;5811.796587119599;6136.164896939413;6175.567710260419;6186.0102383618405;6191.597546159485;3533.480603340588;3693.7810522526966;3904.1801221742617;3976.542697589814;3978.204359128128;5563.471470210324;6011.489023432882;6012.849678758066;6028.728707208274;6078.635281883101;5320.388155362183;5778.36437991829;5790.276215473066;5860.912086318624;5909.379515151019;5757.251557297524;5787.9131813021995;5788.450097240755;5789.942100579109;5815.82552523425;5383.173833737319;5474.206240095244;5555.0278701227935;5592.972035139798;5638.378154158336;4512.668762714941;5731.512821410227;5774.682392468455;5774.9133762994425;5828.825135245949;5266.78932842682;5596.608237423341;5607.971960140173;5616;5647.265855438931 15:56:18 INFO - PROCESS | 2209 | |5;yui.html;722.2813300765739;732.9413646908248;767.6468824340803;819.4182130687212;841.2596914715052;15884.205789710511;16822.242999065056;16840;17224.224909879053;18086.728699069525;16873.915630421863;17239.482815515523;17239.569010774736;17267.30930762771;17337.82662173378;703.9120109986252;862.9266512346443;884.2351366068369;887.4098724348333;887.7780554861284;723.6815801047549;853.2576658307281;868.461553836619;870.3428911172056;880.1110878013188;926.2636204217663;927.0590350793949;927.8840144981878;927.9396839205464;928.7074571509986;922.3635691372931;923.2567782934735;923.607466826596;924.1451657217048;924.2698268368015;682.4881338995754;682.9112215412015;683.8153698501377;684.4250829303409;685.0375222811957;15852.445164419305;15860.286287116993;15907.443239486678;15928.442504512403;15996.12021338826;14473.78289325661;14659.267036648125;14711.485098021518;14745.631359215999;14878;12053.276803391824;12054.879451205463;12148.817767733402;12213.572524961672;12313.26120432777;3754.812259387047;3787.280416720814;3800.1259710266518;4001.099752555652;4044.4539987101657;128080;129680;129917;129966;130252;11100.168472202158;11190.552377904956;11321.773564528829;11350.772984540263;11758.176927614984;22934;23219.18732844376;23226.07095716186;23229.3031209064;23263.41841453977;7792.181820908723;8204.302634276033;8456.238938495442;8545.487270763773;8557.828843423222;4620.722756634613;4635.420572428447;4688.484266730657;4693.6949098308505;4817.759112044384;3712.7215458840155;3787.0910981364273;3792.7345085844277;3831.8275677594575;3834.2331533693373;540.3299908113911;610.9205803245638;611.8929187392189;616.7625464196227;620.711369213318;619.8264485943943;630.889594320992;662.8475450646379;700.8668353012911;708.1749761527865;9238.538073096453;9438.622455101857;9690;9726.124648781644;9949.054839790208;552.3592632546307;558.4192439862578;606.5632744424007;696.5124412910983;700.7862601906365;3699.72252081095;4485.488126649022;4800.73595952226;4809.495003024702;4850.442199147073;93197;133146.33707325993;139455;144234;148627;119996;125868;127548.36225818812;129561.35219323843;131223.34388327997;87202;94491;110055;111090;114354.99999999834;9127.48994026648;9314.44113353201;9322.627094916128;9324.95337523308;9373.953130234306;61323.38676613177;61698.76602468015;62216;62874;63098.36901631109;80127;93217.53391233001;96173;99178;101729;11748.177627565989;12154.392280385768;12165.69585760363;12245.081618878441;12645.051621128636;11294.43527823622;13481.932590336986;13490.538805331253;13769.862301376857;13831.100978436369;12065.819012714992;12087.516499339928;12257.325847078497;12440.440180192094;12482.563110291096;11807.704807379885;11977.760444790882;12919;13183.53857614979;13330.400131993889;11931.4034298283;11944;12273.018158547116;12734;12772.233665980071;9758.9024109758;10098.899011009797;10099.79800403973;10571.894281057399;11103;9344.345895787501;10617.734556636145;10919.508622111865;10938.726531836768;10965.50655220501 15:56:18 INFO - PROCESS | 2209 | __end_tp_report 15:56:18 INFO - PROCESS | 2209 | __start_cc_report 15:56:18 INFO - PROCESS | 2209 | _x_x_mozilla_cycle_collect,1182 15:56:18 INFO - PROCESS | 2209 | __end_cc_report 15:56:18 INFO - PROCESS | 2209 | __startTimestamp1481932578255__endTimestamp 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | ------- Summary: start ------- 15:56:18 INFO - PROCESS | 2209 | Number of tests: 6 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | [#0] dojo.html Cycles:165 Average:5803.77 Median:6103.27 stddev:660.26 (10.8%) stddev-sans-first:633.86 15:56:18 INFO - PROCESS | 2209 | Values: 3360.8 3367.2 3389.2 3421.7 3456.1 5853.3 5927.0 5937.0 5945.3 5959.9 5891.0 5931.7 5948.2 5959.4 5960.2 4357.4 5261.9 5320.7 5342.5 5342.8 5239.2 5241.6 5247.7 5261.3 5342.2 4535.9 5200.3 5361.3 5363.8 5366.8 5358.2 5362.3 5371.6 5377.7 5414.5 5174.1 5249.8 5299.2 5311.8 5323.8 4336.5 5736.5 5767.0 5867.6 5886.5 5154.5 6210.8 6240.7 6252.1 6267.1 6220.7 6244.5 6245.8 6267.8 6294.8 4850.0 5432.8 5742.1 5884.3 5950.6 5696.3 5808.4 6019.6 6323.7 6327.4 6241.5 6265.8 6269.7 6278.5 6278.8 6200.7 6233.8 6254.7 6255.6 6273.1 6301.7 6303.9 6305.6 6322.7 6330.3 6240.7 6288.1 6297.5 6331.4 6339.0 4997.6 5026.5 5036.8 5045.7 5085.3 4460.8 4532.7 4534.1 4541.4 4602.5 5917.9 5921.0 5921.3 5923.0 5932.5 6112.8 6249.9 6252.5 6264.7 6292.6 5789.7 5807.4 5865.4 5889.1 5894.2 5524.0 5524.6 5546.9 5558.7 5563.0 6270.5 6286.4 6313.0 6358.6 6371.1 6260.1 6266.2 6267.8 6269.8 6276.0 6379.2 6387.5 6393.4 6401.1 6429.1 6131.3 6172.6 6220.1 6220.5 6261.6 6245.3 6278.0 6279.9 6285.8 6299.9 6269.8 6274.3 6274.5 6286.8 6300.1 6103.3 6115.4 6142.9 6263.3 6272.9 6045.6 6145.1 6155.6 6161.7 6169.2 6253.0 6255.1 6255.2 6261.2 6278.9 6012.4 6049.7 6112.4 6113.8 6133.3 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | [#1] ext.html Cycles:180 Average:69591.90 Median:35310.82 stddev:149933.89 (424.6%) stddev-sans-first:150264.69 15:56:18 INFO - PROCESS | 2209 | Values: 476.3 497.7 532.7 543.3 568.4 31401.2 33407.8 33483.3 33506.3 41353.8 43494.0 43851.6 43865.3 43890.8 43927.6 9961.9 10122.3 10142.6 10143.2 10157.2 9387.3 9613.0 9757.1 12240.4 12565.6 12460.8 12494.0 12508.6 12513.7 12538.2 12485.3 12567.1 12575.4 12589.5 12600.5 12316.7 12373.1 12384.4 12393.6 12403.5 41487.0 41762.8 41772.0 41884.8 41887.0 3384.8 3462.1 3598.9 3695.7 4171.5 32055.8 32063.2 32084.0 32411.7 32901.5 3121.2 3215.8 3290.9 3303.6 3350.0 482567.0 484266.0 485797.0 485852.0 486096.7 61657.4 62153.0 62183.0 62269.4 62283.8 35466.6 36195.8 36280.3 37465.0 37522.6 17478.6 17674.6 17675.0 17684.6 17696.9 12332.9 13495.8 13548.4 13590.6 13597.2 16850.9 19428.8 19727.8 19728.7 20121.9 6957.4 7696.2 7886.3 8000.4 8002.4 805.8 939.3 1024.9 1071.9 1085.8 29869.0 30244.7 30334.8 30959.1 30999.0 1019.5 1104.7 1122.1 1175.0 1215.4 13079.0 15649.2 15655.8 15702.2 16073.2 614595.0 619969.0 621525.0 622985.9 623233.0 57670.1 58152.4 58254.4 58294.7 58301.7 1289.4 1336.1 1433.6 1437.6 1458.2 29494.0 31996.2 32244.0 32402.7 32603.0 49443.8 50238.5 50275.0 50450.5 50479.0 565581.0 572732.0 573396.0 575305.0 576632.0 30687.8 37096.1 37459.8 41964.8 45757.1 46038.3 46902.8 47046.3 47334.3 47737.8 34474.0 38629.8 38802.6 39880.8 40767.6 38898.0 39528.8 40306.0 40570.0 40675.2 37476.3 38013.0 38207.0 38263.0 38833.0 33105.0 34916.3 34956.7 35268.6 35353.0 26023.3 26039.2 26097.3 26225.5 26637.3 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | [#2] jquery.html Cycles:180 Average:33765.24 Median:27020.80 stddev:96932.76 (358.7%) stddev-sans-first:97172.27 15:56:18 INFO - PROCESS | 2209 | Values: 378.9 380.8 391.3 397.5 411.3 19861.2 21547.2 21551.1 21868.6 22764.5 21239.5 21449.8 21852.8 22066.4 22203.9 5753.2 6278.9 6340.8 6344.4 6353.8 5977.3 6173.1 6219.5 6263.9 6279.7 6211.7 6216.7 6225.4 6227.5 6237.0 5944.6 6158.4 6199.3 6233.9 6235.1 4948.9 5307.1 5458.1 5469.4 5470.8 26370.9 26724.6 26741.0 27018.6 27023.0 2092.7 2346.9 2604.4 2607.6 3044.6 15186.2 15701.6 15702.6 16540.3 16554.9 1784.4 1992.2 1996.4 2011.9 2036.8 89852.0 114197.4 120803.0 120922.4 121186.0 9554.0 9624.2 11027.4 11506.8 11518.1 14594.2 14605.0 14605.7 14614.3 14615.0 8659.0 8916.2 8970.8 9080.6 9098.4 7351.9 9000.6 9003.6 9158.6 9171.0 6348.2 6368.6 6793.4 6918.9 6935.9 1702.7 1802.3 1823.6 1841.4 1876.8 755.5 881.4 964.3 996.5 1093.3 22594.3 23144.3 23163.5 23182.4 23291.9 881.8 902.9 910.9 1011.2 1076.8 11766.7 12119.8 12183.4 12312.8 12400.3 532896.0 590238.0 593273.0 606222.0 607788.0 65962.7 79799.0 84861.6 98605.0 113931.4 982.2 997.2 1037.9 1042.6 1044.4 20662.4 20885.5 21237.0 21424.5 21590.8 38465.0 41211.4 53723.0 54005.7 54435.5 58803.0 70475.9 72141.0 75295.0 76298.0 8059.3 8212.3 8437.1 8486.4 8615.8 11695.7 13562.3 13732.9 13959.2 14190.4 11423.2 11596.6 11666.8 11802.5 11890.2 11478.4 11492.8 11675.2 11937.3 12120.0 9958.0 11610.4 11669.1 11836.5 12005.2 8206.8 8292.7 8382.7 8480.2 8497.9 11468.5 11683.9 11741.9 11779.5 12103.5 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | [#3] mootools.html Cycles:180 Average:5869.69 Median:2590.18 stddev:3355.84 (129.6%) stddev-sans-first:3349.13 15:56:18 INFO - PROCESS | 2209 | Values: 1491.6 1530.6 1732.7 1899.0 1904.0 8601.7 9183.0 9201.3 9202.8 9211.9 8120.8 8377.0 8815.1 9014.5 9018.8 2434.9 2453.0 2460.4 2461.6 2466.1 2405.8 2460.7 2462.4 2462.7 2462.8 2429.8 2440.7 2454.4 2457.0 2457.9 2423.1 2427.3 2438.8 2447.2 2450.3 2319.0 2330.8 2331.1 2335.0 2337.7 9036.0 9123.3 9131.8 9138.7 9138.7 5350.7 5514.9 5515.7 5515.9 5532.3 3513.3 3635.4 3692.6 3709.1 3729.9 1038.5 1066.9 1071.3 1083.4 1088.4 12034.8 12098.3 12135.4 12136.0 12172.3 4797.8 4869.5 4870.1 4946.8 4988.6 10191.7 10194.2 10195.6 10206.9 10211.5 5509.3 5513.0 5516.1 5529.8 5533.9 4595.2 4719.8 4763.7 4986.4 5055.3 3560.3 4047.6 4052.5 4155.6 4174.5 1295.6 1304.5 1309.9 1318.6 1323.5 819.1 849.6 907.0 918.8 940.3 4877.7 5827.6 5828.5 5897.6 6170.7 455.4 457.1 463.0 465.2 468.4 3917.8 3959.4 4008.5 4029.3 4054.4 10839.7 11114.8 11244.7 11262.9 11267.0 11178.9 11187.7 11188.8 11192.9 11200.0 8458.0 8508.0 8509.0 8514.1 8520.6 4712.0 5338.8 5421.4 5623.8 5639.3 10101.0 10285.3 10294.4 10372.4 10550.2 10277.7 10595.4 10658.4 10753.1 10785.6 6827.4 7149.5 7367.9 7440.4 7615.8 8780.3 8856.4 8865.8 8865.9 8867.2 7772.1 7788.5 7873.5 7961.9 8017.2 7567.5 7668.5 7715.3 7722.9 7768.3 7242.1 7364.0 7364.7 7390.0 7390.0 4938.3 5027.9 5038.7 5185.2 5307.6 5041.9 5145.8 5206.6 5247.4 5393.8 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | [#4] prototype.html Cycles:180 Average:4500.98 Median:5020.74 stddev:1427.46 (28.4%) stddev-sans-first:1395.66 15:56:18 INFO - PROCESS | 2209 | Values: 268.3 308.1 316.5 319.2 324.8 4314.8 4917.8 5389.3 5389.7 5459.6 5246.6 5270.4 5304.8 5355.4 5396.2 3462.0 3892.9 4015.8 4100.9 4117.6 3565.9 3829.5 4096.5 4099.1 4102.3 3392.9 4046.0 4047.7 4073.7 4096.3 3886.2 4049.5 4061.8 4066.7 4075.6 2966.7 2984.5 3279.7 3558.9 3593.7 5023.6 5150.9 5164.9 5182.4 5234.3 3584.5 3754.4 4631.8 4656.1 4665.9 4664.5 4846.8 5564.6 5625.2 5675.5 3292.6 3767.2 3909.6 3976.9 3979.3 5042.8 5841.2 5842.8 5856.5 5865.9 4013.8 4039.0 4039.2 4045.3 4065.6 3227.6 3253.1 3431.9 4073.5 4139.3 4051.1 4584.7 4629.5 4663.9 4679.3 4933.9 5662.7 5672.0 5702.8 5743.3 1212.1 1254.3 1282.9 1318.6 1344.8 901.3 919.0 921.9 924.9 933.3 5326.6 5326.7 5327.3 5386.3 5406.6 5059.7 5677.3 5807.9 5882.4 5926.3 4388.8 5257.6 5378.0 5385.6 5386.4 2264.8 2456.4 2530.6 2538.7 2543.8 4290.5 4659.7 4944.9 5001.5 5036.4 4368.4 4563.2 4886.5 4901.8 4906.5 4505.8 4868.7 5017.8 5072.7 5126.0 4411.6 4668.3 5263.8 5956.3 5998.4 5631.4 5702.5 5910.0 5912.3 5923.0 5811.8 6136.2 6175.6 6186.0 6191.6 3533.5 3693.8 3904.2 3976.5 3978.2 5563.5 6011.5 6012.8 6028.7 6078.6 5320.4 5778.4 5790.3 5860.9 5909.4 5757.3 5787.9 5788.5 5789.9 5815.8 5383.2 5474.2 5555.0 5593.0 5638.4 4512.7 5731.5 5774.7 5774.9 5828.8 5266.8 5596.6 5608.0 5616.0 5647.3 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - PROCESS | 2209 | [#5] yui.html Cycles:180 Average:24828.69 Median:3790.01 stddev:39283.29 (1036.5%) stddev-sans-first:39351.79 15:56:18 INFO - PROCESS | 2209 | Values: 722.3 732.9 767.6 819.4 841.3 15884.2 16822.2 16840.0 17224.2 18086.7 16873.9 17239.5 17239.6 17267.3 17337.8 703.9 862.9 884.2 887.4 887.8 723.7 853.3 868.5 870.3 880.1 926.3 927.1 927.9 927.9 928.7 922.4 923.3 923.6 924.1 924.3 682.5 682.9 683.8 684.4 685.0 15852.4 15860.3 15907.4 15928.4 15996.1 14473.8 14659.3 14711.5 14745.6 14878.0 12053.3 12054.9 12148.8 12213.6 12313.3 3754.8 3787.3 3800.1 4001.1 4044.5 128080.0 129680.0 129917.0 129966.0 130252.0 11100.2 11190.6 11321.8 11350.8 11758.2 22934.0 23219.2 23226.1 23229.3 23263.4 7792.2 8204.3 8456.2 8545.5 8557.8 4620.7 4635.4 4688.5 4693.7 4817.8 3712.7 3787.1 3792.7 3831.8 3834.2 540.3 610.9 611.9 616.8 620.7 619.8 630.9 662.8 700.9 708.2 9238.5 9438.6 9690.0 9726.1 9949.1 552.4 558.4 606.6 696.5 700.8 3699.7 4485.5 4800.7 4809.5 4850.4 93197.0 133146.3 139455.0 144234.0 148627.0 119996.0 125868.0 127548.4 129561.4 131223.3 87202.0 94491.0 110055.0 111090.0 114355.0 9127.5 9314.4 9322.6 9325.0 9374.0 61323.4 61698.8 62216.0 62874.0 63098.4 80127.0 93217.5 96173.0 99178.0 101729.0 11748.2 12154.4 12165.7 12245.1 12645.1 11294.4 13481.9 13490.5 13769.9 13831.1 12065.8 12087.5 12257.3 12440.4 12482.6 11807.7 11977.8 12919.0 13183.5 13330.4 11931.4 11944.0 12273.0 12734.0 12772.2 9758.9 10098.9 10099.8 10571.9 11103.0 9344.3 10617.7 10919.5 10938.7 10965.5 15:56:18 INFO - PROCESS | 2209 | -------- Summary: end -------- 15:56:18 INFO - PROCESS | 2209 | 15:56:18 INFO - TEST-INFO | 2209: exit 0 15:56:18 INFO - TEST-OK | dromaeo_css | took 1115352ms 15:56:18 INFO - TEST-START | kraken 15:56:18 INFO - operating with platform_type : mac_ 15:56:18 INFO - Initialising browser for kraken test... 15:56:18 INFO - TEST-INFO | started process 2211 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpZsYVpC/profile http://localhost:52509/getInfo.html) 15:56:21 INFO - PROCESS | 2211 | __metrics Screen width/height:1600/1200 15:56:21 INFO - PROCESS | 2211 | colorDepth:24 15:56:21 INFO - PROCESS | 2211 | Browser inner width/height: 1024/689 15:56:21 INFO - PROCESS | 2211 | __metrics 15:56:21 INFO - PROCESS | 2211 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:56:21 INFO - PROCESS | 2211 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:56:21 INFO - TEST-INFO | 2211: exit 0 15:56:21 INFO - Browser initialized. 15:56:21 INFO - Running cycle 1/1 for kraken test... 15:56:21 INFO - TEST-INFO | started process 2213 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpZsYVpC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:56:33 INFO - PROCESS | 2213 | RSS: Main: 169029632 15:56:33 INFO - PROCESS | 2213 | 15:56:36 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52509/tests/kraken/driver.html?testName=audio-beat-detection) 15:56:37 INFO - PROCESS | 2213 | RSS: Main: 219377664 15:56:37 INFO - PROCESS | 2213 | 15:56:39 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52509/tests/kraken/driver.html?testName=audio-dft) 15:56:40 INFO - PROCESS | 2213 | RSS: Main: 232415232 15:56:40 INFO - PROCESS | 2213 | 15:56:43 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52509/tests/kraken/driver.html?testName=audio-fft) 15:56:44 INFO - PROCESS | 2213 | RSS: Main: 328908800 15:56:44 INFO - PROCESS | 2213 | 15:56:46 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52509/tests/kraken/driver.html?testName=audio-oscillator) 15:56:46 INFO - PROCESS | 2213 | RSS: Main: 229310464 15:56:46 INFO - PROCESS | 2213 | 15:56:48 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:56:49 INFO - PROCESS | 2213 | RSS: Main: 230465536 15:56:49 INFO - PROCESS | 2213 | 15:56:52 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52509/tests/kraken/driver.html?testName=imaging-darkroom) 15:56:52 INFO - PROCESS | 2213 | RSS: Main: 267706368 15:56:52 INFO - PROCESS | 2213 | 15:56:55 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52509/tests/kraken/driver.html?testName=imaging-desaturate) 15:56:56 INFO - PROCESS | 2213 | RSS: Main: 267173888 15:56:56 INFO - PROCESS | 2213 | 15:56:59 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52509/tests/kraken/driver.html?testName=json-parse-financial) 15:56:59 INFO - PROCESS | 2213 | RSS: Main: 266387456 15:56:59 INFO - PROCESS | 2213 | 15:57:01 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:57:01 INFO - PROCESS | 2213 | RSS: Main: 240373760 15:57:01 INFO - PROCESS | 2213 | 15:57:03 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52509/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:57:04 INFO - PROCESS | 2213 | RSS: Main: 246751232 15:57:04 INFO - PROCESS | 2213 | 15:57:06 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:57:07 INFO - PROCESS | 2213 | RSS: Main: 253247488 15:57:07 INFO - PROCESS | 2213 | 15:57:09 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:57:10 INFO - PROCESS | 2213 | RSS: Main: 266752000 15:57:10 INFO - PROCESS | 2213 | 15:57:13 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:57:14 INFO - PROCESS | 2213 | RSS: Main: 260091904 15:57:14 INFO - PROCESS | 2213 | 15:57:15 INFO - PROCESS | 2213 | Cycle 1(1): loaded http://localhost:52509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52509/tests/kraken/driver.html?testName=ai-astar) 15:57:16 INFO - PROCESS | 2213 | RSS: Main: 304001024 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | __start_tp_report 15:57:16 INFO - PROCESS | 2213 | _x_x_mozilla_page_load 15:57:16 INFO - PROCESS | 2213 | _x_x_mozilla_page_load_details 15:57:16 INFO - PROCESS | 2213 | |i|pagename|runs| 15:57:16 INFO - PROCESS | 2213 | |0;ai-astar;114;114;114;112;114;114;113;113;113;113 15:57:16 INFO - PROCESS | 2213 | |1;audio-beat-detection;174;133;136;144;111;109;109;108;138;118 15:57:16 INFO - PROCESS | 2213 | |2;audio-dft;182;179;182;185;186;184;181;184;182;183 15:57:16 INFO - PROCESS | 2213 | |3;audio-fft;81;60;59;101;62;60;59;58;81;57 15:57:16 INFO - PROCESS | 2213 | |4;audio-oscillator;89;69;94;69;67;69;91;66;68;88 15:57:16 INFO - PROCESS | 2213 | |5;imaging-gaussian-blur;92;88;91;88;92;88;92;88;90;88 15:57:16 INFO - PROCESS | 2213 | |6;imaging-darkroom;98;99;100;98;99;107;138;100;99;99 15:57:16 INFO - PROCESS | 2213 | |7;imaging-desaturate;86;91;86;85;85;85;85;86;84;103 15:57:16 INFO - PROCESS | 2213 | |8;json-parse-financial;57;53;52;52;55;57;58;58;56;58 15:57:16 INFO - PROCESS | 2213 | |9;json-stringify-tinderbox;62;70;71;83;71;93;96;86;69;69 15:57:16 INFO - PROCESS | 2213 | |10;stanford-crypto-aes;82;81;83;83;95;94;96;85;84;88 15:57:16 INFO - PROCESS | 2213 | |11;stanford-crypto-ccm;134;131;132;135;133;133;140;149;179;137 15:57:16 INFO - PROCESS | 2213 | |12;stanford-crypto-pbkdf2;161;162;208;158;211;223;165;161;161;159 15:57:16 INFO - PROCESS | 2213 | |13;stanford-crypto-sha256-iterative;66;66;66;64;65;65;66;66;65;65 15:57:16 INFO - PROCESS | 2213 | __end_tp_report 15:57:16 INFO - PROCESS | 2213 | __start_cc_report 15:57:16 INFO - PROCESS | 2213 | _x_x_mozilla_cycle_collect,1923 15:57:16 INFO - PROCESS | 2213 | __end_cc_report 15:57:16 INFO - PROCESS | 2213 | __startTimestamp1481932636192__endTimestamp 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | ------- Summary: start ------- 15:57:16 INFO - PROCESS | 2213 | Number of tests: 14 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:57:16 INFO - PROCESS | 2213 | Values: 114.0 114.0 114.0 112.0 114.0 114.0 113.0 113.0 113.0 113.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:134.50 stddev:21.27 (15.8%) stddev-sans-first:14.67 15:57:16 INFO - PROCESS | 2213 | Values: 174.0 133.0 136.0 144.0 111.0 109.0 109.0 108.0 138.0 118.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.50 stddev:2.04 (1.1%) stddev-sans-first:2.15 15:57:16 INFO - PROCESS | 2213 | Values: 182.0 179.0 182.0 185.0 186.0 184.0 181.0 184.0 182.0 183.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#3] audio-fft Cycles:10 Average:67.80 Median:60.00 stddev:14.81 (24.7%) stddev-sans-first:14.92 15:57:16 INFO - PROCESS | 2213 | Values: 81.0 60.0 59.0 101.0 62.0 60.0 59.0 58.0 81.0 57.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.50 stddev:11.76 (15.0%) stddev-sans-first:11.64 15:57:16 INFO - PROCESS | 2213 | Values: 89.0 69.0 94.0 69.0 67.0 69.0 91.0 66.0 68.0 88.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:90.50 stddev:1.89 (2.1%) stddev-sans-first:1.81 15:57:16 INFO - PROCESS | 2213 | Values: 92.0 88.0 91.0 88.0 92.0 88.0 92.0 88.0 90.0 88.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#6] imaging-darkroom Cycles:10 Average:103.70 Median:98.50 stddev:12.33 (12.5%) stddev-sans-first:12.90 15:57:16 INFO - PROCESS | 2213 | Values: 98.0 99.0 100.0 98.0 99.0 107.0 138.0 100.0 99.0 99.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#7] imaging-desaturate Cycles:10 Average:87.60 Median:85.50 stddev:5.74 (6.7%) stddev-sans-first:6.06 15:57:16 INFO - PROCESS | 2213 | Values: 86.0 91.0 86.0 85.0 85.0 85.0 85.0 86.0 84.0 103.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:57.00 stddev:2.46 (4.3%) stddev-sans-first:2.55 15:57:16 INFO - PROCESS | 2213 | Values: 57.0 53.0 52.0 52.0 55.0 57.0 58.0 58.0 56.0 58.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:77.00 stddev:11.59 (15.0%) stddev-sans-first:10.94 15:57:16 INFO - PROCESS | 2213 | Values: 62.0 70.0 71.0 83.0 71.0 93.0 96.0 86.0 69.0 69.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:5.78 (6.7%) stddev-sans-first:5.83 15:57:16 INFO - PROCESS | 2213 | Values: 82.0 81.0 83.0 83.0 95.0 94.0 96.0 85.0 84.0 88.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:136.00 stddev:14.58 (10.7%) stddev-sans-first:15.29 15:57:16 INFO - PROCESS | 2213 | Values: 134.0 131.0 132.0 135.0 133.0 133.0 140.0 149.0 179.0 137.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:163.50 stddev:25.94 (15.9%) stddev-sans-first:26.87 15:57:16 INFO - PROCESS | 2213 | Values: 161.0 162.0 208.0 158.0 211.0 223.0 165.0 161.0 161.0 159.0 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - PROCESS | 2213 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 15:57:16 INFO - PROCESS | 2213 | Values: 66.0 66.0 66.0 64.0 65.0 65.0 66.0 66.0 65.0 65.0 15:57:16 INFO - PROCESS | 2213 | -------- Summary: end -------- 15:57:16 INFO - PROCESS | 2213 | 15:57:16 INFO - TEST-INFO | 2213: exit 0 15:57:16 INFO - TEST-OK | kraken | took 58097ms 15:57:16 INFO - SUITE-END | took 1173s 15:57:17 INFO - Completed test suite (00:19:33) 15:57:17 INFO - javascript benchmark 15:57:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.7983520988737, 3367.2255381262307, 3389.2035371687634, 3421.743369247307, 3456.1014136324566, 5853.268341457318, 5926.9999999999945, 5936.970315148418, 5945.286565612128, 5959.851003724909, 5891.0, 5931.673757943311, 5948.196993405889, 5959.374265702104, 5960.225170727799, 4357.43353364063, 5261.8704102162255, 5320.733963301819, 5342.492463215988, 5342.759575819078, 5239.161734122541, 5241.554467870235, 5247.737613119348, 5261.289725886994, 5342.225377320306, 4535.886602834922, 5200.29795977542, 5361.303030606015, 5363.785448582072, 5366.758495867676, 5358.169483730028, 5362.3029006229135, 5371.57027437804, 5377.704226267554, 5414.485623865727, 5174.094533456668, 5249.816256431007, 5299.231611416323, 5311.760970756325, 5323.813666521653, 4336.457942757155, 5736.455036771542, 5767.0, 5867.618604790675, 5886.499647529965, 5154.484551544815, 6210.844728881769, 6240.719167637421, 6252.124702541648, 6267.059941008885, 6220.720067596969, 6244.500439964792, 6245.7501699931945, 6267.780627678055, 6294.779682711083, 4849.975750121227, 5432.75552600134, 5742.138679198112, 5884.293884733859, 5950.6132101413705, 5696.287964004499, 5808.3901190375245, 6019.608725432833, 6323.683815809191, 6327.430531252117, 6241.469475094668, 6265.843353916189, 6269.7492100316385, 6278.529110316653, 6278.780242691484, 6200.689965501707, 6233.812985610439, 6254.749810007549, 6255.624662520263, 6273.0904018917, 6301.653409062454, 6303.905441418382, 6305.558610897285, 6322.652254125976, 6330.303666596671, 6240.656763878031, 6288.056791481223, 6297.464715499143, 6331.398517140864, 6339.0, 4997.600191984632, 5026.4973502649445, 5036.7733451994745, 5045.747712614355, 5085.3134826797905, 4460.77696115193, 4532.7280363178315, 4534.093181363741, 4541.43232095988, 4602.516735742765, 5917.852053698606, 5920.970395147997, 5921.289445266596, 5923.0, 5932.525397968152, 6112.807455516588, 6249.875002499924, 6252.499800015988, 6264.749410023548, 6292.559520833589, 5789.652620842763, 5807.361190269067, 5865.384134665798, 5889.087191485327, 5894.204282421904, 5524.0, 5524.613277070647, 5546.944530554642, 5558.666480011212, 5562.972185139049, 6270.529710271748, 6286.37136286386, 6312.968435157794, 6358.618482891041, 6371.108044873721, 6260.092286618506, 6266.216722909637, 6267.843303917439, 6269.780557680459, 6275.96862015687, 6379.2344918608205, 6387.520935929917, 6393.392627700361, 6401.103845461732, 6429.067785171217, 6131.315499379051, 6172.629642221481, 6220.098085777447, 6220.502359811295, 6261.62430254168, 6245.28179259391, 6277.96861015692, 6279.874402511833, 6285.811425657238, 6299.897517934435, 6269.843253918689, 6274.278457977391, 6274.498040156685, 6286.811395658137, 6300.086487459201, 6103.267607887082, 6115.388461153849, 6142.867137759686, 6263.311035786151, 6272.905906411316, 6045.637261764308, 6145.125736650364, 6155.630662160284, 6161.691915404302, 6169.2288463942, 6253.030780229072, 6255.093011513396, 6255.218097737783, 6261.154744109669, 6278.874422511615, 6012.428819262163, 6049.727762250621, 6112.449879510866, 6113.786017489367, 6133.294671112879], "value": 5762.461047230085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.3045952908754, 497.7357511919724, 532.7336331834083, 543.2882923370382, 568.3634329550904, 31401.214969625744, 33407.83296083516, 33483.330333393315, 33506.329873402516, 41353.7932310338, 43494.0, 43851.56148438522, 43865.34201986965, 43890.7805460973, 43927.560724392744, 9961.900380996189, 10122.342047766908, 10142.594296228142, 10143.23925705575, 10157.238207134458, 9387.342885997983, 9612.951935240313, 9757.073078057572, 12240.44917978693, 12565.623031309075, 12460.750784984295, 12494.0, 12508.624741257778, 12513.687157821081, 12538.247705137675, 12485.313307768069, 12567.120301578892, 12575.434105465185, 12589.496420143183, 12600.495980160782, 12316.692082697915, 12373.13388062836, 12384.442700078518, 12393.566225182076, 12403.503859845596, 41487.0, 41762.791186043876, 41772.0, 41884.79057604692, 41887.0, 3384.830758462067, 3462.0998540379433, 3598.874039408608, 3695.7043436525014, 4171.499420069611, 32055.83972080148, 32063.19842003945, 32084.03747887567, 32411.675883241103, 32901.50647740286, 3121.2352973521633, 3215.8070515769127, 3290.93418131636, 3303.620083690358, 3349.9665003349896, 482567.0, 484266.0, 485797.0, 485852.0, 486096.6951652403, 61657.38342616606, 62153.0, 62183.0, 62269.37730622636, 62283.75432491415, 35466.64533354685, 36195.819020904724, 36280.274394511966, 37465.0, 37522.62477375246, 17478.563035924202, 17674.558136046446, 17675.027873467083, 17684.557886052695, 17696.91151544234, 12332.938335308267, 13495.797563036562, 13548.390322435316, 13590.59228223155, 13597.184168949894, 16850.915745421193, 19428.805711942983, 19727.802721972595, 19728.70406943897, 20121.893295868867, 6957.408620267232, 7696.230376962259, 7886.250806173519, 8000.35997120229, 8002.439829212016, 805.7864665863551, 939.3424602778083, 1024.9180065594883, 1071.9464026798628, 1085.755704966392, 29868.9545865898, 30244.697553024627, 30334.78660853541, 30959.0712278632, 30999.0, 1019.4698756646502, 1104.745908441063, 1122.0686829931137, 1175.024729474534, 1215.3619349841226, 13079.0, 15649.217539122998, 15655.843441565667, 15702.21488925572, 16073.196340182943, 614595.0, 619969.0, 621525.0, 622985.8850705718, 623233.0, 57670.134947975814, 58152.4184758147, 58254.4174558249, 58294.7085264571, 58301.70849145727, 1289.3939848271298, 1336.0580790542838, 1433.6200906759716, 1437.5615437291517, 1458.2344269258724, 29493.967711130008, 31996.20009499781, 32244.0, 32402.67597324091, 32603.02190934276, 49443.76390590264, 50238.497615023385, 50274.99450011052, 50450.495495046045, 50479.0, 565581.0, 572732.0, 573396.0, 575305.0, 576632.0, 30687.846560767055, 37096.07259818418, 37459.81270093741, 41964.790176048926, 45757.08485830198, 46038.309425359315, 46902.76548617235, 47046.29430558476, 47334.28998565093, 47737.76131119322, 34474.0, 38629.806850965564, 38802.6431016637, 39880.80059599799, 40767.59232407757, 38898.0, 39528.80235598804, 40305.99235019031, 40569.98575035648, 40675.186496269314, 37476.25047499089, 38013.049673758374, 38207.0, 38263.0, 38833.0, 33105.0, 34916.28569584935, 34956.650433496354, 35268.64731352653, 35353.0, 26023.349416264744, 26039.218823435327, 26097.347566310993, 26225.475490490466, 26637.334066648487], "value": 20699.157388831183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.94884190634264, 380.76012112369204, 391.3405911039897, 397.48724145851855, 411.2782067471587, 19861.20555177793, 21547.24584639538, 21551.13795448184, 21868.562628747415, 22764.54470910585, 21239.469013274636, 21449.785502144972, 21852.781472185274, 22066.44833879154, 22203.888980555075, 5753.194552762606, 6278.905816412757, 6340.8097757067135, 6344.3655634436645, 6353.8411539711415, 5977.31260904995, 6173.1048997895505, 6219.471344935663, 6263.906041409383, 6279.654618995954, 6211.689415529206, 6216.658083805389, 6225.408586184328, 6227.470664993481, 6237.0, 5944.613600116, 6158.353372895848, 6199.256089269294, 6233.906491402633, 6235.064740288947, 4948.901021979576, 5307.071262529081, 5458.1266997280645, 5469.371022332403, 5470.8085217017215, 26370.868145659148, 26724.599131013052, 26741.0, 27018.5947210792, 27023.0, 2092.696558998937, 2346.917857874966, 2604.4009877728226, 2607.647967524379, 3044.604201453819, 15186.164760938143, 15701.607459813482, 15702.607434814106, 16540.338386464526, 16554.917225413796, 1784.4361380626722, 1992.2429476798868, 1996.3611644273838, 2011.8994050297426, 2036.75558932929, 89852.0, 114197.42901285441, 120803.0, 120922.3953880225, 121186.0, 9553.952230238805, 9624.230061595055, 11027.44862756859, 11506.76986460266, 11518.078553715683, 14594.197319147548, 14605.0, 14605.707885842436, 14614.34235459407, 14615.0, 8659.004214515411, 8916.19754222123, 8970.775730606656, 9080.593642684695, 9098.363114582047, 7351.852962940711, 9000.594973226089, 9003.594838232295, 9158.587863546156, 9171.037041110721, 6348.206474190726, 6368.5860419072615, 6793.422559082434, 6918.8962165567555, 6935.861282774316, 1702.6594681063837, 1802.2790883646385, 1823.601963418101, 1841.4475657302755, 1876.8310852023383, 755.4560716284267, 881.3962435731416, 964.2960638733764, 996.5216695985968, 1093.2893619147458, 22594.322170334915, 23144.3056708299, 23163.53672926532, 23182.42043948915, 23291.88354058219, 881.7751473374249, 902.873597696323, 910.9180173784391, 1011.1910471622673, 1076.7577295108538, 11766.705832354259, 12119.818202726967, 12183.390830458442, 12312.753744925052, 12400.255984640951, 532896.0, 590238.0, 593273.0, 606222.0, 607788.0, 65962.67018664876, 79799.0, 84861.57569212114, 98605.0, 113931.43034284776, 982.189693502863, 997.1922742578535, 1037.8858325584179, 1042.6038105519854, 1044.38903241603, 20662.380128596167, 20885.477863052936, 21237.030451432223, 21424.464388390414, 21590.784092158876, 38465.0, 41211.38182927199, 53723.0, 54005.729971349894, 54435.45564544304, 58803.0, 70475.9428608561, 72141.0, 75295.0, 76298.0, 8059.274665280153, 8212.260896519341, 8437.11410301934, 8486.448380855225, 8615.82768344617, 11695.657552888779, 13562.254076025913, 13732.862671373558, 13959.23224222637, 14190.432382704988, 11423.200375973935, 11596.594119205787, 11666.76666466649, 11802.468888899848, 11890.227135236528, 11478.426078696199, 11492.770144597229, 11675.182737208654, 11937.28376297425, 12120.030397567996, 9958.0, 11610.419479026184, 11669.12481563903, 11836.526538938346, 12005.159638825198, 8206.753797386087, 8292.709755158781, 8382.748517544484, 8480.236778689947, 8497.915020849712, 11468.483918223867, 11683.941580292045, 11741.941290293495, 11779.52881884715, 12103.51585936588], "value": 9956.89022937594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.5823569400568, 1530.5943924859914, 1732.7227643577023, 1898.9810101898977, 1904.0194299935545, 8601.741947741562, 9183.0, 9201.309901757362, 9202.769930751734, 9211.861822072666, 8120.796980075501, 8376.994760628719, 8815.118488151182, 9014.459132452057, 9018.819623607524, 2434.9269521914325, 2453.031052734178, 2460.4218008767925, 2461.5569197544437, 2466.124525793344, 2405.822427865045, 2460.7416221296776, 2462.4090218347646, 2462.704475462938, 2462.827602067856, 2429.8056155507516, 2440.707115146185, 2454.435479839638, 2457.0, 2457.8893949772305, 2423.09134074722, 2427.2839512343903, 2438.8292819502553, 2447.155731272708, 2450.3261603059123, 2319.0491898321775, 2330.8018818400287, 2331.1258278145697, 2334.988325058364, 2337.6610391493136, 9035.954820225857, 9123.315751318678, 9131.81736365269, 9138.68014619485, 9138.725838224864, 5350.678959262418, 5514.944850551483, 5515.7242137892945, 5515.862103447446, 5532.336119665666, 3513.2797776455764, 3635.4001589737663, 3692.6307369263127, 3709.1283548366114, 3729.925401491982, 1038.48075962019, 1066.9253152279343, 1071.266182664877, 1083.3932997521413, 1088.434014312561, 12034.759304813855, 12098.274103553815, 12135.393230338448, 12136.0, 12172.2696638202, 4797.7601119943865, 4869.513048695173, 4870.14772414826, 4946.826861059845, 4988.575971042429, 10191.745206369751, 10194.216012197836, 10195.592176312864, 10206.948965255126, 10211.489425528694, 5509.338879334506, 5513.0, 5516.062269414209, 5529.806456773994, 5533.861653458695, 4595.241785105421, 4719.787609557578, 4763.69036012658, 4986.376702912136, 5055.34280543527, 3560.3413368526903, 4047.6238079053264, 4052.5339585947404, 4155.646770024582, 4174.457320548309, 1295.5530342031984, 1304.5042883704132, 1309.9017573682013, 1318.604418674413, 1323.4639970811836, 819.0780655858179, 849.562475325208, 906.9863952040724, 918.8089075065764, 940.2524992630875, 4877.6829506081995, 5827.562932780059, 5828.504577110908, 5897.5576831736935, 6170.691465426711, 455.428437311179, 457.07442429081374, 462.99074018520116, 465.2114665641705, 468.412142760833, 3917.7845218512684, 3959.4456776051375, 4008.5390180129075, 4029.315016447211, 4054.3715724062818, 10839.67480975572, 11114.833277500844, 11244.66266012021, 11262.943685281522, 11267.0, 11178.888211117785, 11187.72030699239, 11188.776224475465, 11192.944035279772, 11199.992000719974, 8457.957710211533, 8508.0, 8509.021462531764, 8514.148585141436, 8520.616572254263, 4711.952880471288, 5338.786448542171, 5421.430749771217, 5623.803166889139, 5639.266895303748, 10101.0, 10285.2800303978, 10294.433806140734, 10372.429516376671, 10550.155987521133, 10277.74305642365, 10595.417252051211, 10658.360498370123, 10753.085987691135, 10785.568577256821, 6827.419669327964, 7149.53528020677, 7367.926320736724, 7440.4419668524, 7615.809604759926, 8780.25367843715, 8856.3800533962, 8865.822683546421, 8865.867011994955, 8867.246284065926, 7772.067351917806, 7788.493747906595, 7873.5275883447175, 7961.9203807963495, 8017.158198389086, 7567.545947242963, 7668.539887606761, 7715.344195743424, 7722.92277077222, 7768.300852923264, 7242.094738157731, 7364.0, 7364.742234021784, 7389.963050184715, 7389.96305018493, 4938.259261110862, 5027.949720502748, 5038.664753840309, 5185.248139019896, 5307.575393968396, 5041.949580504148, 5145.819896303611, 5206.635535512478, 5247.4490178530705, 5393.784248630168], "value": 4617.157039819734, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.303751764172, 308.1126356094446, 316.5046701911509, 319.2099553604828, 324.8245947188518, 4314.82740690372, 4917.80328786849, 5389.272448219489, 5389.676619402839, 5459.563234941205, 5246.580273578114, 5270.393904700961, 5304.832936753917, 5355.410904800478, 5396.163594642827, 3461.9614115765294, 3892.8832135035855, 4015.7791321477307, 4100.938485922714, 4117.558854400951, 3565.94651080234, 3829.5021647185827, 4096.549379568245, 4099.098198396363, 4102.318049599665, 3392.914267434422, 4046.0491784430783, 4047.6964227682893, 4073.7352072115364, 4096.303628383167, 3886.24218277436, 4049.514058312992, 4061.8172182251724, 4066.6746660267404, 4075.572064933199, 2966.6859849317566, 2984.4627966966154, 3279.721223695965, 3558.9110272243142, 3593.658602432765, 5023.6232282578585, 5150.871228219287, 5164.870878228036, 5182.404023537304, 5234.345706786652, 3584.4981702561663, 3754.3617585010616, 4631.8147274109, 4656.115338085753, 4665.930011049837, 4664.486906440289, 4846.75766211688, 5564.638298510584, 5625.240592520039, 5675.5459563234845, 3292.571965644475, 3767.190054138346, 3909.648131668135, 3976.9005774855573, 3979.343408337621, 5042.84871453857, 5841.240638716939, 5842.838149884527, 5856.531477481792, 5865.912011319833, 4013.7591744495426, 4039.0, 4039.1921615676983, 4045.3122969095325, 4065.593440655911, 3227.6288226854213, 3253.089135042192, 3431.9313613727586, 4073.5315438724924, 4139.336687031938, 4051.1290072634524, 4584.747838868894, 4629.490756016836, 4663.906721865612, 4679.298105284234, 4933.925991110136, 5662.716864156858, 5671.9864448120325, 5702.800401985911, 5743.253377060955, 1212.090931801149, 1254.3101294288106, 1282.896708830405, 1318.5648735917125, 1344.8050032745198, 901.2744740483843, 919.0, 921.8755468011867, 924.8716565789725, 933.2953620016843, 5326.627136100436, 5326.748214169667, 5327.254184414185, 5386.272853164851, 5406.648567843077, 5059.748411956718, 5677.296810956696, 5807.88384232313, 5882.3529411764675, 5926.259217597801, 4388.802503887333, 5257.579393648499, 5377.973110134424, 5385.6230063895155, 5386.407495175527, 2264.8074913632195, 2456.3736247256834, 2530.569803133472, 2538.6699729035477, 2543.7535607552168, 4290.549492303326, 4659.743714095757, 4944.9258261126115, 5001.524550257683, 5036.388355726206, 4368.432103826546, 4563.178627846953, 4886.511348865085, 4901.779419926112, 4906.509349065136, 4505.797239124247, 4868.707877527359, 5017.84946451607, 5072.691925174037, 5125.974370128126, 4411.588291746611, 4668.253079507398, 5263.842084737464, 5956.285245770535, 5998.360721282622, 5631.436856314336, 5702.495028927101, 5909.970450147722, 5912.290525137011, 5922.970385148046, 5811.796587119599, 6136.164896939413, 6175.567710260419, 6186.0102383618405, 6191.597546159485, 3533.480603340588, 3693.7810522526966, 3904.1801221742617, 3976.542697589814, 3978.204359128128, 5563.471470210324, 6011.489023432882, 6012.849678758066, 6028.728707208274, 6078.635281883101, 5320.388155362183, 5778.36437991829, 5790.276215473066, 5860.912086318624, 5909.379515151019, 5757.251557297524, 5787.9131813021995, 5788.450097240755, 5789.942100579109, 5815.82552523425, 5383.173833737319, 5474.206240095244, 5555.0278701227935, 5592.972035139798, 5638.378154158336, 4512.668762714941, 5731.512821410227, 5774.682392468455, 5774.9133762994425, 5828.825135245949, 5266.78932842682, 5596.608237423341, 5607.971960140173, 5616.0, 5647.265855438931], "value": 4049.8985417869267, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.2813300765739, 732.9413646908248, 767.6468824340803, 819.4182130687212, 841.2596914715052, 15884.205789710511, 16822.242999065056, 16840.0, 17224.224909879053, 18086.728699069525, 16873.915630421863, 17239.482815515523, 17239.569010774736, 17267.30930762771, 17337.82662173378, 703.9120109986252, 862.9266512346443, 884.2351366068369, 887.4098724348333, 887.7780554861284, 723.6815801047549, 853.2576658307281, 868.461553836619, 870.3428911172056, 880.1110878013188, 926.2636204217663, 927.0590350793949, 927.8840144981878, 927.9396839205464, 928.7074571509986, 922.3635691372931, 923.2567782934735, 923.607466826596, 924.1451657217048, 924.2698268368015, 682.4881338995754, 682.9112215412015, 683.8153698501377, 684.4250829303409, 685.0375222811957, 15852.445164419305, 15860.286287116993, 15907.443239486678, 15928.442504512403, 15996.12021338826, 14473.78289325661, 14659.267036648125, 14711.485098021518, 14745.631359215999, 14878.0, 12053.276803391824, 12054.879451205463, 12148.817767733402, 12213.572524961672, 12313.26120432777, 3754.812259387047, 3787.280416720814, 3800.1259710266518, 4001.099752555652, 4044.4539987101657, 128080.0, 129680.0, 129917.0, 129966.0, 130252.0, 11100.168472202158, 11190.552377904956, 11321.773564528829, 11350.772984540263, 11758.176927614984, 22934.0, 23219.18732844376, 23226.07095716186, 23229.3031209064, 23263.41841453977, 7792.181820908723, 8204.302634276033, 8456.238938495442, 8545.487270763773, 8557.828843423222, 4620.722756634613, 4635.420572428447, 4688.484266730657, 4693.6949098308505, 4817.759112044384, 3712.7215458840155, 3787.0910981364273, 3792.7345085844277, 3831.8275677594575, 3834.2331533693373, 540.3299908113911, 610.9205803245638, 611.8929187392189, 616.7625464196227, 620.711369213318, 619.8264485943943, 630.889594320992, 662.8475450646379, 700.8668353012911, 708.1749761527865, 9238.538073096453, 9438.622455101857, 9690.0, 9726.124648781644, 9949.054839790208, 552.3592632546307, 558.4192439862578, 606.5632744424007, 696.5124412910983, 700.7862601906365, 3699.72252081095, 4485.488126649022, 4800.73595952226, 4809.495003024702, 4850.442199147073, 93197.0, 133146.33707325993, 139455.0, 144234.0, 148627.0, 119996.0, 125868.0, 127548.36225818812, 129561.35219323843, 131223.34388327997, 87202.0, 94491.0, 110055.0, 111090.0, 114354.99999999834, 9127.48994026648, 9314.44113353201, 9322.627094916128, 9324.95337523308, 9373.953130234306, 61323.38676613177, 61698.76602468015, 62216.0, 62874.0, 63098.36901631109, 80127.0, 93217.53391233001, 96173.0, 99178.0, 101729.0, 11748.177627565989, 12154.392280385768, 12165.69585760363, 12245.081618878441, 12645.051621128636, 11294.43527823622, 13481.932590336986, 13490.538805331253, 13769.862301376857, 13831.100978436369, 12065.819012714992, 12087.516499339928, 12257.325847078497, 12440.440180192094, 12482.563110291096, 11807.704807379885, 11977.760444790882, 12919.0, 13183.53857614979, 13330.400131993889, 11931.4034298283, 11944.0, 12273.018158547116, 12734.0, 12772.233665980071, 9758.9024109758, 10098.899011009797, 10099.79800403973, 10571.894281057399, 11103.0, 9344.345895787501, 10617.734556636145, 10919.508622111865, 10938.726531836768, 10965.50655220501], "value": 7869.683174430211, "unit": "score"}], "name": "dromaeo_css", "value": 7477.41347091121, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 112.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 133.0, 136.0, 144.0, 111.0, 109.0, 109.0, 108.0, 138.0, 118.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 182.0, 185.0, 186.0, 184.0, 181.0, 184.0, 182.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 101.0, 62.0, 60.0, 59.0, 58.0, 81.0, 57.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 94.0, 69.0, 67.0, 69.0, 91.0, 66.0, 68.0, 88.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 91.0, 88.0, 92.0, 88.0, 92.0, 88.0, 90.0, 88.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 100.0, 98.0, 99.0, 107.0, 138.0, 100.0, 99.0, 99.0], "value": 103.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 86.0, 85.0, 85.0, 85.0, 85.0, 86.0, 84.0, 103.0], "value": 87.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 52.0, 52.0, 55.0, 57.0, 58.0, 58.0, 56.0, 58.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 70.0, 71.0, 83.0, 71.0, 93.0, 96.0, 86.0, 69.0, 69.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 83.0, 83.0, 95.0, 94.0, 96.0, 85.0, 84.0, 88.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 132.0, 135.0, 133.0, 133.0, 140.0, 149.0, 179.0, 137.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 208.0, 158.0, 211.0, 223.0, 165.0, 161.0, 161.0, 159.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 64.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1452.3000000000002, "alertThreshold": 2.0}]} 15:57:17 INFO - Return code: 0 15:57:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:57:17 INFO - # TBPL SUCCESS # 15:57:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:57:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:57:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:57:17 INFO - 2016-12-16 15:57:17.495 screenresolution[2217:23060] starting screenresolution argv=screenresolution get 15:57:17 INFO - 2016-12-16 15:57:17.498 screenresolution[2217:23060] Display 0: 1600x1200x32@60 15:57:17 INFO - 2016-12-16 15:57:17.504 screenresolution[2218:23063] starting screenresolution argv=screenresolution list 15:57:17 INFO - Available Modes on Display 0 15:57:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:57:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:57:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:57:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:57:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:57:17 INFO - Intel Iris: 15:57:17 INFO - Chipset Model: Intel Iris 15:57:17 INFO - Type: GPU 15:57:17 INFO - Bus: Built-In 15:57:17 INFO - VRAM (Dynamic, Max): 1536 MB 15:57:17 INFO - Vendor: Intel (0x8086) 15:57:17 INFO - Device ID: 0x0a2e 15:57:17 INFO - Revision ID: 0x0009 15:57:17 INFO - Displays: 15:57:17 INFO - Display: 15:57:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:57:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:57:17 INFO - Display Serial Number: 1600x1200 60 15:57:17 INFO - Main Display: Yes 15:57:17 INFO - Mirror: Off 15:57:17 INFO - Online: Yes 15:57:17 INFO - Rotation: Supported 15:57:17 INFO - Return code: 0 15:57:17 INFO - Running post-action listener: _resource_record_post_action 15:57:17 INFO - [mozharness: 2016-12-16 23:57:17.737959Z] Finished run-tests step (success) 15:57:17 INFO - Running post-run listener: _resource_record_post_run 15:57:17 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 1429504; Write bytes: 494608384; Read time: 9; Write time: 1563 15:57:17 INFO - TinderboxPrint: CPU usage
53.4% 15:57:17 INFO - TinderboxPrint: I/O read bytes / time
1,429,504 / 9 15:57:17 INFO - TinderboxPrint: I/O write bytes / time
494,608,384 / 1,563 15:57:17 INFO - TinderboxPrint: CPU idle
2,229.7 (46.6%) 15:57:17 INFO - TinderboxPrint: CPU system
962.6 (20.1%) 15:57:17 INFO - TinderboxPrint: CPU user
1,597.4 (33.4%) 15:57:17 INFO - TinderboxPrint: Swap in / out
196,026,368 / 0 15:57:17 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 185426432; Write bytes: 178391040; Read time: 17660; Write time: 395 15:57:17 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 1429504; Write bytes: 296151040; Read time: 9; Write time: 1112 15:57:18 INFO - Running post-run listener: _upload_blobber_files 15:57:18 INFO - Blob upload gear active. 15:57:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:57:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:57:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:57:18 INFO - (blobuploader) - INFO - Open directory for files ... 15:57:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:57:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:19 INFO - (blobuploader) - INFO - Done attempting. 15:57:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:57:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:57:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:20 INFO - (blobuploader) - INFO - Done attempting. 15:57:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:57:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:57:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:23 INFO - (blobuploader) - INFO - Done attempting. 15:57:23 INFO - (blobuploader) - INFO - Iteration through files over. 15:57:23 INFO - Return code: 0 15:57:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:57:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:57:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/489de9fce3082e499a0e20bd2aaaa9e26ef45836362105f3dcc55880735cc75c1fdd0e4062fe9a72a8080ed08093cc4c0943c9492370f7c341f2d7e9a407eef6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aada2ac3dd2b73b6728e96408c7ea861e1967974e3e3c9a668f3956559cc38dd92a7ac13e291c4755023d6ea45ff52e8abb3f4f585477e9b12feaa5fc692afc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3257a133ddc4e827b6d89ff2ff94da0da5281bc930eea55d2cdf67232ca88ad49685819feeb32a7c0f7eb279249cd4f862b9d7b5ed6784ee4a68d7626b7a5b8"} 15:57:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:57:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:57:23 INFO - Contents: 15:57:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/489de9fce3082e499a0e20bd2aaaa9e26ef45836362105f3dcc55880735cc75c1fdd0e4062fe9a72a8080ed08093cc4c0943c9492370f7c341f2d7e9a407eef6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aada2ac3dd2b73b6728e96408c7ea861e1967974e3e3c9a668f3956559cc38dd92a7ac13e291c4755023d6ea45ff52e8abb3f4f585477e9b12feaa5fc692afc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3257a133ddc4e827b6d89ff2ff94da0da5281bc930eea55d2cdf67232ca88ad49685819feeb32a7c0f7eb279249cd4f862b9d7b5ed6784ee4a68d7626b7a5b8"} 15:57:23 INFO - Running post-run listener: copy_logs_to_upload_dir 15:57:23 INFO - Copying logs to upload dir... 15:57:23 INFO - mkdir: /builds/slave/test/build/upload/logs 15:57:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.558720 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-16 15:57:23.124480) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 15:57:23.128769) ========= 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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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/489de9fce3082e499a0e20bd2aaaa9e26ef45836362105f3dcc55880735cc75c1fdd0e4062fe9a72a8080ed08093cc4c0943c9492370f7c341f2d7e9a407eef6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aada2ac3dd2b73b6728e96408c7ea861e1967974e3e3c9a668f3956559cc38dd92a7ac13e291c4755023d6ea45ff52e8abb3f4f585477e9b12feaa5fc692afc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3257a133ddc4e827b6d89ff2ff94da0da5281bc930eea55d2cdf67232ca88ad49685819feeb32a7c0f7eb279249cd4f862b9d7b5ed6784ee4a68d7626b7a5b8"} build_url:https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/CbFAFdDBRsCVEmYsNoOWmA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/489de9fce3082e499a0e20bd2aaaa9e26ef45836362105f3dcc55880735cc75c1fdd0e4062fe9a72a8080ed08093cc4c0943c9492370f7c341f2d7e9a407eef6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aada2ac3dd2b73b6728e96408c7ea861e1967974e3e3c9a668f3956559cc38dd92a7ac13e291c4755023d6ea45ff52e8abb3f4f585477e9b12feaa5fc692afc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3257a133ddc4e827b6d89ff2ff94da0da5281bc930eea55d2cdf67232ca88ad49685819feeb32a7c0f7eb279249cd4f862b9d7b5ed6784ee4a68d7626b7a5b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 15:57:23.162837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 15:57:23.163183) ========= 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.4z9LZNa9t1/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.zHuAjWfYLy/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.005223 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 15:57:23.211923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 15:57:23.212247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 15:57:23.212585) ========= ========= Total master_lag: 0.18 =========