builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0149 starttime: 1474674395.19 results: success (0) buildid: 20160923145125 builduid: f744b8f6aa7c4600a4d8df54fd521ba6 revision: 9d6a1ee63674c52222be7d6bc946fbd798846dcd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:35.190873) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:35.191262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:35.191529) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:35.276626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:35.276929) ========= 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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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-09-23 16:46:35-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 119M=0s 2016-09-23 16:46:35 (119 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.643915 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:35.962636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:35.962987) ========= 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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.028319 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:36.012031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 16:46:36.012366) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9d6a1ee63674c52222be7d6bc946fbd798846dcd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9d6a1ee63674c52222be7d6bc946fbd798846dcd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FcYbVWSPaA/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.MkXZZcSWw1/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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-09-23 16:46:36,092 truncating revision to first 12 chars 2016-09-23 16:46:36,092 Setting DEBUG logging. 2016-09-23 16:46:36,092 attempt 1/10 2016-09-23 16:46:36,092 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9d6a1ee63674?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 16:46:37,112 unpacking tar archive at: mozilla-aurora-9d6a1ee63674/testing/mozharness/ program finished with exit code 0 elapsedTime=1.270960 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 16:46:37.303152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:37.303496) ========= script_repo_revision: 9d6a1ee63674c52222be7d6bc946fbd798846dcd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:37.303881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:37.304156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 16:46:37.320169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-09-23 16:46:37.320512) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FcYbVWSPaA/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.MkXZZcSWw1/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:46:37 INFO - MultiFileLogger online at 20160923 16:46:37 in /builds/slave/test 16:46:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:46:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:46:37 INFO - {'append_to_log': False, 16:46:37 INFO - 'base_work_dir': '/builds/slave/test', 16:46:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:46:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:46:37 INFO - 'branch': 'Mozilla-Aurora', 16:46:37 INFO - 'buildbot_json_path': 'buildprops.json', 16:46:37 INFO - 'config_files': ('talos/mac_config.py',), 16:46:37 INFO - 'default_actions': ('clobber', 16:46:37 INFO - 'read-buildbot-config', 16:46:37 INFO - 'download-and-extract', 16:46:37 INFO - 'populate-webroot', 16:46:37 INFO - 'create-virtualenv', 16:46:37 INFO - 'install', 16:46:37 INFO - 'run-tests'), 16:46:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:46:37 INFO - 'download_minidump_stackwalk': True, 16:46:37 INFO - 'download_symbols': 'ondemand', 16:46:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:46:37 INFO - 'tooltool.py': '/tools/tooltool.py', 16:46:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:46:37 INFO - '/tools/misc-python/virtualenv.py')}, 16:46:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:46:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:46:37 INFO - 'installer_path': 'installer.exe', 16:46:37 INFO - 'log_level': 'info', 16:46:37 INFO - 'log_name': 'talos', 16:46:37 INFO - 'log_to_console': True, 16:46:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:46:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:46:37 INFO - 'opt_config_files': (), 16:46:37 INFO - 'pip_index': False, 16:46:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:46:37 INFO - 'cmd': ('bash', 16:46:37 INFO - '-c', 16:46:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:46:37 INFO - 'enabled': True, 16:46:37 INFO - 'halt_on_failure': False, 16:46:37 INFO - 'name': 'check_screen_resolution'},), 16:46:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:46:37 INFO - 'cmd': ('bash', 16:46:37 INFO - '-c', 16:46:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:46:37 INFO - 'enabled': True, 16:46:37 INFO - 'halt_on_failure': False, 16:46:37 INFO - 'name': 'check_screen_resolution'},), 16:46:37 INFO - 'run_cmd_checks_enabled': True, 16:46:37 INFO - 'sps_profile': False, 16:46:37 INFO - 'sps_profile_interval': 0, 16:46:37 INFO - 'suite': 'dromaeojs-e10s', 16:46:37 INFO - 'system_bits': '32', 16:46:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:46:37 INFO - 'title': 't-yosemite-r7-0149', 16:46:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:46:37 INFO - 'use_talos_json': True, 16:46:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:46:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:46:37 INFO - 'work_dir': 'build'} 16:46:37 INFO - [mozharness: 2016-09-23 23:46:37.526362Z] Running clobber step. 16:46:37 INFO - Running pre-action listener: _resource_record_pre_action 16:46:37 INFO - Running main action method: clobber 16:46:37 INFO - rmtree: /builds/slave/test/build 16:46:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:46:39 INFO - Running post-action listener: _resource_record_post_action 16:46:39 INFO - [mozharness: 2016-09-23 23:46:39.705319Z] Finished clobber step (success) 16:46:39 INFO - [mozharness: 2016-09-23 23:46:39.705444Z] Running read-buildbot-config step. 16:46:39 INFO - Running pre-action listener: _resource_record_pre_action 16:46:39 INFO - Running main action method: read_buildbot_config 16:46:39 INFO - Using buildbot properties: 16:46:39 INFO - { 16:46:39 INFO - "project": "", 16:46:39 INFO - "product": "firefox", 16:46:39 INFO - "script_repo_revision": "production", 16:46:39 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:46:39 INFO - "repository": "", 16:46:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:46:39 INFO - "buildid": "20160923145125", 16:46:39 INFO - "pgo_build": "False", 16:46:39 INFO - "basedir": "/builds/slave/test", 16:46:39 INFO - "buildnumber": 403, 16:46:39 INFO - "slavename": "t-yosemite-r7-0149", 16:46:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:46:39 INFO - "platform": "yosemite_r7", 16:46:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:46:39 INFO - "branch": "mozilla-aurora", 16:46:39 INFO - "repo_path": "releases/mozilla-aurora", 16:46:39 INFO - "revision": "9d6a1ee63674c52222be7d6bc946fbd798846dcd", 16:46:39 INFO - "stage_platform": "macosx64", 16:46:39 INFO - "builduid": "f744b8f6aa7c4600a4d8df54fd521ba6", 16:46:39 INFO - "slavebuilddir": "test" 16:46:39 INFO - } 16:46:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:46:39 INFO - Running post-action listener: _resource_record_post_action 16:46:39 INFO - [mozharness: 2016-09-23 23:46:39.708763Z] Finished read-buildbot-config step (success) 16:46:39 INFO - [mozharness: 2016-09-23 23:46:39.708871Z] Running download-and-extract step. 16:46:39 INFO - Running pre-action listener: _resource_record_pre_action 16:46:39 INFO - Running main action method: download_and_extract 16:46:39 INFO - mkdir: /builds/slave/test/build/tests 16:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:46:39 INFO - trying https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:46:39 INFO - Downloading https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 16:46:40 INFO - Downloaded 1199 bytes. 16:46:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:46:40 INFO - Using the following test package requirements: 16:46:40 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:46:40 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:46:40 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:46:40 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:46:40 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:46:40 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:46:40 INFO - u'jsshell-mac.zip'], 16:46:40 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:46:40 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:46:40 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:46:40 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:46:40 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:46:40 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:46:40 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:46:40 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:46:40 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:46:40 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:46:40 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:46:40 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:46:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:46:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:46:40 INFO - Fetch https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:46:41 INFO - Expected file size: 16430833 16:46:48 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:46:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:46:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:46:48 INFO - Fetch https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:46:48 INFO - Expected file size: 16430833 16:46:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:46:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:46:55 INFO - Fetch https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:46:56 INFO - Expected file size: 14414059 16:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:46:56 INFO - trying https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:46:56 INFO - Downloading https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:46:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 16:46:59 INFO - Downloaded 115256303 bytes. 16:46:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:46:59 INFO - mkdir: /builds/slave/test/properties 16:46:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:46:59 INFO - Writing to file /builds/slave/test/properties/build_url 16:46:59 INFO - Contents: 16:46:59 INFO - build_url:https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:47:00 INFO - Running post-action listener: _resource_record_post_action 16:47:00 INFO - Running post-action listener: set_extra_try_arguments 16:47:00 INFO - [mozharness: 2016-09-23 23:47:00.314309Z] Finished download-and-extract step (success) 16:47:00 INFO - [mozharness: 2016-09-23 23:47:00.314435Z] Running populate-webroot step. 16:47:00 INFO - Running pre-action listener: _resource_record_pre_action 16:47:00 INFO - Running main action method: populate_webroot 16:47:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:47:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:47:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:47:00 INFO - '--tppagecycles', 16:47:00 INFO - '7'], 16:47:00 INFO - 'tests': ['tsvgm']}}, 16:47:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:47:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:47:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:47:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:47:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:00 INFO - 'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:00 INFO - 'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['damp', 'tps']}, 16:47:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:00 INFO - 'tests': ['damp', 'tps']}, 16:47:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['dromaeo_dom']}, 16:47:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:47:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['basic_compositor_video']}, 16:47:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:47:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['a11yr', 16:47:00 INFO - 'ts_paint', 16:47:00 INFO - 'tpaint', 16:47:00 INFO - 'sessionrestore', 16:47:00 INFO - 'sessionrestore_no_auto_restore', 16:47:00 INFO - 'tabpaint']}, 16:47:00 INFO - 'other-e10s': {'tests': ['a11yr', 16:47:00 INFO - 'ts_paint', 16:47:00 INFO - 'tpaint', 16:47:00 INFO - 'sessionrestore', 16:47:00 INFO - 'sessionrestore_no_auto_restore', 16:47:00 INFO - 'tabpaint']}, 16:47:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:47:00 INFO - 'ts_paint', 16:47:00 INFO - 'tpaint', 16:47:00 INFO - 'sessionrestore', 16:47:00 INFO - 'sessionrestore_no_auto_restore', 16:47:00 INFO - 'tabpaint']}, 16:47:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:47:00 INFO - 'ts_paint', 16:47:00 INFO - 'tpaint', 16:47:00 INFO - 'sessionrestore', 16:47:00 INFO - 'sessionrestore_no_auto_restore', 16:47:00 INFO - 'tabpaint']}, 16:47:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['a11yr', 16:47:00 INFO - 'ts_paint', 16:47:00 INFO - 'tpaint', 16:47:00 INFO - 'sessionrestore', 16:47:00 INFO - 'sessionrestore_no_auto_restore', 16:47:00 INFO - 'tabpaint']}, 16:47:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['a11yr', 16:47:00 INFO - 'ts_paint', 16:47:00 INFO - 'tpaint', 16:47:00 INFO - 'sessionrestore', 16:47:00 INFO - 'sessionrestore_no_auto_restore', 16:47:00 INFO - 'tabpaint']}, 16:47:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['tsvgx', 16:47:00 INFO - 'tsvgr_opacity', 16:47:00 INFO - 'tart', 16:47:00 INFO - 'tscrollx', 16:47:00 INFO - 'cart']}, 16:47:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:47:00 INFO - 'tsvgr_opacity', 16:47:00 INFO - 'tart', 16:47:00 INFO - 'tscrollx', 16:47:00 INFO - 'cart']}, 16:47:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:00 INFO - 'talos_options': ['--disable-e10s'], 16:47:00 INFO - 'tests': ['tp5o']}, 16:47:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:00 INFO - 'tests': ['tp5o']}, 16:47:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:00 INFO - 'talos_options': ['--disable-e10s', 16:47:00 INFO - '--xperf_path', 16:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:00 INFO - 'tests': ['tp5n']}, 16:47:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:00 INFO - 'talos_options': ['--xperf_path', 16:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:00 INFO - 'tests': ['tp5n']}}, 16:47:00 INFO - 'talos.zip': {'path': '', 16:47:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:47:00 INFO - Running post-action listener: _resource_record_post_action 16:47:00 INFO - [mozharness: 2016-09-23 23:47:00.333284Z] Finished populate-webroot step (success) 16:47:00 INFO - [mozharness: 2016-09-23 23:47:00.333417Z] Running create-virtualenv step. 16:47:00 INFO - Running pre-action listener: _resource_record_pre_action 16:47:00 INFO - Running main action method: create_virtualenv 16:47:00 INFO - Creating virtualenv /builds/slave/test/build/venv 16:47:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:47:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:47:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:47:00 INFO - Using real prefix '/tools/python27' 16:47:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 16:47:04 INFO - Installing pip.................done. 16:47:04 INFO - Return code: 0 16:47:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47: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', 'pip>=1.5'] in /builds/slave/test/build 16:47: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 pip>=1.5 16:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:04 INFO - 'HOME': '/Users/cltbld', 16:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:04 INFO - 'LOGNAME': 'cltbld', 16:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:04 INFO - 'MOZ_NO_REMOTE': '1', 16:47:04 INFO - 'NO_EM_RESTART': '1', 16:47:04 INFO - 'PAGER': '/bin/cat', 16:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:04 INFO - 'PWD': '/builds/slave/test', 16:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:04 INFO - 'SHELL': '/bin/bash', 16:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:04 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:04 INFO - 'USER': 'cltbld', 16:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:04 INFO - 'XPC_FLAGS': '0x0', 16:47:04 INFO - 'XPC_SERVICE_NAME': '0', 16:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:47:04 INFO - Cleaning up... 16:47:04 INFO - Return code: 0 16:47:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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', '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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:47: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 psutil>=3.1.1 16:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:04 INFO - 'HOME': '/Users/cltbld', 16:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:04 INFO - 'LOGNAME': 'cltbld', 16:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:04 INFO - 'MOZ_NO_REMOTE': '1', 16:47:04 INFO - 'NO_EM_RESTART': '1', 16:47:04 INFO - 'PAGER': '/bin/cat', 16:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:04 INFO - 'PWD': '/builds/slave/test', 16:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:04 INFO - 'SHELL': '/bin/bash', 16:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:04 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:04 INFO - 'USER': 'cltbld', 16:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:04 INFO - 'XPC_FLAGS': '0x0', 16:47:04 INFO - 'XPC_SERVICE_NAME': '0', 16:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:04 INFO - Downloading/unpacking psutil>=3.1.1 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:07 INFO - Installing collected packages: psutil 16:47:07 INFO - Running setup.py install for psutil 16:47:08 INFO - building 'psutil._psutil_osx' extension 16:47:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:47:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:47:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:47:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:47:08 INFO - building 'psutil._psutil_posix' extension 16:47:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:47:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:47:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:47:08 INFO - ^ 16:47:08 INFO - 1 warning generated. 16:47:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:47:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:09 INFO - Successfully installed psutil 16:47:09 INFO - Cleaning up... 16:47:09 INFO - Return code: 0 16:47:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:09 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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:47:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:09 INFO - 'HOME': '/Users/cltbld', 16:47:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:09 INFO - 'LOGNAME': 'cltbld', 16:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:09 INFO - 'MOZ_NO_REMOTE': '1', 16:47:09 INFO - 'NO_EM_RESTART': '1', 16:47:09 INFO - 'PAGER': '/bin/cat', 16:47:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:09 INFO - 'PWD': '/builds/slave/test', 16:47:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:09 INFO - 'SHELL': '/bin/bash', 16:47:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:09 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:09 INFO - 'USER': 'cltbld', 16:47:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:09 INFO - 'XPC_FLAGS': '0x0', 16:47:09 INFO - 'XPC_SERVICE_NAME': '0', 16:47:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:47:11 INFO - Installing collected packages: mozsystemmonitor 16:47:11 INFO - Running setup.py install for mozsystemmonitor 16:47:12 INFO - Successfully installed mozsystemmonitor 16:47:12 INFO - Cleaning up... 16:47:12 INFO - Return code: 0 16:47:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:12 INFO - 'HOME': '/Users/cltbld', 16:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:12 INFO - 'LOGNAME': 'cltbld', 16:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:12 INFO - 'MOZ_NO_REMOTE': '1', 16:47:12 INFO - 'NO_EM_RESTART': '1', 16:47:12 INFO - 'PAGER': '/bin/cat', 16:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:12 INFO - 'PWD': '/builds/slave/test', 16:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:12 INFO - 'SHELL': '/bin/bash', 16:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:12 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:12 INFO - 'USER': 'cltbld', 16:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:12 INFO - 'XPC_FLAGS': '0x0', 16:47:12 INFO - 'XPC_SERVICE_NAME': '0', 16:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:12 INFO - Downloading/unpacking jsonschema==2.5.1 16:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:47:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:15 INFO - Downloading functools32-3.2.3-2.tar.gz 16:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:47:15 INFO - warning: no files found matching '*.txt' 16:47:15 INFO - no previously-included directories found matching 'build' 16:47:15 INFO - no previously-included directories found matching 'dist' 16:47:15 INFO - no previously-included directories found matching '.git*' 16:47:15 INFO - Installing collected packages: jsonschema, functools32 16:47:15 INFO - Running setup.py install for functools32 16:47:15 INFO - warning: no files found matching '*.txt' 16:47:15 INFO - no previously-included directories found matching 'build' 16:47:15 INFO - no previously-included directories found matching 'dist' 16:47:15 INFO - no previously-included directories found matching '.git*' 16:47:15 INFO - Successfully installed jsonschema functools32 16:47:15 INFO - Cleaning up... 16:47:15 INFO - Return code: 0 16:47:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:15 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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:15 INFO - 'HOME': '/Users/cltbld', 16:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:15 INFO - 'LOGNAME': 'cltbld', 16:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:15 INFO - 'MOZ_NO_REMOTE': '1', 16:47:15 INFO - 'NO_EM_RESTART': '1', 16:47:15 INFO - 'PAGER': '/bin/cat', 16:47:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:15 INFO - 'PWD': '/builds/slave/test', 16:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:15 INFO - 'SHELL': '/bin/bash', 16:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:15 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:15 INFO - 'USER': 'cltbld', 16:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:15 INFO - 'XPC_FLAGS': '0x0', 16:47:15 INFO - 'XPC_SERVICE_NAME': '0', 16:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:47:15 INFO - Cleaning up... 16:47:16 INFO - Return code: 0 16:47:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:47:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:16 INFO - 'HOME': '/Users/cltbld', 16:47:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:16 INFO - 'LOGNAME': 'cltbld', 16:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:16 INFO - 'MOZ_NO_REMOTE': '1', 16:47:16 INFO - 'NO_EM_RESTART': '1', 16:47:16 INFO - 'PAGER': '/bin/cat', 16:47:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:16 INFO - 'PWD': '/builds/slave/test', 16:47:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:16 INFO - 'SHELL': '/bin/bash', 16:47:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:16 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:16 INFO - 'USER': 'cltbld', 16:47:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:16 INFO - 'XPC_FLAGS': '0x0', 16:47:16 INFO - 'XPC_SERVICE_NAME': '0', 16:47:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:16 INFO - Downloading/unpacking blobuploader==1.2.4 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:18 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:47:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:19 INFO - Downloading docopt-0.6.1.tar.gz 16:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:19 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:19 INFO - Running setup.py install for blobuploader 16:47:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:47:20 INFO - Running setup.py install for requests 16:47:20 INFO - Running setup.py install for docopt 16:47:20 INFO - Successfully installed blobuploader requests docopt 16:47:20 INFO - Cleaning up... 16:47:20 INFO - Return code: 0 16:47:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:20 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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:20 INFO - 'HOME': '/Users/cltbld', 16:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:20 INFO - 'LOGNAME': 'cltbld', 16:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:20 INFO - 'MOZ_NO_REMOTE': '1', 16:47:20 INFO - 'NO_EM_RESTART': '1', 16:47:20 INFO - 'PAGER': '/bin/cat', 16:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:20 INFO - 'PWD': '/builds/slave/test', 16:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:20 INFO - 'SHELL': '/bin/bash', 16:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:20 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:20 INFO - 'USER': 'cltbld', 16:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:20 INFO - 'XPC_FLAGS': '0x0', 16:47:20 INFO - 'XPC_SERVICE_NAME': '0', 16:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-TLIrF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-NiXCof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Lh2ucz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-K_ThUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-7u9GPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-96aXCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-35ISt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-AKDUoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:21 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-n0sy__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:22 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-qXIVSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:22 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-ZNSnTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:22 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Sp8dkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:22 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-p72871-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:22 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-zqKzH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:22 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Kg_uyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:22 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-jKrYiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:22 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-4JE1lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:22 INFO - Running setup.py install for manifestparser 16:47:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozcrash 16:47:23 INFO - Running setup.py install for mozdebug 16:47:23 INFO - Running setup.py install for mozdevice 16:47:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozfile 16:47:23 INFO - Running setup.py install for mozhttpd 16:47:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozinfo 16:47:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:47:23 INFO - Running setup.py install for mozInstall 16:47:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for mozleak 16:47:24 INFO - Running setup.py install for mozlog 16:47:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for moznetwork 16:47:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for mozprocess 16:47:24 INFO - Running setup.py install for mozprofile 16:47:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:47:24 INFO - Running setup.py install for mozrunner 16:47:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:47:25 INFO - Running setup.py install for mozscreenshot 16:47:25 INFO - Running setup.py install for moztest 16:47:25 INFO - Running setup.py install for mozversion 16:47:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:47:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:25 INFO - Cleaning up... 16:47:25 INFO - Return code: 0 16:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:25 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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:25 INFO - 'HOME': '/Users/cltbld', 16:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:25 INFO - 'LOGNAME': 'cltbld', 16:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:25 INFO - 'MOZ_NO_REMOTE': '1', 16:47:25 INFO - 'NO_EM_RESTART': '1', 16:47:25 INFO - 'PAGER': '/bin/cat', 16:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:25 INFO - 'PWD': '/builds/slave/test', 16:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:25 INFO - 'SHELL': '/bin/bash', 16:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:25 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:25 INFO - 'USER': 'cltbld', 16:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:25 INFO - 'XPC_FLAGS': '0x0', 16:47:25 INFO - 'XPC_SERVICE_NAME': '0', 16:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:25 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-L9Jr_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:25 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-FikY1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:25 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)) 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:25 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-UGiZUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Hotm7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:26 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)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-oAtGcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-xgA4G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-1LaJtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Z6jnoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-4a6dsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-WPFIq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-axD5Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:26 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-PXIZvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:27 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)) 16:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:27 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-SqEcuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:27 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-YKZbc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:27 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)) 16:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:27 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-bWqTSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:27 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-mX6fF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:27 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)) 16:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:27 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-jQxKZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:47:27 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)) 16:47:27 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)) 16:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:47:27 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)) 16:47:27 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)) 16:47:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:29 INFO - Downloading blessings-1.6.tar.gz 16:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:30 INFO - Installing collected packages: blessings 16:47:30 INFO - Running setup.py install for blessings 16:47:30 INFO - Successfully installed blessings 16:47:30 INFO - Cleaning up... 16:47:30 INFO - Return code: 0 16:47:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:30 INFO - Reading from file tmpfile_stdout 16:47:30 INFO - Current package versions: 16:47:30 INFO - blessings == 1.6 16:47:30 INFO - blobuploader == 1.2.4 16:47:30 INFO - docopt == 0.6.1 16:47:30 INFO - functools32 == 3.2.3-2 16:47:30 INFO - jsonschema == 2.5.1 16:47:30 INFO - manifestparser == 1.1 16:47:30 INFO - mozInstall == 1.12 16:47:30 INFO - mozcrash == 0.17 16:47:30 INFO - mozdebug == 0.1 16:47:30 INFO - mozdevice == 0.48 16:47:30 INFO - mozfile == 1.2 16:47:30 INFO - mozhttpd == 0.7 16:47:30 INFO - mozinfo == 0.9 16:47:30 INFO - mozleak == 0.1 16:47:30 INFO - mozlog == 3.4 16:47:30 INFO - moznetwork == 0.27 16:47:30 INFO - mozprocess == 0.23 16:47:30 INFO - mozprofile == 0.28 16:47:30 INFO - mozrunner == 6.12 16:47:30 INFO - mozscreenshot == 0.1 16:47:30 INFO - mozsystemmonitor == 0.3 16:47:30 INFO - moztest == 0.7 16:47:30 INFO - mozversion == 1.4 16:47:30 INFO - psutil == 3.1.1 16:47:30 INFO - requests == 1.2.3 16:47:30 INFO - wsgiref == 0.1.2 16:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:30 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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:30 INFO - 'HOME': '/Users/cltbld', 16:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:30 INFO - 'LOGNAME': 'cltbld', 16:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:30 INFO - 'MOZ_NO_REMOTE': '1', 16:47:30 INFO - 'NO_EM_RESTART': '1', 16:47:30 INFO - 'PAGER': '/bin/cat', 16:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:30 INFO - 'PWD': '/builds/slave/test', 16:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:30 INFO - 'SHELL': '/bin/bash', 16:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:30 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:30 INFO - 'USER': 'cltbld', 16:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:30 INFO - 'XPC_FLAGS': '0x0', 16:47:30 INFO - 'XPC_SERVICE_NAME': '0', 16:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:47:30 INFO - Cleaning up... 16:47:30 INFO - Return code: 0 16:47:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:30 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 0x108149490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080bf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4735d6ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, '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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:30 INFO - 'HOME': '/Users/cltbld', 16:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:30 INFO - 'LOGNAME': 'cltbld', 16:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:30 INFO - 'MOZ_NO_REMOTE': '1', 16:47:30 INFO - 'NO_EM_RESTART': '1', 16:47:30 INFO - 'PAGER': '/bin/cat', 16:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:30 INFO - 'PWD': '/builds/slave/test', 16:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:30 INFO - 'SHELL': '/bin/bash', 16:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:47:30 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:30 INFO - 'USER': 'cltbld', 16:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:30 INFO - 'XPC_FLAGS': '0x0', 16:47:30 INFO - 'XPC_SERVICE_NAME': '0', 16:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:47:31 INFO - Cleaning up... 16:47:31 INFO - Return code: 0 16:47:31 INFO - Running post-action listener: _resource_record_post_action 16:47:31 INFO - Running post-action listener: _start_resource_monitoring 16:47:31 INFO - Starting resource monitoring. 16:47:31 INFO - [mozharness: 2016-09-23 23:47:31.144179Z] Finished create-virtualenv step (success) 16:47:31 INFO - [mozharness: 2016-09-23 23:47:31.145151Z] Running install step. 16:47:31 INFO - Running pre-action listener: _resource_record_pre_action 16:47:31 INFO - Running main action method: install 16:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:31 INFO - Reading from file tmpfile_stdout 16:47:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:47:31 INFO - Reading from file tmpfile_stdout 16:47:31 INFO - Output received: 16:47:31 INFO - Usage: mozinstall [options] installer 16:47:31 INFO - Options: 16:47:31 INFO - -h, --help show this help message and exit 16:47:31 INFO - -d DEST, --destination=DEST 16:47:31 INFO - Directory to install application into. [default: 16:47:31 INFO - "/builds/slave/test"] 16:47:31 INFO - --app=APP Application being installed. [default: firefox] 16:47:31 INFO - mkdir: /builds/slave/test/build/application 16:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:48:03 INFO - Reading from file tmpfile_stdout 16:48:03 INFO - Output received: 16:48:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:48:03 INFO - Running post-action listener: _resource_record_post_action 16:48:03 INFO - [mozharness: 2016-09-23 23:48:03.828466Z] Finished install step (success) 16:48:03 INFO - [mozharness: 2016-09-23 23:48:03.828635Z] Running run-tests step. 16:48:03 INFO - Running pre-action listener: _resource_record_pre_action 16:48:03 INFO - Running main action method: run_tests 16:48:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:48:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:48:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:48:03 INFO - 2016-09-23 16:48:03.842 screenresolution[1650:8470] starting screenresolution argv=screenresolution get 16:48:03 INFO - 2016-09-23 16:48:03.845 screenresolution[1650:8470] Display 0: 1600x1200x32@60 16:48:03 INFO - 2016-09-23 16:48:03.851 screenresolution[1651:8472] starting screenresolution argv=screenresolution list 16:48:03 INFO - Available Modes on Display 0 16:48:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:48:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:48:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:48:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:48:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:48:04 INFO - Intel Iris: 16:48:04 INFO - Chipset Model: Intel Iris 16:48:04 INFO - Type: GPU 16:48:04 INFO - Bus: Built-In 16:48:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:48:04 INFO - Vendor: Intel (0x8086) 16:48:04 INFO - Device ID: 0x0a2e 16:48:04 INFO - Revision ID: 0x0009 16:48:04 INFO - Displays: 16:48:04 INFO - Display: 16:48:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:48:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:48:04 INFO - Display Serial Number: 1600x1200 60 16:48:04 INFO - Main Display: Yes 16:48:04 INFO - Mirror: Off 16:48:04 INFO - Online: Yes 16:48:04 INFO - Rotation: Supported 16:48:04 INFO - Return code: 0 16:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:48:04 INFO - Python 2.7.3 16:48:04 INFO - Return code: 0 16:48:04 INFO - grabbing minidump binary from tooltool 16:48: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')]} 16:48:04 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 0x107f5dd30>, '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 0x107dc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f55b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:48:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:48:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:48:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:48:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:48:04 INFO - Return code: 0 16:48:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:48:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:48:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:48:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:48:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0149 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FcYbVWSPaA/Render', 16:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:04 INFO - 'HOME': '/Users/cltbld', 16:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:04 INFO - 'LOGNAME': 'cltbld', 16:48:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:48:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:04 INFO - 'MOZ_NO_REMOTE': '1', 16:48:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:48:04 INFO - 'NO_EM_RESTART': '1', 16:48:04 INFO - 'PAGER': '/bin/cat', 16:48:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:04 INFO - 'PWD': '/builds/slave/test', 16:48:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:04 INFO - 'SHELL': '/bin/bash', 16:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkXZZcSWw1/Listeners', 16:48:04 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 16:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:04 INFO - 'USER': 'cltbld', 16:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:04 INFO - 'XPC_FLAGS': '0x0', 16:48:04 INFO - 'XPC_SERVICE_NAME': '0', 16:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:48:04 INFO - mozversion application_buildid: 20160923145125 16:48:04 INFO - mozversion application_changeset: 9d6a1ee63674c52222be7d6bc946fbd798846dcd 16:48:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:48:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:48:04 INFO - mozversion application_name: Firefox 16:48:04 INFO - mozversion application_remotingname: firefox-dev 16:48:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:48:04 INFO - mozversion application_vendor: Mozilla 16:48:04 INFO - mozversion application_version: 51.0a2 16:48:04 INFO - mozversion platform_buildid: 20160923145125 16:48:04 INFO - mozversion platform_changeset: 9d6a1ee63674c52222be7d6bc946fbd798846dcd 16:48:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:48:04 INFO - mozversion platform_version: 51.0a2 16:48:04 INFO - using testdate: 1474674484 16:48:04 INFO - actual date: 1474674484 16:48:04 INFO - starting webserver on 'localhost:49273' 16:48:04 INFO - SUITE-START | Running 2 tests 16:48:04 INFO - TEST-START | dromaeo_css 16:48:04 INFO - operating with platform_type : mac_ 16:48:04 INFO - Initialising browser for dromaeo_css test... 16:48:04 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpGpauhL/profile http://localhost:49273/getInfo.html) 16:48:07 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 16:48:07 INFO - PROCESS | 1661 | colorDepth:24 16:48:07 INFO - PROCESS | 1661 | Browser inner width/height: 1024/663 16:48:07 INFO - PROCESS | 1661 | __metrics 16:48:07 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:48:07 INFO - TEST-INFO | 1661: exit 0 16:48:07 INFO - Browser initialized. 16:48:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:48:07 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpGpauhL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:19 INFO - PROCESS | 1665 | RSS: Main: 234905600 16:48:19 INFO - PROCESS | 1665 | 16:49:09 INFO - PROCESS | 1665 | 1474674549634 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] 16:51:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 16:51:23 INFO - PROCESS | 1665 | RSS: Main: 246358016 16:51:23 INFO - PROCESS | 1665 | 16:54:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 16:54:25 INFO - PROCESS | 1665 | RSS: Main: 256503808 16:54:25 INFO - PROCESS | 1665 | 16:57:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 16:57:28 INFO - PROCESS | 1665 | RSS: Main: 258899968 16:57:28 INFO - PROCESS | 1665 | 17:00:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 17:00:30 INFO - PROCESS | 1665 | RSS: Main: 259084288 17:00:30 INFO - PROCESS | 1665 | 17:03:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 17:03:34 INFO - PROCESS | 1665 | RSS: Main: 263524352 17:03:34 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 17:06:37 INFO - PROCESS | 1665 | RSS: Main: 266219520 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | __start_tp_report 17:06:37 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 17:06:37 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 17:06:37 INFO - PROCESS | 1665 | |i|pagename|runs| 17:06:37 INFO - PROCESS | 1665 | |0;dojo.html;3427.126082848873;3431.1936694876717;3449.62054174041;3461.878834240802;3464.982675086625;5746.741396637146;5750.7412166452505;5766.625169363999;5793.884122317551;5795.391483894194;5756.597038207327;5769.884602307962;5775;5782.10377391504;5800.129980502927;5268.288781014552;5288.788448462057;5316.096263635172;5330.653507521999;5331.546818520431;5358.812441564546;5361.785528578852;5374.408815030343;5385.973070134643;5387.272718183034;5261.9476104779005;5262.657927234736;5354.491323324278;5359.651622644536;5366.70483123428;5214.530692237698;5260.158374660055;5361.517463428271;5365.597580181502;5419.024575576394;4822.927656085161;4979.954209615985;5168.2764412982215;5299.49654782795;5316.973415132899;5651.943480565183;5766.192733017381;5775.27809023872;5847.590668653196;5888.440598143169;5062.620303477254;6217.067439884054;6224.751009959597;6268.905966410507;6327.96836015817;6309.526785491061;6309.810705678791;6314.336994615545;6319;6335.334789847046;5901.3508514063415;5904.084866845603;5925.170476133345;5935.347111817697;5951.464368206795;6225.035119556476;6268.247810262797;6288.685565721696;6290.874182516415;6297.559170858088;6200.193974783249;6230.376962303824;6255.874882502325;6288.151099601587;6292.716827742763;6316.905246421307;6320.525960552977;6351.491880649629;6354.269259035178;6367.936320636827;6141.854248382413;6164.630122192593;6186.876262474815;6248.156498872685;6302;4769.928451073237;5142.897142057138;5718.971405142947;6303.527235457359;6307.306196318493;4308.763018033976;4972.477889821589;4992.2761199626575;4995.400551933792;5013.974930125399;4361.629261512807;4367.716098453654;4406.427164468662;4474.149911516802;4520.638348932078;5150.407703114115;5932.377100404482;6006.879862402815;6031.125486804389;6066.99683656584;5189.532942035235;6198.163247961557;6210.192674952227;6245.344238854946;6268.937310626927;5779.711014449261;5892.911606325909;5921.082232254007;5986.5210783137245;5995.730192141364;5451.236826844245;5453.263809385761;5455.945440545624;5458.918116228259;5461.563074953994;6444.806655800334;6470.676466176767;6473.77341793035;6473.805785826433;6488.999999999905;6154.846128846635;6222.937770622236;6251.062340648939;6257.217847769029;6262.74949002053;6371.74513019474;6445.838854028687;6457.5479716419395;6459.5478316519275;6469.126667899774;6256.468200202851;6262.655553944577;6304.810855674337;6326.9683651581445;6338.0809782580345;6167.136600875791;6214.347493513116;6218.378162183745;6298.212723409574;6350.618962862243;5028.874278143076;5965.552583556164;5991.569551202579;6240.875182496234;6251;5066.9239961401345;5366.221897824872;6206.193194884817;6217.222847144107;6219.378062193744;5844.181814545882;5850.648961062179;5991;6093.695315234309;6117.816465506042;6090.665013424305;6125.876495711566;6154.292256390572;6211.3167551570195;6211.9689401552705;4976.950230497649;6086.2087928569;6093.60391574564;6117.938820611737;6239.844003899939 17:06:37 INFO - PROCESS | 1665 | |1;ext.html;439.3563429575671;441.93934557063045;501.363268648816;505.12613179199985;517.0795983149994;40230.597694023054;42449.78775106128;42543.93640158998;42630.36054459186;42640.36039459407;36275.9117226483;40922.18155636886;44011.55988440123;44456.55543444565;44725.77637111818;9718.222542196625;9993.200543956502;10015.74960625983;10025.849612255823;10026.298159128864;9681.612735490571;9833.557489912972;9847.803043939117;9873.062059104373;9879.110880020797;9949.95025024874;9964.551595178234;9987.851397089355;9989.100980911717;9994.650187243447;9866.753331166743;9901.554430050664;9932.90067099327;9952.751181220456;9960.85058724116;9785.412875227508;9897.307188496809;9928.90071099287;9929.751756206153;9933.950330248375;42122.578774212176;42542;42552.14895702068;42609;42738;3208.631007434152;3374.7637665363436;3392.8973083747633;3589.425691889285;3885.825137868803;31192.376152476823;31682;31869.521957170662;31901.52147717786;32297.031089067365;3173.4922412414135;3204.1829333520036;3262.429074911881;3277.1643230975947;3338.983305083483;515815;519246.9999999962;520359;520363.39818301046;522930;59687;64509.99999999906;64572.354276457576;64736.67631661812;64769.67615161894;35038.47442288368;36214.45678314827;36406;67593.32406675871;67871.66064169747;17181.828181718272;17343.3062677494;17379.73930391045;17433.738493922603;17484.91257543704;13166.14420062712;13243.8742706871;13254.40355184019;13292.468301268034;13297.3351332433;19732.901335493232;19786.802131978784;19809.603807923762;19959.00204989774;20053.59892802165;7869.449138560246;7941.45141697375;7966.163552826985;7975.920240797634;7985.361171106298;828.6726742936506;909.4580647091395;953.9904600953902;1009.4599389326675;1091.901728844408;27285.72714272832;30583;30761.538576921364;31074;31877;899.9775005624912;1058.074185088048;1071.983920241197;1089.1178145702006;1114.7213196700825;15597.922010389875;16138.75791863123;16211.918940405223;16350.75473867893;16408.67182656364;588423.1157688454;628809;650745;669854;670044;50935;58217;59599;60164.69917650384;60285.39714602798;1369.2605992763995;1375.3604573873197;1402.025592213402;1403.6561042544643;1411.84469708332;26551.60172597374;30172.24569385783;30307.545386818776;30808.845955770976;31054.534181986837;52773.7361313191;53240.73379633077;53671;53747.19379209237;53959.73020134874;614527;616578;619124;620127;620886;27552.44895102127;27584.724152758215;27890.721092789623;27926.3018424541;27964.44071118607;48430.757846210545;48711.512884870695;49519.50480495293;49676.50323496863;50126;40113.99715007148;40743.38884916788;41064.58935410608;41652.79173604112;42131;40629.57796477109;40998.79500602478;41207.7939610312;41904.79047604743;42075.36886946637;34275.4858677125;35997.46003809998;39541.01147471336;39827.60172398239;41162.79418602888;34032;36022.639773602976;36086.917392478266;36111.916642500764;36219.456708149926;26381.604275935493;26597.867010664824;26672.46655066849;26798.987783076347;26904.596431053942 17:06:37 INFO - PROCESS | 1665 | |2;jquery.html;369.39419352262297;374.63660249557927;379.1942122988649;382.4225419616378;391.25465987294217;18754.343597974075;19993.900030499863;20153.496162595926;20190.293339733093;20336.88147151906;18762.155702993365;18841.528961775963;19220.135093920773;20100.69848952267;20312.796872031275;5845.09401042839;5869.618474799146;6009.609375390607;6091.695415229243;6153.876922461548;3872.2642697887454;6164.815055548341;6217.1917650705345;6221.377862213788;6236.968815155918;4065.024394145413;5860.765569377219;6146.907796383058;6165.106059621352;6211.068339749028;5964.612300200473;6119.296280927706;6165.075238714184;6183.412575805291;6222.408871157233;5950.256217972754;5951.880962380771;5956.821295361146;5957.136215248808;5957.970210148965;14039;23782;23922;24192.395190120213;24637.753622463726;2005.568802707425;2184.344696591016;2220.700205472273;2598.1555994301925;2600.557905156128;9871.309008369417;10289.279750417474;11111.00000999914;14938.62653433662;15024;1777.6711308407987;1808.7919889212778;1874.109797846026;1924.0956750327323;1928.594995051041;119044.40477797555;119845.40077299645;120021.39989300085;121003.78996210013;126205;7663.540187588763;8478.152184781473;9565.90434095664;9757.707268781947;10041.4863274627;12314.445849936774;12364.876351236373;12431.31627760482;12436.689082773004;12451.94158496538;7985.800354991172;8066.919330806734;8105;8169.918300817035;8262.17378262169;8512.659493620185;8589.226969572768;8620.698275560326;8687.391882568287;8755.299576034029;3221.4845624699938;3607.603163651996;3835.6931445484292;3895.8052097395016;3952.031752220667;1491.336355321893;1799.7120460726483;1910.4841692742882;1939.8448124150034;1979.1687491253708;858.2318824651902;869.2524428991063;930.4928813796497;945.9054094590623;958.2477754962321;16760.916195419188;17992.740508164305;19381.689056641368;20426;21219.78780212209;875.7022612311717;898.2679116520146;933.6452148183647;943.8206740719241;965.9517024148764;9567.282453815853;10093.646722364681;10701.625443109453;10859.83710244347;10867.239293249397;568194.1590292022;586257;596413;607459;611357;127550;128530.35734821267;132707.33646331707;137458;139583;358.63061047121505;392.61915941536665;452.79397873967264;455.47165288265455;457.3231617206553;8746.868796967923;11049.447527623426;11061.557537698724;11192.21654484211;11304.660860174208;53659.463405365444;53966.19050714164;56129.158062628274;57170;58045;59298.81402371842;67377;81806;85232;86113.13886861302;8004.839903201787;8093.959530202547;8143.633536490754;8402.537860417735;8541.658333666584;9069.727908162766;12011.81982270284;12356.814647780111;12790.552330668383;12987.675308117372;10777.167881460327;11069.667909962714;11199.432079509039;11305.886941130813;11331.150163737588;10359.32664376813;10788.190885683449;10804;11184.161187910777;11246.268992515788;10909.799922008731;11044.558217671203;11073.667789966314;11102.777944441228;11667.708307292385;7209.918512223208;7386.596546656118;8110.351171906115;8296.585170741319;8338.87491687613;8170.01959764832;8452.661893524437;8902.821943560963;11079.72300692489;11334.433278336215 17:06:37 INFO - PROCESS | 1665 | |3;mootools.html;1281.634734100781;1504.052446958416;1612.298650087212;1759.780027496563;1814.6461440019202;8136.471129376587;8394.748157555268;8595.054544000155;9176.770580735476;9187.77030574236;8576.228139467446;8938.329625278098;8969.506677132771;9003.549822508881;9003.684871029514;1959.980400195994;2363.1492662641435;2368.538135063663;2374.6556749271344;2384.2489615771065;2343.379004563792;2361.197192954395;2385.821063420242;2397.5324811661735;2399.3881560202126;2371.893264803088;2376.738558758535;2384.7496012918655;2386.5823480890863;2401.0275838285525;2350.82368822339;2365.9763402366016;2368.6683864259016;2384.237044145865;2385.9642105368434;2325;2336.427575244059;2339.6841426407386;2343.988280058606;2346.4485845826216;8922.821543569093;8957.955210223907;9015.14356136166;9032.277417806625;9039.276857851357;5195.142801437758;5305.0450918834595;5364.007658583175;5374.032674118657;5384.946150538483;3598.3702852000797;3630.419132938717;3648.1426864686778;3653.6346365363515;3667.468217108531;1076.8976947190004;1084.2897901874285;1088.3089238333637;1098.2696506822954;1106.0985296982933;11738.295702257892;11852.170348075639;11886.702832429171;11904.940475297655;11920.46357913896;4561.475430325555;4657.371254880615;4778.331033655291;4847.2729090636685;4860.149473842134;9973.551190196458;10066.094051535398;10086.44524551142;10100.595976161017;10119.494025298705;5248.895022099537;5260.28986086881;5278.604104692164;5281.867953301121;5291.126964050965;4302.741835489881;4478.305862591304;4745.406824146981;4839.637027222972;4913.631477639191;3900.278448487039;3940.054386947112;3973;4020.577839326887;4046.2716710991717;1279.0598909801288;1290.7031382782013;1295.2940647347218;1295.591888555102;1298.4806077569049;921.8386782313203;923.0953665407937;923.7921367930651;924.4268553496875;951.7144856543148;4766.285057241442;5786.855328616818;5846.7076646167525;6036.305824830113;6079.665618390943;430.29002146458595;439.674640765831;442.8715672454952;776.751439539342;1042.2912419554775;3941.546722126992;3966.960330396717;3970.980145099256;4040.969552764085;4090.836366545305;10659.040686338112;11107.444627768578;11138.832917506244;11154.10767138627;11196.440177991068;9392.8591071134;10712.78574428507;10881.455927203766;11145.164112691418;11148.219624626197;8332.375071869634;8389.07720150783;8428.704995325133;8519.829603407898;8528.786780330542;5789;5958.463738263577;5971.820845374646;5987.790427335022;5991.281046274475;10041.648542300984;10104.69685909424;10242.948785256027;10247.795044099226;10256.846147307648;10212.65619341945;10253.948730256301;10255.94872025635;10468.895311046792;10484.685459436228;5694.117411801178;5708.771649133988;6578.210614726264;6790.558613690095;6950.914725582204;8300.501969881827;8434.957825210835;8442.451240669337;8567.100454452442;8580.884485016908;6614.768483103068;7623.085229772463;7628.199039100815;7655.272749088827;7721.305082542598;7380.752389425429;7488.5506869588;7531.472796904164;7633.389328853567;7649.770506884803;7072.434205263669;7077.504574679723;7151.141862976476;7163.785086447207;7164.820879478055;4999.325091112653;5029.974850125726;5035.169197082587;5119.28330033803;5187.948120518747;4720.645951553716;5021.899562008666;5028.818227716411;5056.191009438472;5206.895862082662 17:06:37 INFO - PROCESS | 1665 | |4;prototype.html;257.6200104845353;290.6570247108412;313.5281401490756;314.45913029589116;318.2568702080642;5001.974200448815;5505.614606977513;5527.226188333631;5650.8587285317835;5663.4336566343345;5125.359884836854;5349.806579302477;5490.72135063949;5503.587230957674;5510.8071217507395;3882.864099756509;4236.978815105927;4276.486821581415;4289.699721019514;4294.849680261176;3953.3674612062077;4145.585441455845;4269.893252668692;4309.676774241929;4324.913501729963;4037.878863634081;4222.324428091506;4243.111815242219;4244.872653820375;4250.766207858566;4227.957720422803;4253.319468884979;4265.7014009019385;4268.9573104268875;4278.272693642057;3402.030421329909;3713.2573485303046;3716.6655001049767;3717.8141092945243;3717.940386989722;4092.9795351023354;4748.667593268473;4840.918405085812;5364.356277246756;5491.258680078178;4352.499462561815;4717.410323709536;4780.418573970052;4788.497207793202;4796.3524924135145;5230.8169214077325;5551.417101204396;5754.813170995037;5831.883362332772;5847.649141051551;3607.6211997740384;3832.1760821423527;3887.455756194135;3913.9217215655813;3929.8821035368983;5271.947280527184;6086.026235802295;6136.846578835521;6177.505799535981;6182.845428864314;3209.3581283743347;3960.5841386653988;3977.2244412339314;3980.7810570418906;4001.679865610744;3781.3949768036982;3869.0550213648685;3995.901127190046;4002.6197511236387;4017.268257584812;3859.7684138951754;4456.6211871991245;4611.976940115278;4723.622110231173;4754;4522.5025247222775;5530.225768392428;5649.689267090267;5973.880522389528;5979.312379076462;1089.5968491658136;1116.1238427834273;1208.6313674329415;1232.3530146673068;1342.7515909556764;810.6028046257292;888.8666949639262;896.9686060987834;901.8996823874862;921.5439605423414;4725.5510726480925;5251.894962100737;5503.367112782002;5503.669779813224;5558.749856256478;5990.6705131218205;5992.340842507408;5993.520518358521;5995.490383317379;6000.549958753111;4463.018136010072;5283;5453.318335208099;5496.615236933456;5568.522007706531;2348.6278858353185;2566.7176610572824;2573.5716677243936;2685.44948285601;2704.8647567621542;4442.334124703237;4540.253146846177;4798.337961205811;5161.4322424533275;5265.815696450606;4680.7191568506;5143.768530416065;5153.3558305211845;5168.819091331786;5715.571332150105;6308.8107356778455;6405.839854003687;6437.935620643827;6451.677416129175;6458.644774537445;5563.609097725569;5781.219535362672;5811.4188581143235;6109.358517355614;6141.508679305734;5241.292425522505;5951;6028.939710603014;6034.24571928509;6142.723577438936;6248.4064013918605;6286.522667173302;6399.632136109669;6414.422701956846;6451.741930322734;3283.801412484378;3612.7471077024356;3735.43111893011;3983.2830090583975;3985.561588225351;4236.216299984513;5723.456271654186;6088.630058236861;6105.931461994044;6114.785982490592;5546.3638226722405;5698.686572238566;5809.912851307149;5966.404613992927;6003.549733769897;5112.335396398445;5867.237259156283;5909;5912.46787789101;5914.733836977261;4427.756473393994;5120.572193474928;5417.160340147283;5541.889162216814;5799.8550036249435;4907.77914993819;5323.547498462519;5478.890422191614;5986.6707331097205;6006.429389208019;5056.86220600362;5622.606417550732;5827.475527202572;5843.211166492639;5872.29532456108 17:06:37 INFO - PROCESS | 1665 | |5;yui.html;748.8202831320481;758.2872100225787;790.7904405332588;796.7251298302084;815.4903185509057;14678.559643210707;15200.6959860803;15233;15302.540923772305;15309.693806123885;13728.656783580416;13770.586882393543;13830.17018978862;13851.722965540683;13864.930675346634;808.2523665609317;824.6124321568853;860.2945584620613;866.4974314897345;867.6876324523166;851.9701810436636;856.0839901305606;856.9314454843598;858.3133493205441;859.8624220124781;893.7765558610347;896.5338024227398;896.9864053619401;897.0401670212875;898.24996128233;884.7832281091141;885.4156256870434;885.7785553611598;889.7108439757072;890.3100097424483;661.0943008078963;662.1788981662752;662.3707477896018;663.731188868509;665.5174998126369;15236.390544378211;15276.541703748906;15293.847061529354;15325.157116358596;15359.232038398148;13758.31208439574;13840.653983650389;14056.156630602196;14092.788608170784;14161.291935403291;11928.866757658096;11992.460339284753;12018.879811201863;12066.396680165957;12259.570915017932;3684.5578530576236;3697.704183665327;3742.8689995850013;3836;3852.6339997700175;106242.46878765634;113000.4349978253;114075;115020;117603;10626.574937002588;10733.677989660322;10890.29213101146;10904.127669786556;10905.509252083517;17683.646327073388;21707.45731356697;21723.913804309723;21952.012159452544;22173.33479995603;7910.2089791020435;7910.960445197852;7948.125706172316;7973.880391794128;8066.193380661887;4405.31717583775;4415.867523974286;4592.448906131285;4628.9537104628525;4680.4149481314835;3601.297746939374;3687.8524859005875;3715.238376132886;3718.5537735471917;3746.587875333711;608.9604175728564;620.5687047501942;638.7093872288098;648.6432462145801;654.1986067067899;466.6989791584409;563.2621266141286;593.2969431224013;642.5239454550857;675.6587923098901;9293.159367185814;9625.497370683534;9654.324197306121;9737.415755054719;9928.553215105338;571.5770329955802;644.3234603666132;661.4146480364816;668.38174688414;687.2715121469508;3745.4569087482164;4716.764161791965;4730.858074257778;4764;4802.927956080662;138606;145274;149337;149941;153287.23356383145;78057.43885122266;121711;126675.73324266824;126930;131309;89654;91821;95410;96889;108078.45960770146;9372.297077719062;9882.11061004513;9928.950355248178;9988.700338989842;10027.44849033281;54933.72533137309;55595.44404555903;56288.71855640696;56817.43182568121;57600.135997960904;78914;79049.60475197817;79622.60188699019;83401.58299208464;84154.31691366261;11240.55037798479;12263.632091037283;12417.31704756247;12695.492180312684;13008.21950682962;13800.382545613129;14406.639834004234;14647.560573182822;14720.263986800832;14726.337314821074;11119;12934.870651293366;13695;14124;14144.504942326968;13118.803217951547;13187.868121319048;13611.523596674466;13636.113652612548;14108.647283817987;13287.269200193696;13999.23004234736;14020.94842886808;14167.36246868914;14213.50252741149;10743.516541755484;11010.39442830652;11258.943705281421;11261.21171517986;11488.827667584826;10597.735056623646;11408.62508763825;11580.884191158317;11720.179587429138;11754.412279385826 17:06:37 INFO - PROCESS | 1665 | __end_tp_report 17:06:37 INFO - PROCESS | 1665 | __start_cc_report 17:06:37 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,356 17:06:37 INFO - PROCESS | 1665 | __end_cc_report 17:06:37 INFO - PROCESS | 1665 | __startTimestamp1474675597301__endTimestamp 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | ------- Summary: start ------- 17:06:37 INFO - PROCESS | 1665 | Number of tests: 6 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5762.62 Median:5986.52 stddev:663.96 (11.1%) stddev-sans-first:640.22 17:06:37 INFO - PROCESS | 1665 | Values: 3427.1 3431.2 3449.6 3461.9 3465.0 5746.7 5750.7 5766.6 5793.9 5795.4 5756.6 5769.9 5775.0 5782.1 5800.1 5268.3 5288.8 5316.1 5330.7 5331.5 5358.8 5361.8 5374.4 5386.0 5387.3 5261.9 5262.7 5354.5 5359.7 5366.7 5214.5 5260.2 5361.5 5365.6 5419.0 4822.9 4980.0 5168.3 5299.5 5317.0 5651.9 5766.2 5775.3 5847.6 5888.4 5062.6 6217.1 6224.8 6268.9 6328.0 6309.5 6309.8 6314.3 6319.0 6335.3 5901.4 5904.1 5925.2 5935.3 5951.5 6225.0 6268.2 6288.7 6290.9 6297.6 6200.2 6230.4 6255.9 6288.2 6292.7 6316.9 6320.5 6351.5 6354.3 6367.9 6141.9 6164.6 6186.9 6248.2 6302.0 4769.9 5142.9 5719.0 6303.5 6307.3 4308.8 4972.5 4992.3 4995.4 5014.0 4361.6 4367.7 4406.4 4474.1 4520.6 5150.4 5932.4 6006.9 6031.1 6067.0 5189.5 6198.2 6210.2 6245.3 6268.9 5779.7 5892.9 5921.1 5986.5 5995.7 5451.2 5453.3 5455.9 5458.9 5461.6 6444.8 6470.7 6473.8 6473.8 6489.0 6154.8 6222.9 6251.1 6257.2 6262.7 6371.7 6445.8 6457.5 6459.5 6469.1 6256.5 6262.7 6304.8 6327.0 6338.1 6167.1 6214.3 6218.4 6298.2 6350.6 5028.9 5965.6 5991.6 6240.9 6251.0 5066.9 5366.2 6206.2 6217.2 6219.4 5844.2 5850.6 5991.0 6093.7 6117.8 6090.7 6125.9 6154.3 6211.3 6212.0 4977.0 6086.2 6093.6 6117.9 6239.8 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:72683.73 Median:41430.29 stddev:159221.16 (384.3%) stddev-sans-first:159575.43 17:06:37 INFO - PROCESS | 1665 | Values: 439.4 441.9 501.4 505.1 517.1 40230.6 42449.8 42543.9 42630.4 42640.4 36275.9 40922.2 44011.6 44456.6 44725.8 9718.2 9993.2 10015.7 10025.8 10026.3 9681.6 9833.6 9847.8 9873.1 9879.1 9950.0 9964.6 9987.9 9989.1 9994.7 9866.8 9901.6 9932.9 9952.8 9960.9 9785.4 9897.3 9928.9 9929.8 9934.0 42122.6 42542.0 42552.1 42609.0 42738.0 3208.6 3374.8 3392.9 3589.4 3885.8 31192.4 31682.0 31869.5 31901.5 32297.0 3173.5 3204.2 3262.4 3277.2 3339.0 515815.0 519247.0 520359.0 520363.4 522930.0 59687.0 64510.0 64572.4 64736.7 64769.7 35038.5 36214.5 36406.0 67593.3 67871.7 17181.8 17343.3 17379.7 17433.7 17484.9 13166.1 13243.9 13254.4 13292.5 13297.3 19732.9 19786.8 19809.6 19959.0 20053.6 7869.4 7941.5 7966.2 7975.9 7985.4 828.7 909.5 954.0 1009.5 1091.9 27285.7 30583.0 30761.5 31074.0 31877.0 900.0 1058.1 1072.0 1089.1 1114.7 15597.9 16138.8 16211.9 16350.8 16408.7 588423.1 628809.0 650745.0 669854.0 670044.0 50935.0 58217.0 59599.0 60164.7 60285.4 1369.3 1375.4 1402.0 1403.7 1411.8 26551.6 30172.2 30307.5 30808.8 31054.5 52773.7 53240.7 53671.0 53747.2 53959.7 614527.0 616578.0 619124.0 620127.0 620886.0 27552.4 27584.7 27890.7 27926.3 27964.4 48430.8 48711.5 49519.5 49676.5 50126.0 40114.0 40743.4 41064.6 41652.8 42131.0 40629.6 40998.8 41207.8 41904.8 42075.4 34275.5 35997.5 39541.0 39827.6 41162.8 34032.0 36022.6 36086.9 36111.9 36219.5 26381.6 26597.9 26672.5 26799.0 26904.6 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:34579.13 Median:2109.06 stddev:99546.35 (4719.9%) stddev-sans-first:99792.46 17:06:37 INFO - PROCESS | 1665 | Values: 369.4 374.6 379.2 382.4 391.3 18754.3 19993.9 20153.5 20190.3 20336.9 18762.2 18841.5 19220.1 20100.7 20312.8 5845.1 5869.6 6009.6 6091.7 6153.9 3872.3 6164.8 6217.2 6221.4 6237.0 4065.0 5860.8 6146.9 6165.1 6211.1 5964.6 6119.3 6165.1 6183.4 6222.4 5950.3 5951.9 5956.8 5957.1 5958.0 14039.0 23782.0 23922.0 24192.4 24637.8 2005.6 2184.3 2220.7 2598.2 2600.6 9871.3 10289.3 11111.0 14938.6 15024.0 1777.7 1808.8 1874.1 1924.1 1928.6 119044.4 119845.4 120021.4 121003.8 126205.0 7663.5 8478.2 9565.9 9757.7 10041.5 12314.4 12364.9 12431.3 12436.7 12451.9 7985.8 8066.9 8105.0 8169.9 8262.2 8512.7 8589.2 8620.7 8687.4 8755.3 3221.5 3607.6 3835.7 3895.8 3952.0 1491.3 1799.7 1910.5 1939.8 1979.2 858.2 869.3 930.5 945.9 958.2 16760.9 17992.7 19381.7 20426.0 21219.8 875.7 898.3 933.6 943.8 966.0 9567.3 10093.6 10701.6 10859.8 10867.2 568194.2 586257.0 596413.0 607459.0 611357.0 127550.0 128530.4 132707.3 137458.0 139583.0 358.6 392.6 452.8 455.5 457.3 8746.9 11049.4 11061.6 11192.2 11304.7 53659.5 53966.2 56129.2 57170.0 58045.0 59298.8 67377.0 81806.0 85232.0 86113.1 8004.8 8094.0 8143.6 8402.5 8541.7 9069.7 12011.8 12356.8 12790.6 12987.7 10777.2 11069.7 11199.4 11305.9 11331.2 10359.3 10788.2 10804.0 11184.2 11246.3 10909.8 11044.6 11073.7 11102.8 11667.7 7209.9 7386.6 8110.4 8296.6 8338.9 8170.0 8452.7 8902.8 11079.7 11334.4 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5742.53 Median:4689.01 stddev:3270.50 (69.7%) stddev-sans-first:3262.49 17:06:37 INFO - PROCESS | 1665 | Values: 1281.6 1504.1 1612.3 1759.8 1814.6 8136.5 8394.7 8595.1 9176.8 9187.8 8576.2 8938.3 8969.5 9003.5 9003.7 1960.0 2363.1 2368.5 2374.7 2384.2 2343.4 2361.2 2385.8 2397.5 2399.4 2371.9 2376.7 2384.7 2386.6 2401.0 2350.8 2366.0 2368.7 2384.2 2386.0 2325.0 2336.4 2339.7 2344.0 2346.4 8922.8 8958.0 9015.1 9032.3 9039.3 5195.1 5305.0 5364.0 5374.0 5384.9 3598.4 3630.4 3648.1 3653.6 3667.5 1076.9 1084.3 1088.3 1098.3 1106.1 11738.3 11852.2 11886.7 11904.9 11920.5 4561.5 4657.4 4778.3 4847.3 4860.1 9973.6 10066.1 10086.4 10100.6 10119.5 5248.9 5260.3 5278.6 5281.9 5291.1 4302.7 4478.3 4745.4 4839.6 4913.6 3900.3 3940.1 3973.0 4020.6 4046.3 1279.1 1290.7 1295.3 1295.6 1298.5 921.8 923.1 923.8 924.4 951.7 4766.3 5786.9 5846.7 6036.3 6079.7 430.3 439.7 442.9 776.8 1042.3 3941.5 3967.0 3971.0 4041.0 4090.8 10659.0 11107.4 11138.8 11154.1 11196.4 9392.9 10712.8 10881.5 11145.2 11148.2 8332.4 8389.1 8428.7 8519.8 8528.8 5789.0 5958.5 5971.8 5987.8 5991.3 10041.6 10104.7 10242.9 10247.8 10256.8 10212.7 10253.9 10255.9 10468.9 10484.7 5694.1 5708.8 6578.2 6790.6 6950.9 8300.5 8435.0 8442.5 8567.1 8580.9 6614.8 7623.1 7628.2 7655.3 7721.3 7380.8 7488.6 7531.5 7633.4 7649.8 7072.4 7077.5 7151.1 7163.8 7164.8 4999.3 5030.0 5035.2 5119.3 5187.9 4720.6 5021.9 5028.8 5056.2 5206.9 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4656.08 Median:5165.13 stddev:1488.31 (28.8%) stddev-sans-first:1455.41 17:06:37 INFO - PROCESS | 1665 | Values: 257.6 290.7 313.5 314.5 318.3 5002.0 5505.6 5527.2 5650.9 5663.4 5125.4 5349.8 5490.7 5503.6 5510.8 3882.9 4237.0 4276.5 4289.7 4294.8 3953.4 4145.6 4269.9 4309.7 4324.9 4037.9 4222.3 4243.1 4244.9 4250.8 4228.0 4253.3 4265.7 4269.0 4278.3 3402.0 3713.3 3716.7 3717.8 3717.9 4093.0 4748.7 4840.9 5364.4 5491.3 4352.5 4717.4 4780.4 4788.5 4796.4 5230.8 5551.4 5754.8 5831.9 5847.6 3607.6 3832.2 3887.5 3913.9 3929.9 5271.9 6086.0 6136.8 6177.5 6182.8 3209.4 3960.6 3977.2 3980.8 4001.7 3781.4 3869.1 3995.9 4002.6 4017.3 3859.8 4456.6 4612.0 4723.6 4754.0 4522.5 5530.2 5649.7 5973.9 5979.3 1089.6 1116.1 1208.6 1232.4 1342.8 810.6 888.9 897.0 901.9 921.5 4725.6 5251.9 5503.4 5503.7 5558.7 5990.7 5992.3 5993.5 5995.5 6000.5 4463.0 5283.0 5453.3 5496.6 5568.5 2348.6 2566.7 2573.6 2685.4 2704.9 4442.3 4540.3 4798.3 5161.4 5265.8 4680.7 5143.8 5153.4 5168.8 5715.6 6308.8 6405.8 6437.9 6451.7 6458.6 5563.6 5781.2 5811.4 6109.4 6141.5 5241.3 5951.0 6028.9 6034.2 6142.7 6248.4 6286.5 6399.6 6414.4 6451.7 3283.8 3612.7 3735.4 3983.3 3985.6 4236.2 5723.5 6088.6 6105.9 6114.8 5546.4 5698.7 5809.9 5966.4 6003.5 5112.3 5867.2 5909.0 5912.5 5914.7 4427.8 5120.6 5417.2 5541.9 5799.9 4907.8 5323.5 5478.9 5986.7 6006.4 5056.9 5622.6 5827.5 5843.2 5872.3 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:23723.17 Median:3716.90 stddev:37545.16 (1010.1%) stddev-sans-first:37610.86 17:06:37 INFO - PROCESS | 1665 | Values: 748.8 758.3 790.8 796.7 815.5 14678.6 15200.7 15233.0 15302.5 15309.7 13728.7 13770.6 13830.2 13851.7 13864.9 808.3 824.6 860.3 866.5 867.7 852.0 856.1 856.9 858.3 859.9 893.8 896.5 897.0 897.0 898.2 884.8 885.4 885.8 889.7 890.3 661.1 662.2 662.4 663.7 665.5 15236.4 15276.5 15293.8 15325.2 15359.2 13758.3 13840.7 14056.2 14092.8 14161.3 11928.9 11992.5 12018.9 12066.4 12259.6 3684.6 3697.7 3742.9 3836.0 3852.6 106242.5 113000.4 114075.0 115020.0 117603.0 10626.6 10733.7 10890.3 10904.1 10905.5 17683.6 21707.5 21723.9 21952.0 22173.3 7910.2 7911.0 7948.1 7973.9 8066.2 4405.3 4415.9 4592.4 4629.0 4680.4 3601.3 3687.9 3715.2 3718.6 3746.6 609.0 620.6 638.7 648.6 654.2 466.7 563.3 593.3 642.5 675.7 9293.2 9625.5 9654.3 9737.4 9928.6 571.6 644.3 661.4 668.4 687.3 3745.5 4716.8 4730.9 4764.0 4802.9 138606.0 145274.0 149337.0 149941.0 153287.2 78057.4 121711.0 126675.7 126930.0 131309.0 89654.0 91821.0 95410.0 96889.0 108078.5 9372.3 9882.1 9929.0 9988.7 10027.4 54933.7 55595.4 56288.7 56817.4 57600.1 78914.0 79049.6 79622.6 83401.6 84154.3 11240.6 12263.6 12417.3 12695.5 13008.2 13800.4 14406.6 14647.6 14720.3 14726.3 11119.0 12934.9 13695.0 14124.0 14144.5 13118.8 13187.9 13611.5 13636.1 14108.6 13287.3 13999.2 14020.9 14167.4 14213.5 10743.5 11010.4 11258.9 11261.2 11488.8 10597.7 11408.6 11580.9 11720.2 11754.4 17:06:37 INFO - PROCESS | 1665 | -------- Summary: end -------- 17:06:37 INFO - PROCESS | 1665 | 17:06:37 INFO - TEST-INFO | 1665: exit 0 17:06:37 INFO - TEST-OK | dromaeo_css | took 1113549ms 17:06:37 INFO - TEST-START | kraken 17:06:37 INFO - operating with platform_type : mac_ 17:06:37 INFO - Initialising browser for kraken test... 17:06:38 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpOdMQ8G/profile http://localhost:49273/getInfo.html) 17:06:40 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 17:06:40 INFO - PROCESS | 1674 | colorDepth:24 17:06:40 INFO - PROCESS | 1674 | Browser inner width/height: 1024/663 17:06:40 INFO - PROCESS | 1674 | __metrics 17:06:40 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 17:06:41 INFO - TEST-INFO | 1674: exit 0 17:06:41 INFO - Browser initialized. 17:06:41 INFO - Running cycle 1/1 for kraken test... 17:06:41 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpOdMQ8G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:53 INFO - PROCESS | 1676 | RSS: Main: 238555136 17:06:53 INFO - PROCESS | 1676 | 17:06:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 17:06:57 INFO - PROCESS | 1676 | RSS: Main: 248430592 17:06:57 INFO - PROCESS | 1676 | 17:06:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 17:07:00 INFO - PROCESS | 1676 | RSS: Main: 255967232 17:07:00 INFO - PROCESS | 1676 | 17:07:03 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 17:07:04 INFO - PROCESS | 1676 | RSS: Main: 256892928 17:07:04 INFO - PROCESS | 1676 | 17:07:06 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 17:07:06 INFO - PROCESS | 1676 | RSS: Main: 256950272 17:07:06 INFO - PROCESS | 1676 | 17:07:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:07:09 INFO - PROCESS | 1676 | RSS: Main: 256724992 17:07:09 INFO - PROCESS | 1676 | 17:07:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 17:07:13 INFO - PROCESS | 1676 | RSS: Main: 257277952 17:07:13 INFO - PROCESS | 1676 | 17:07:16 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:16 INFO - PROCESS | 1676 | RSS: Main: 257294336 17:07:16 INFO - PROCESS | 1676 | 17:07:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 17:07:20 INFO - PROCESS | 1676 | RSS: Main: 257556480 17:07:20 INFO - PROCESS | 1676 | 17:07:21 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:22 INFO - PROCESS | 1676 | RSS: Main: 257200128 17:07:22 INFO - PROCESS | 1676 | 17:07:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:25 INFO - PROCESS | 1676 | RSS: Main: 257236992 17:07:25 INFO - PROCESS | 1676 | 17:07:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:07:28 INFO - PROCESS | 1676 | RSS: Main: 257269760 17:07:28 INFO - PROCESS | 1676 | 17:07:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:07:31 INFO - PROCESS | 1676 | RSS: Main: 257323008 17:07:31 INFO - PROCESS | 1676 | 17:07:34 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:35 INFO - PROCESS | 1676 | RSS: Main: 257650688 17:07:35 INFO - PROCESS | 1676 | 17:07:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 17:07:37 INFO - PROCESS | 1676 | RSS: Main: 259293184 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | __start_tp_report 17:07:37 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 17:07:37 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 17:07:37 INFO - PROCESS | 1676 | |i|pagename|runs| 17:07:37 INFO - PROCESS | 1676 | |0;ai-astar;107;118;117;120;118;118;116;119;119;119 17:07:37 INFO - PROCESS | 1676 | |1;audio-beat-detection;145;113;111;161;146;143;132;114;140;129 17:07:37 INFO - PROCESS | 1676 | |2;audio-dft;197;198;195;202;196;199;238;193;196;195 17:07:37 INFO - PROCESS | 1676 | |3;audio-fft;81;59;60;86;63;59;58;59;79;61 17:07:37 INFO - PROCESS | 1676 | |4;audio-oscillator;102;63;106;104;100;90;87;71;71;89 17:07:37 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;90;88;89;88;91;87;97;88;91;133 17:07:37 INFO - PROCESS | 1676 | |6;imaging-darkroom;96;97;97;97;124;155;97;155;118;96 17:07:37 INFO - PROCESS | 1676 | |7;imaging-desaturate;90;94;91;97;95;83;147;148;92;93 17:07:37 INFO - PROCESS | 1676 | |8;json-parse-financial;55;56;57;56;60;61;59;62;59;60 17:07:37 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;74;69;67;80;79;64;78;103;106;97 17:07:37 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;82;78;80;82;81;85;83;85;81;88 17:07:37 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;144;139;139;134;156;152;160;147;196;157 17:07:37 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;174;164;169;167;170;198;187;169;165;161 17:07:37 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;70;79;89;90;91;88;67;68;65;66 17:07:37 INFO - PROCESS | 1676 | __end_tp_report 17:07:37 INFO - PROCESS | 1676 | __start_cc_report 17:07:37 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,955 17:07:37 INFO - PROCESS | 1676 | __end_cc_report 17:07:37 INFO - PROCESS | 1676 | __startTimestamp1474675657135__endTimestamp 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | ------- Summary: start ------- 17:07:37 INFO - PROCESS | 1676 | Number of tests: 14 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:117.10 Median:118.50 stddev:3.73 (3.1%) stddev-sans-first:1.20 17:07:37 INFO - PROCESS | 1676 | Values: 107.0 118.0 117.0 120.0 118.0 118.0 116.0 119.0 119.0 119.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:141.50 stddev:16.69 (11.8%) stddev-sans-first:17.16 17:07:37 INFO - PROCESS | 1676 | Values: 145.0 113.0 111.0 161.0 146.0 143.0 132.0 114.0 140.0 129.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:200.90 Median:197.50 stddev:13.27 (6.7%) stddev-sans-first:14.00 17:07:37 INFO - PROCESS | 1676 | Values: 197.0 198.0 195.0 202.0 196.0 199.0 238.0 193.0 196.0 195.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:66.50 Median:62.00 stddev:10.92 (17.6%) stddev-sans-first:10.24 17:07:37 INFO - PROCESS | 1676 | Values: 81.0 59.0 60.0 86.0 63.0 59.0 58.0 59.0 79.0 61.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:71.00 stddev:15.38 (21.7%) stddev-sans-first:15.49 17:07:37 INFO - PROCESS | 1676 | Values: 102.0 63.0 106.0 104.0 100.0 90.0 87.0 71.0 71.0 89.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:89.50 stddev:13.93 (15.6%) stddev-sans-first:14.69 17:07:37 INFO - PROCESS | 1676 | Values: 90.0 88.0 89.0 88.0 91.0 87.0 97.0 88.0 91.0 133.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:113.20 Median:96.50 stddev:24.21 (25.1%) stddev-sans-first:24.87 17:07:37 INFO - PROCESS | 1676 | Values: 96.0 97.0 97.0 97.0 124.0 155.0 97.0 155.0 118.0 96.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:103.00 Median:92.50 stddev:23.75 (25.7%) stddev-sans-first:24.72 17:07:37 INFO - PROCESS | 1676 | Values: 90.0 94.0 91.0 97.0 95.0 83.0 147.0 148.0 92.0 93.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:59.50 stddev:2.37 (4.0%) stddev-sans-first:2.15 17:07:37 INFO - PROCESS | 1676 | Values: 55.0 56.0 57.0 56.0 60.0 61.0 59.0 62.0 59.0 60.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:81.70 Median:76.00 stddev:15.10 (19.9%) stddev-sans-first:15.76 17:07:37 INFO - PROCESS | 1676 | Values: 74.0 69.0 67.0 80.0 79.0 64.0 78.0 103.0 106.0 97.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:2.88 (3.5%) stddev-sans-first:3.05 17:07:37 INFO - PROCESS | 1676 | Values: 82.0 78.0 80.0 82.0 81.0 85.0 83.0 85.0 81.0 88.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:154.00 stddev:17.61 (11.4%) stddev-sans-first:18.41 17:07:37 INFO - PROCESS | 1676 | Values: 144.0 139.0 139.0 134.0 156.0 152.0 160.0 147.0 196.0 157.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:169.50 stddev:11.47 (6.8%) stddev-sans-first:12.15 17:07:37 INFO - PROCESS | 1676 | Values: 174.0 164.0 169.0 167.0 170.0 198.0 187.0 169.0 165.0 161.0 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.30 Median:83.50 stddev:11.20 (13.4%) stddev-sans-first:11.56 17:07:37 INFO - PROCESS | 1676 | Values: 70.0 79.0 89.0 90.0 91.0 88.0 67.0 68.0 65.0 66.0 17:07:37 INFO - PROCESS | 1676 | -------- Summary: end -------- 17:07:37 INFO - PROCESS | 1676 | 17:07:37 INFO - TEST-INFO | 1676: exit 0 17:07:37 INFO - TEST-OK | kraken | took 59971ms 17:07:37 INFO - SUITE-END | took 1173s 17:07:38 INFO - Completed test suite (00:19:33) 17:07:38 INFO - javascript benchmark 17:07:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7325.641518542144, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3427.126082848873, 3431.1936694876717, 3449.62054174041, 3461.878834240802, 3464.982675086625, 5746.741396637146, 5750.7412166452505, 5766.625169363999, 5793.884122317551, 5795.391483894194, 5756.597038207327, 5769.884602307962, 5775.0, 5782.10377391504, 5800.129980502927, 5268.288781014552, 5288.788448462057, 5316.096263635172, 5330.653507521999, 5331.546818520431, 5358.812441564546, 5361.785528578852, 5374.408815030343, 5385.973070134643, 5387.272718183034, 5261.9476104779005, 5262.657927234736, 5354.491323324278, 5359.651622644536, 5366.70483123428, 5214.530692237698, 5260.158374660055, 5361.517463428271, 5365.597580181502, 5419.024575576394, 4822.927656085161, 4979.954209615985, 5168.2764412982215, 5299.49654782795, 5316.973415132899, 5651.943480565183, 5766.192733017381, 5775.27809023872, 5847.590668653196, 5888.440598143169, 5062.620303477254, 6217.067439884054, 6224.751009959597, 6268.905966410507, 6327.96836015817, 6309.526785491061, 6309.810705678791, 6314.336994615545, 6319.0, 6335.334789847046, 5901.3508514063415, 5904.084866845603, 5925.170476133345, 5935.347111817697, 5951.464368206795, 6225.035119556476, 6268.247810262797, 6288.685565721696, 6290.874182516415, 6297.559170858088, 6200.193974783249, 6230.376962303824, 6255.874882502325, 6288.151099601587, 6292.716827742763, 6316.905246421307, 6320.525960552977, 6351.491880649629, 6354.269259035178, 6367.936320636827, 6141.854248382413, 6164.630122192593, 6186.876262474815, 6248.156498872685, 6302.0, 4769.928451073237, 5142.897142057138, 5718.971405142947, 6303.527235457359, 6307.306196318493, 4308.763018033976, 4972.477889821589, 4992.2761199626575, 4995.400551933792, 5013.974930125399, 4361.629261512807, 4367.716098453654, 4406.427164468662, 4474.149911516802, 4520.638348932078, 5150.407703114115, 5932.377100404482, 6006.879862402815, 6031.125486804389, 6066.99683656584, 5189.532942035235, 6198.163247961557, 6210.192674952227, 6245.344238854946, 6268.937310626927, 5779.711014449261, 5892.911606325909, 5921.082232254007, 5986.5210783137245, 5995.730192141364, 5451.236826844245, 5453.263809385761, 5455.945440545624, 5458.918116228259, 5461.563074953994, 6444.806655800334, 6470.676466176767, 6473.77341793035, 6473.805785826433, 6488.999999999905, 6154.846128846635, 6222.937770622236, 6251.062340648939, 6257.217847769029, 6262.74949002053, 6371.74513019474, 6445.838854028687, 6457.5479716419395, 6459.5478316519275, 6469.126667899774, 6256.468200202851, 6262.655553944577, 6304.810855674337, 6326.9683651581445, 6338.0809782580345, 6167.136600875791, 6214.347493513116, 6218.378162183745, 6298.212723409574, 6350.618962862243, 5028.874278143076, 5965.552583556164, 5991.569551202579, 6240.875182496234, 6251.0, 5066.9239961401345, 5366.221897824872, 6206.193194884817, 6217.222847144107, 6219.378062193744, 5844.181814545882, 5850.648961062179, 5991.0, 6093.695315234309, 6117.816465506042, 6090.665013424305, 6125.876495711566, 6154.292256390572, 6211.3167551570195, 6211.9689401552705, 4976.950230497649, 6086.2087928569, 6093.60391574564, 6117.938820611737, 6239.844003899939], "value": 5723.042016357281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.3563429575671, 441.93934557063045, 501.363268648816, 505.12613179199985, 517.0795983149994, 40230.597694023054, 42449.78775106128, 42543.93640158998, 42630.36054459186, 42640.36039459407, 36275.9117226483, 40922.18155636886, 44011.55988440123, 44456.55543444565, 44725.77637111818, 9718.222542196625, 9993.200543956502, 10015.74960625983, 10025.849612255823, 10026.298159128864, 9681.612735490571, 9833.557489912972, 9847.803043939117, 9873.062059104373, 9879.110880020797, 9949.95025024874, 9964.551595178234, 9987.851397089355, 9989.100980911717, 9994.650187243447, 9866.753331166743, 9901.554430050664, 9932.90067099327, 9952.751181220456, 9960.85058724116, 9785.412875227508, 9897.307188496809, 9928.90071099287, 9929.751756206153, 9933.950330248375, 42122.578774212176, 42542.0, 42552.14895702068, 42609.0, 42738.0, 3208.631007434152, 3374.7637665363436, 3392.8973083747633, 3589.425691889285, 3885.825137868803, 31192.376152476823, 31682.0, 31869.521957170662, 31901.52147717786, 32297.031089067365, 3173.4922412414135, 3204.1829333520036, 3262.429074911881, 3277.1643230975947, 3338.983305083483, 515815.0, 519246.9999999962, 520359.0, 520363.39818301046, 522930.0, 59687.0, 64509.99999999906, 64572.354276457576, 64736.67631661812, 64769.67615161894, 35038.47442288368, 36214.45678314827, 36406.0, 67593.32406675871, 67871.66064169747, 17181.828181718272, 17343.3062677494, 17379.73930391045, 17433.738493922603, 17484.91257543704, 13166.14420062712, 13243.8742706871, 13254.40355184019, 13292.468301268034, 13297.3351332433, 19732.901335493232, 19786.802131978784, 19809.603807923762, 19959.00204989774, 20053.59892802165, 7869.449138560246, 7941.45141697375, 7966.163552826985, 7975.920240797634, 7985.361171106298, 828.6726742936506, 909.4580647091395, 953.9904600953902, 1009.4599389326675, 1091.901728844408, 27285.72714272832, 30583.0, 30761.538576921364, 31074.0, 31877.0, 899.9775005624912, 1058.074185088048, 1071.983920241197, 1089.1178145702006, 1114.7213196700825, 15597.922010389875, 16138.75791863123, 16211.918940405223, 16350.75473867893, 16408.67182656364, 588423.1157688454, 628809.0, 650745.0, 669854.0, 670044.0, 50935.0, 58217.0, 59599.0, 60164.69917650384, 60285.39714602798, 1369.2605992763995, 1375.3604573873197, 1402.025592213402, 1403.6561042544643, 1411.84469708332, 26551.60172597374, 30172.24569385783, 30307.545386818776, 30808.845955770976, 31054.534181986837, 52773.7361313191, 53240.73379633077, 53671.0, 53747.19379209237, 53959.73020134874, 614527.0, 616578.0, 619124.0, 620127.0, 620886.0, 27552.44895102127, 27584.724152758215, 27890.721092789623, 27926.3018424541, 27964.44071118607, 48430.757846210545, 48711.512884870695, 49519.50480495293, 49676.50323496863, 50126.0, 40113.99715007148, 40743.38884916788, 41064.58935410608, 41652.79173604112, 42131.0, 40629.57796477109, 40998.79500602478, 41207.7939610312, 41904.79047604743, 42075.36886946637, 34275.4858677125, 35997.46003809998, 39541.01147471336, 39827.60172398239, 41162.79418602888, 34032.0, 36022.639773602976, 36086.917392478266, 36111.916642500764, 36219.456708149926, 26381.604275935493, 26597.867010664824, 26672.46655066849, 26798.987783076347, 26904.596431053942], "value": 20459.04872100181, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.39419352262297, 374.63660249557927, 379.1942122988649, 382.4225419616378, 391.25465987294217, 18754.343597974075, 19993.900030499863, 20153.496162595926, 20190.293339733093, 20336.88147151906, 18762.155702993365, 18841.528961775963, 19220.135093920773, 20100.69848952267, 20312.796872031275, 5845.09401042839, 5869.618474799146, 6009.609375390607, 6091.695415229243, 6153.876922461548, 3872.2642697887454, 6164.815055548341, 6217.1917650705345, 6221.377862213788, 6236.968815155918, 4065.024394145413, 5860.765569377219, 6146.907796383058, 6165.106059621352, 6211.068339749028, 5964.612300200473, 6119.296280927706, 6165.075238714184, 6183.412575805291, 6222.408871157233, 5950.256217972754, 5951.880962380771, 5956.821295361146, 5957.136215248808, 5957.970210148965, 14039.0, 23782.0, 23922.0, 24192.395190120213, 24637.753622463726, 2005.568802707425, 2184.344696591016, 2220.700205472273, 2598.1555994301925, 2600.557905156128, 9871.309008369417, 10289.279750417474, 11111.00000999914, 14938.62653433662, 15024.0, 1777.6711308407987, 1808.7919889212778, 1874.109797846026, 1924.0956750327323, 1928.594995051041, 119044.40477797555, 119845.40077299645, 120021.39989300085, 121003.78996210013, 126205.0, 7663.540187588763, 8478.152184781473, 9565.90434095664, 9757.707268781947, 10041.4863274627, 12314.445849936774, 12364.876351236373, 12431.31627760482, 12436.689082773004, 12451.94158496538, 7985.800354991172, 8066.919330806734, 8105.0, 8169.918300817035, 8262.17378262169, 8512.659493620185, 8589.226969572768, 8620.698275560326, 8687.391882568287, 8755.299576034029, 3221.4845624699938, 3607.603163651996, 3835.6931445484292, 3895.8052097395016, 3952.031752220667, 1491.336355321893, 1799.7120460726483, 1910.4841692742882, 1939.8448124150034, 1979.1687491253708, 858.2318824651902, 869.2524428991063, 930.4928813796497, 945.9054094590623, 958.2477754962321, 16760.916195419188, 17992.740508164305, 19381.689056641368, 20426.0, 21219.78780212209, 875.7022612311717, 898.2679116520146, 933.6452148183647, 943.8206740719241, 965.9517024148764, 9567.282453815853, 10093.646722364681, 10701.625443109453, 10859.83710244347, 10867.239293249397, 568194.1590292022, 586257.0, 596413.0, 607459.0, 611357.0, 127550.0, 128530.35734821267, 132707.33646331707, 137458.0, 139583.0, 358.63061047121505, 392.61915941536665, 452.79397873967264, 455.47165288265455, 457.3231617206553, 8746.868796967923, 11049.447527623426, 11061.557537698724, 11192.21654484211, 11304.660860174208, 53659.463405365444, 53966.19050714164, 56129.158062628274, 57170.0, 58045.0, 59298.81402371842, 67377.0, 81806.0, 85232.0, 86113.13886861302, 8004.839903201787, 8093.959530202547, 8143.633536490754, 8402.537860417735, 8541.658333666584, 9069.727908162766, 12011.81982270284, 12356.814647780111, 12790.552330668383, 12987.675308117372, 10777.167881460327, 11069.667909962714, 11199.432079509039, 11305.886941130813, 11331.150163737588, 10359.32664376813, 10788.190885683449, 10804.0, 11184.161187910777, 11246.268992515788, 10909.799922008731, 11044.558217671203, 11073.667789966314, 11102.777944441228, 11667.708307292385, 7209.918512223208, 7386.596546656118, 8110.351171906115, 8296.585170741319, 8338.87491687613, 8170.01959764832, 8452.661893524437, 8902.821943560963, 11079.72300692489, 11334.433278336215], "value": 8974.120109468302, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.634734100781, 1504.052446958416, 1612.298650087212, 1759.780027496563, 1814.6461440019202, 8136.471129376587, 8394.748157555268, 8595.054544000155, 9176.770580735476, 9187.77030574236, 8576.228139467446, 8938.329625278098, 8969.506677132771, 9003.549822508881, 9003.684871029514, 1959.980400195994, 2363.1492662641435, 2368.538135063663, 2374.6556749271344, 2384.2489615771065, 2343.379004563792, 2361.197192954395, 2385.821063420242, 2397.5324811661735, 2399.3881560202126, 2371.893264803088, 2376.738558758535, 2384.7496012918655, 2386.5823480890863, 2401.0275838285525, 2350.82368822339, 2365.9763402366016, 2368.6683864259016, 2384.237044145865, 2385.9642105368434, 2325.0, 2336.427575244059, 2339.6841426407386, 2343.988280058606, 2346.4485845826216, 8922.821543569093, 8957.955210223907, 9015.14356136166, 9032.277417806625, 9039.276857851357, 5195.142801437758, 5305.0450918834595, 5364.007658583175, 5374.032674118657, 5384.946150538483, 3598.3702852000797, 3630.419132938717, 3648.1426864686778, 3653.6346365363515, 3667.468217108531, 1076.8976947190004, 1084.2897901874285, 1088.3089238333637, 1098.2696506822954, 1106.0985296982933, 11738.295702257892, 11852.170348075639, 11886.702832429171, 11904.940475297655, 11920.46357913896, 4561.475430325555, 4657.371254880615, 4778.331033655291, 4847.2729090636685, 4860.149473842134, 9973.551190196458, 10066.094051535398, 10086.44524551142, 10100.595976161017, 10119.494025298705, 5248.895022099537, 5260.28986086881, 5278.604104692164, 5281.867953301121, 5291.126964050965, 4302.741835489881, 4478.305862591304, 4745.406824146981, 4839.637027222972, 4913.631477639191, 3900.278448487039, 3940.054386947112, 3973.0, 4020.577839326887, 4046.2716710991717, 1279.0598909801288, 1290.7031382782013, 1295.2940647347218, 1295.591888555102, 1298.4806077569049, 921.8386782313203, 923.0953665407937, 923.7921367930651, 924.4268553496875, 951.7144856543148, 4766.285057241442, 5786.855328616818, 5846.7076646167525, 6036.305824830113, 6079.665618390943, 430.29002146458595, 439.674640765831, 442.8715672454952, 776.751439539342, 1042.2912419554775, 3941.546722126992, 3966.960330396717, 3970.980145099256, 4040.969552764085, 4090.836366545305, 10659.040686338112, 11107.444627768578, 11138.832917506244, 11154.10767138627, 11196.440177991068, 9392.8591071134, 10712.78574428507, 10881.455927203766, 11145.164112691418, 11148.219624626197, 8332.375071869634, 8389.07720150783, 8428.704995325133, 8519.829603407898, 8528.786780330542, 5789.0, 5958.463738263577, 5971.820845374646, 5987.790427335022, 5991.281046274475, 10041.648542300984, 10104.69685909424, 10242.948785256027, 10247.795044099226, 10256.846147307648, 10212.65619341945, 10253.948730256301, 10255.94872025635, 10468.895311046792, 10484.685459436228, 5694.117411801178, 5708.771649133988, 6578.210614726264, 6790.558613690095, 6950.914725582204, 8300.501969881827, 8434.957825210835, 8442.451240669337, 8567.100454452442, 8580.884485016908, 6614.768483103068, 7623.085229772463, 7628.199039100815, 7655.272749088827, 7721.305082542598, 7380.752389425429, 7488.5506869588, 7531.472796904164, 7633.389328853567, 7649.770506884803, 7072.434205263669, 7077.504574679723, 7151.141862976476, 7163.785086447207, 7164.820879478055, 4999.325091112653, 5029.974850125726, 5035.169197082587, 5119.28330033803, 5187.948120518747, 4720.645951553716, 5021.899562008666, 5028.818227716411, 5056.191009438472, 5206.895862082662], "value": 4563.873696975543, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.6200104845353, 290.6570247108412, 313.5281401490756, 314.45913029589116, 318.2568702080642, 5001.974200448815, 5505.614606977513, 5527.226188333631, 5650.8587285317835, 5663.4336566343345, 5125.359884836854, 5349.806579302477, 5490.72135063949, 5503.587230957674, 5510.8071217507395, 3882.864099756509, 4236.978815105927, 4276.486821581415, 4289.699721019514, 4294.849680261176, 3953.3674612062077, 4145.585441455845, 4269.893252668692, 4309.676774241929, 4324.913501729963, 4037.878863634081, 4222.324428091506, 4243.111815242219, 4244.872653820375, 4250.766207858566, 4227.957720422803, 4253.319468884979, 4265.7014009019385, 4268.9573104268875, 4278.272693642057, 3402.030421329909, 3713.2573485303046, 3716.6655001049767, 3717.8141092945243, 3717.940386989722, 4092.9795351023354, 4748.667593268473, 4840.918405085812, 5364.356277246756, 5491.258680078178, 4352.499462561815, 4717.410323709536, 4780.418573970052, 4788.497207793202, 4796.3524924135145, 5230.8169214077325, 5551.417101204396, 5754.813170995037, 5831.883362332772, 5847.649141051551, 3607.6211997740384, 3832.1760821423527, 3887.455756194135, 3913.9217215655813, 3929.8821035368983, 5271.947280527184, 6086.026235802295, 6136.846578835521, 6177.505799535981, 6182.845428864314, 3209.3581283743347, 3960.5841386653988, 3977.2244412339314, 3980.7810570418906, 4001.679865610744, 3781.3949768036982, 3869.0550213648685, 3995.901127190046, 4002.6197511236387, 4017.268257584812, 3859.7684138951754, 4456.6211871991245, 4611.976940115278, 4723.622110231173, 4754.0, 4522.5025247222775, 5530.225768392428, 5649.689267090267, 5973.880522389528, 5979.312379076462, 1089.5968491658136, 1116.1238427834273, 1208.6313674329415, 1232.3530146673068, 1342.7515909556764, 810.6028046257292, 888.8666949639262, 896.9686060987834, 901.8996823874862, 921.5439605423414, 4725.5510726480925, 5251.894962100737, 5503.367112782002, 5503.669779813224, 5558.749856256478, 5990.6705131218205, 5992.340842507408, 5993.520518358521, 5995.490383317379, 6000.549958753111, 4463.018136010072, 5283.0, 5453.318335208099, 5496.615236933456, 5568.522007706531, 2348.6278858353185, 2566.7176610572824, 2573.5716677243936, 2685.44948285601, 2704.8647567621542, 4442.334124703237, 4540.253146846177, 4798.337961205811, 5161.4322424533275, 5265.815696450606, 4680.7191568506, 5143.768530416065, 5153.3558305211845, 5168.819091331786, 5715.571332150105, 6308.8107356778455, 6405.839854003687, 6437.935620643827, 6451.677416129175, 6458.644774537445, 5563.609097725569, 5781.219535362672, 5811.4188581143235, 6109.358517355614, 6141.508679305734, 5241.292425522505, 5951.0, 6028.939710603014, 6034.24571928509, 6142.723577438936, 6248.4064013918605, 6286.522667173302, 6399.632136109669, 6414.422701956846, 6451.741930322734, 3283.801412484378, 3612.7471077024356, 3735.43111893011, 3983.2830090583975, 3985.561588225351, 4236.216299984513, 5723.456271654186, 6088.630058236861, 6105.931461994044, 6114.785982490592, 5546.3638226722405, 5698.686572238566, 5809.912851307149, 5966.404613992927, 6003.549733769897, 5112.335396398445, 5867.237259156283, 5909.0, 5912.46787789101, 5914.733836977261, 4427.756473393994, 5120.572193474928, 5417.160340147283, 5541.889162216814, 5799.8550036249435, 4907.77914993819, 5323.547498462519, 5478.890422191614, 5986.6707331097205, 6006.429389208019, 5056.86220600362, 5622.606417550732, 5827.475527202572, 5843.211166492639, 5872.29532456108], "value": 4169.31511165931, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.8202831320481, 758.2872100225787, 790.7904405332588, 796.7251298302084, 815.4903185509057, 14678.559643210707, 15200.6959860803, 15233.0, 15302.540923772305, 15309.693806123885, 13728.656783580416, 13770.586882393543, 13830.17018978862, 13851.722965540683, 13864.930675346634, 808.2523665609317, 824.6124321568853, 860.2945584620613, 866.4974314897345, 867.6876324523166, 851.9701810436636, 856.0839901305606, 856.9314454843598, 858.3133493205441, 859.8624220124781, 893.7765558610347, 896.5338024227398, 896.9864053619401, 897.0401670212875, 898.24996128233, 884.7832281091141, 885.4156256870434, 885.7785553611598, 889.7108439757072, 890.3100097424483, 661.0943008078963, 662.1788981662752, 662.3707477896018, 663.731188868509, 665.5174998126369, 15236.390544378211, 15276.541703748906, 15293.847061529354, 15325.157116358596, 15359.232038398148, 13758.31208439574, 13840.653983650389, 14056.156630602196, 14092.788608170784, 14161.291935403291, 11928.866757658096, 11992.460339284753, 12018.879811201863, 12066.396680165957, 12259.570915017932, 3684.5578530576236, 3697.704183665327, 3742.8689995850013, 3836.0, 3852.6339997700175, 106242.46878765634, 113000.4349978253, 114075.0, 115020.0, 117603.0, 10626.574937002588, 10733.677989660322, 10890.29213101146, 10904.127669786556, 10905.509252083517, 17683.646327073388, 21707.45731356697, 21723.913804309723, 21952.012159452544, 22173.33479995603, 7910.2089791020435, 7910.960445197852, 7948.125706172316, 7973.880391794128, 8066.193380661887, 4405.31717583775, 4415.867523974286, 4592.448906131285, 4628.9537104628525, 4680.4149481314835, 3601.297746939374, 3687.8524859005875, 3715.238376132886, 3718.5537735471917, 3746.587875333711, 608.9604175728564, 620.5687047501942, 638.7093872288098, 648.6432462145801, 654.1986067067899, 466.6989791584409, 563.2621266141286, 593.2969431224013, 642.5239454550857, 675.6587923098901, 9293.159367185814, 9625.497370683534, 9654.324197306121, 9737.415755054719, 9928.553215105338, 571.5770329955802, 644.3234603666132, 661.4146480364816, 668.38174688414, 687.2715121469508, 3745.4569087482164, 4716.764161791965, 4730.858074257778, 4764.0, 4802.927956080662, 138606.0, 145274.0, 149337.0, 149941.0, 153287.23356383145, 78057.43885122266, 121711.0, 126675.73324266824, 126930.0, 131309.0, 89654.0, 91821.0, 95410.0, 96889.0, 108078.45960770146, 9372.297077719062, 9882.11061004513, 9928.950355248178, 9988.700338989842, 10027.44849033281, 54933.72533137309, 55595.44404555903, 56288.71855640696, 56817.43182568121, 57600.135997960904, 78914.0, 79049.60475197817, 79622.60188699019, 83401.58299208464, 84154.31691366261, 11240.55037798479, 12263.632091037283, 12417.31704756247, 12695.492180312684, 13008.21950682962, 13800.382545613129, 14406.639834004234, 14647.560573182822, 14720.263986800832, 14726.337314821074, 11119.0, 12934.870651293366, 13695.0, 14124.0, 14144.504942326968, 13118.803217951547, 13187.868121319048, 13611.523596674466, 13636.113652612548, 14108.647283817987, 13287.269200193696, 13999.23004234736, 14020.94842886808, 14167.36246868914, 14213.50252741149, 10743.516541755484, 11010.39442830652, 11258.943705281421, 11261.21171517986, 11488.827667584826, 10597.735056623646, 11408.62508763825, 11580.884191158317, 11720.179587429138, 11754.412279385826], "value": 7729.049461881215, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 117.0, 120.0, 118.0, 118.0, 116.0, 119.0, 119.0, 119.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 111.0, 161.0, 146.0, 143.0, 132.0, 114.0, 140.0, 129.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 198.0, 195.0, 202.0, 196.0, 199.0, 238.0, 193.0, 196.0, 195.0], "value": 200.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 86.0, 63.0, 59.0, 58.0, 59.0, 79.0, 61.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 63.0, 106.0, 104.0, 100.0, 90.0, 87.0, 71.0, 71.0, 89.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 89.0, 88.0, 91.0, 87.0, 97.0, 88.0, 91.0, 133.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 124.0, 155.0, 97.0, 155.0, 118.0, 96.0], "value": 113.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 91.0, 97.0, 95.0, 83.0, 147.0, 148.0, 92.0, 93.0], "value": 103.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 56.0, 60.0, 61.0, 59.0, 62.0, 59.0, 60.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 67.0, 80.0, 79.0, 64.0, 78.0, 103.0, 106.0, 97.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 80.0, 82.0, 81.0, 85.0, 83.0, 85.0, 81.0, 88.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 139.0, 134.0, 156.0, 152.0, 160.0, 147.0, 196.0, 157.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 164.0, 169.0, 167.0, 170.0, 198.0, 187.0, 169.0, 165.0, 161.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 89.0, 90.0, 91.0, 88.0, 67.0, 68.0, 65.0, 66.0], "value": 77.3, "unit": "score"}]}]} 17:07:38 INFO - Return code: 0 17:07:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:07:38 ERROR - # TBPL SUCCESS # 17:07:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:07:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:07:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:07:38 INFO - 2016-09-23 17:07:38.448 screenresolution[1681:11514] starting screenresolution argv=screenresolution get 17:07:38 INFO - 2016-09-23 17:07:38.450 screenresolution[1681:11514] Display 0: 1600x1200x32@60 17:07:38 INFO - 2016-09-23 17:07:38.456 screenresolution[1682:11517] starting screenresolution argv=screenresolution list 17:07:38 INFO - Available Modes on Display 0 17:07:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:07:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:07:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:07:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:07:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:07:38 INFO - Intel Iris: 17:07:38 INFO - Chipset Model: Intel Iris 17:07:38 INFO - Type: GPU 17:07:38 INFO - Bus: Built-In 17:07:38 INFO - VRAM (Dynamic, Max): 1536 MB 17:07:38 INFO - Vendor: Intel (0x8086) 17:07:38 INFO - Device ID: 0x0a2e 17:07:38 INFO - Revision ID: 0x0009 17:07:38 INFO - Displays: 17:07:38 INFO - Display: 17:07:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:07:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:07:38 INFO - Display Serial Number: 1600x1200 60 17:07:38 INFO - Main Display: Yes 17:07:38 INFO - Mirror: Off 17:07:38 INFO - Online: Yes 17:07:38 INFO - Rotation: Supported 17:07:38 INFO - Return code: 0 17:07:38 INFO - Running post-action listener: _resource_record_post_action 17:07:38 INFO - [mozharness: 2016-09-24 00:07:38.691540Z] Finished run-tests step (success) 17:07:38 INFO - Running post-run listener: _resource_record_post_run 17:07:38 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 33115136; Write bytes: 667318272; Read time: 314; Write time: 1936 17:07:38 INFO - TinderboxPrint: CPU usage
54.1% 17:07:38 INFO - TinderboxPrint: I/O read bytes / time
33,115,136 / 314 17:07:38 INFO - TinderboxPrint: I/O write bytes / time
667,318,272 / 1,936 17:07:38 INFO - TinderboxPrint: CPU idle
2,218.2 (45.9%) 17:07:38 INFO - TinderboxPrint: CPU system
972.3 (20.1%) 17:07:38 INFO - TinderboxPrint: CPU user
1,639.2 (33.9%) 17:07:38 INFO - TinderboxPrint: Swap in / out
392,265,728 / 0 17:07:38 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355906048; Write bytes: 356423680; Read time: 27430; Write time: 677 17:07:38 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 32168960; Write bytes: 300711936; Read time: 299; Write time: 1224 17:07:39 INFO - Running post-run listener: _upload_blobber_files 17:07:39 INFO - Blob upload gear active. 17:07:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:07:39 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 17:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:07:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:07:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:07:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:07:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:40 INFO - (blobuploader) - INFO - Done attempting. 17:07:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:07:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:07:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:41 INFO - (blobuploader) - INFO - Done attempting. 17:07:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:07:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:07:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:43 INFO - (blobuploader) - INFO - Done attempting. 17:07:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:07:43 INFO - Return code: 0 17:07:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:07:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:07:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c603791c87fac348a63fba438e339b83d2a4c2d3575881ab42fcc3baa108a257c37fd1e9312b6c3bea1fa12e6fabe38b448ab3312a5283ff6ef9f8263d15496", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bdb97e48afe11b497a5a5d005491fc62ad12d0ee2f36677ff6ffe69ab2a438dce9e2ed4ae7e20c4f1d1e4e872d2c7d16ab1d271567d4f7d1053e7163d33c68b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1d0d4c64f83aaf4ad5f6a1625fa096caa377e4dbf4f98f62eea74d76c82bb67cac71ee11f0ce3bde70d6a0a62a9d78e81b290391d1151bd87c123968ca40f72"} 17:07:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:07:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:07:43 INFO - Contents: 17:07:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c603791c87fac348a63fba438e339b83d2a4c2d3575881ab42fcc3baa108a257c37fd1e9312b6c3bea1fa12e6fabe38b448ab3312a5283ff6ef9f8263d15496", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bdb97e48afe11b497a5a5d005491fc62ad12d0ee2f36677ff6ffe69ab2a438dce9e2ed4ae7e20c4f1d1e4e872d2c7d16ab1d271567d4f7d1053e7163d33c68b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1d0d4c64f83aaf4ad5f6a1625fa096caa377e4dbf4f98f62eea74d76c82bb67cac71ee11f0ce3bde70d6a0a62a9d78e81b290391d1151bd87c123968ca40f72"} 17:07:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:07:43 INFO - Copying logs to upload dir... 17:07:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:07:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.575847 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-09-23 17:07:44.342707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-09-23 17:07:44.346746) ========= 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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c603791c87fac348a63fba438e339b83d2a4c2d3575881ab42fcc3baa108a257c37fd1e9312b6c3bea1fa12e6fabe38b448ab3312a5283ff6ef9f8263d15496", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bdb97e48afe11b497a5a5d005491fc62ad12d0ee2f36677ff6ffe69ab2a438dce9e2ed4ae7e20c4f1d1e4e872d2c7d16ab1d271567d4f7d1053e7163d33c68b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1d0d4c64f83aaf4ad5f6a1625fa096caa377e4dbf4f98f62eea74d76c82bb67cac71ee11f0ce3bde70d6a0a62a9d78e81b290391d1151bd87c123968ca40f72"} build_url:https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010951 build_url: 'https://queue.taskcluster.net/v1/task/N8XzEtRBS2-L5Cx7slhv_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c603791c87fac348a63fba438e339b83d2a4c2d3575881ab42fcc3baa108a257c37fd1e9312b6c3bea1fa12e6fabe38b448ab3312a5283ff6ef9f8263d15496", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bdb97e48afe11b497a5a5d005491fc62ad12d0ee2f36677ff6ffe69ab2a438dce9e2ed4ae7e20c4f1d1e4e872d2c7d16ab1d271567d4f7d1053e7163d33c68b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1d0d4c64f83aaf4ad5f6a1625fa096caa377e4dbf4f98f62eea74d76c82bb67cac71ee11f0ce3bde70d6a0a62a9d78e81b290391d1151bd87c123968ca40f72"}' ========= master_lag: 2.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-09-23 17:07:46.505395) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:07:46.505738) ========= 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.FcYbVWSPaA/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.MkXZZcSWw1/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.005114 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:07:46.538061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 17:07:46.538395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 17:07:46.538716) ========= ========= Total master_lag: 2.70 =========