builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0281 starttime: 1478690766.53 results: success (0) buildid: 20161108173621 builduid: 083c302c289d4fffa60edb78cf695dbd revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.526911) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.527260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.527542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.998142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.998419) ========= 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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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-11-09 03:26:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-11-09 03:26:07 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.614141 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:07.638235) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:07.638533) ========= 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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.023023 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:07.694291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 03:26:07.694609) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae3b6bfb810476141647ad681b796ed118062412 --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 ae3b6bfb810476141647ad681b796ed118062412 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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-11-09 03:26:07,782 truncating revision to first 12 chars 2016-11-09 03:26:07,783 Setting DEBUG logging. 2016-11-09 03:26:07,783 attempt 1/10 2016-11-09 03:26:07,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ae3b6bfb8104?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-09 03:26:08,524 unpacking tar archive at: mozilla-aurora-ae3b6bfb8104/testing/mozharness/ program finished with exit code 0 elapsedTime=1.017553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 03:26:08.736152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:08.738472) ========= script_repo_revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:08.738855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:08.739131) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:08.786173) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-09 03:26:08.786447) ========= /tools/buildbot/bin/python -u 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', '-u', '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:09 INFO - MultiFileLogger online at 20161109 03:26:09 in /builds/slave/test 03:26:09 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 03:26:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:09 INFO - {'append_to_log': False, 03:26:09 INFO - 'base_work_dir': '/builds/slave/test', 03:26:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:09 INFO - 'branch': 'Mozilla-Aurora', 03:26:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:09 INFO - 'config_files': ('talos/mac_config.py',), 03:26:09 INFO - 'default_actions': ('clobber', 03:26:09 INFO - 'read-buildbot-config', 03:26:09 INFO - 'download-and-extract', 03:26:09 INFO - 'populate-webroot', 03:26:09 INFO - 'create-virtualenv', 03:26:09 INFO - 'install', 03:26:09 INFO - 'run-tests'), 03:26:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:09 INFO - 'download_minidump_stackwalk': True, 03:26:09 INFO - 'download_symbols': 'ondemand', 03:26:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:09 INFO - 'installer_path': 'installer.exe', 03:26:09 INFO - 'log_level': 'info', 03:26:09 INFO - 'log_name': 'talos', 03:26:09 INFO - 'log_to_console': True, 03:26:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:26:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:26:09 INFO - 'opt_config_files': (), 03:26:09 INFO - 'pip_index': False, 03:26:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:26:09 INFO - 'cmd': ('bash', 03:26:09 INFO - '-c', 03:26:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:26:09 INFO - 'enabled': True, 03:26:09 INFO - 'halt_on_failure': False, 03:26:09 INFO - 'name': 'check_screen_resolution'},), 03:26:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:26:09 INFO - 'cmd': ('bash', 03:26:09 INFO - '-c', 03:26:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:26:09 INFO - 'enabled': True, 03:26:09 INFO - 'halt_on_failure': False, 03:26:09 INFO - 'name': 'check_screen_resolution'},), 03:26:09 INFO - 'run_cmd_checks_enabled': True, 03:26:09 INFO - 'sps_profile': False, 03:26:09 INFO - 'sps_profile_interval': 0, 03:26:09 INFO - 'suite': 'dromaeojs-e10s', 03:26:09 INFO - 'system_bits': '32', 03:26:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:09 INFO - 'title': 't-yosemite-r7-0281', 03:26:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:09 INFO - 'use_talos_json': True, 03:26:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:09 INFO - 'work_dir': 'build'} 03:26:09 INFO - [mozharness: 2016-11-09 11:26:09.019037Z] Running clobber step. 03:26:09 INFO - Running pre-action listener: _resource_record_pre_action 03:26:09 INFO - Running main action method: clobber 03:26:09 INFO - rmtree: /builds/slave/test/build 03:26:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:11 INFO - Running post-action listener: _resource_record_post_action 03:26:11 INFO - [mozharness: 2016-11-09 11:26:11.369918Z] Finished clobber step (success) 03:26:11 INFO - [mozharness: 2016-11-09 11:26:11.370186Z] Running read-buildbot-config step. 03:26:11 INFO - Running pre-action listener: _resource_record_pre_action 03:26:11 INFO - Running main action method: read_buildbot_config 03:26:11 INFO - Using buildbot properties: 03:26:11 INFO - { 03:26:11 INFO - "project": "", 03:26:11 INFO - "product": "firefox", 03:26:11 INFO - "script_repo_revision": "production", 03:26:11 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:26:11 INFO - "repository": "", 03:26:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:26:11 INFO - "buildid": "20161108173621", 03:26:11 INFO - "pgo_build": "False", 03:26:11 INFO - "basedir": "/builds/slave/test", 03:26:11 INFO - "buildnumber": 33, 03:26:11 INFO - "slavename": "t-yosemite-r7-0281", 03:26:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:26:11 INFO - "platform": "yosemite_r7", 03:26:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:26:11 INFO - "branch": "mozilla-aurora", 03:26:11 INFO - "repo_path": "releases/mozilla-aurora", 03:26:11 INFO - "revision": "ae3b6bfb810476141647ad681b796ed118062412", 03:26:11 INFO - "stage_platform": "macosx64", 03:26:11 INFO - "builduid": "083c302c289d4fffa60edb78cf695dbd", 03:26:11 INFO - "slavebuilddir": "test" 03:26:11 INFO - } 03:26:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:26:11 INFO - Running post-action listener: _resource_record_post_action 03:26:11 INFO - [mozharness: 2016-11-09 11:26:11.375968Z] Finished read-buildbot-config step (success) 03:26:11 INFO - [mozharness: 2016-11-09 11:26:11.376201Z] Running download-and-extract step. 03:26:11 INFO - Running pre-action listener: _resource_record_pre_action 03:26:11 INFO - Running main action method: download_and_extract 03:26:11 INFO - mkdir: /builds/slave/test/build/tests 03:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:11 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:26:11 INFO - Downloading https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 03:26:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 03:26:12 INFO - Downloaded 1199 bytes. 03:26:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:26:12 INFO - Using the following test package requirements: 03:26:12 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:26:12 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:12 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:26:12 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:12 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:26:12 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:12 INFO - u'jsshell-mac.zip'], 03:26:12 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:12 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:26:12 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:26:12 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:12 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:26:12 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:12 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:26:12 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:12 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:26:12 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:12 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:26:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:26:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:26:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:26:12 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:26:12 INFO - Expected file size: 16423395 03:26:19 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 03:26:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:26:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:26:19 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:26:20 INFO - Expected file size: 16423395 03:26:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:26:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:26:26 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:26:27 INFO - Expected file size: 14414089 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:28 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:26:28 INFO - Downloading https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 03:26:32 INFO - Downloaded 115464056 bytes. 03:26:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:26:32 INFO - mkdir: /builds/slave/test/properties 03:26:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:32 INFO - Contents: 03:26:32 INFO - build_url:https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:26:33 INFO - Running post-action listener: _resource_record_post_action 03:26:33 INFO - Running post-action listener: set_extra_try_arguments 03:26:33 INFO - [mozharness: 2016-11-09 11:26:33.074283Z] Finished download-and-extract step (success) 03:26:33 INFO - [mozharness: 2016-11-09 11:26:33.074432Z] Running populate-webroot step. 03:26:33 INFO - Running pre-action listener: _resource_record_pre_action 03:26:33 INFO - Running main action method: populate_webroot 03:26:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:33 INFO - '--tppagecycles', 03:26:33 INFO - '7'], 03:26:33 INFO - 'tests': ['tsvgm']}}, 03:26:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:33 INFO - 'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:33 INFO - 'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['damp', 'tps']}, 03:26:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:33 INFO - 'tests': ['damp', 'tps']}, 03:26:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['dromaeo_dom']}, 03:26:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['basic_compositor_video']}, 03:26:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:26:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['a11yr', 03:26:33 INFO - 'ts_paint', 03:26:33 INFO - 'tpaint', 03:26:33 INFO - 'sessionrestore', 03:26:33 INFO - 'sessionrestore_no_auto_restore', 03:26:33 INFO - 'tabpaint']}, 03:26:33 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:33 INFO - 'ts_paint', 03:26:33 INFO - 'tpaint', 03:26:33 INFO - 'sessionrestore', 03:26:33 INFO - 'sessionrestore_no_auto_restore', 03:26:33 INFO - 'tabpaint']}, 03:26:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:33 INFO - 'ts_paint', 03:26:33 INFO - 'tpaint', 03:26:33 INFO - 'sessionrestore', 03:26:33 INFO - 'sessionrestore_no_auto_restore', 03:26:33 INFO - 'tabpaint']}, 03:26:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:33 INFO - 'ts_paint', 03:26:33 INFO - 'tpaint', 03:26:33 INFO - 'sessionrestore', 03:26:33 INFO - 'sessionrestore_no_auto_restore', 03:26:33 INFO - 'tabpaint']}, 03:26:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['a11yr', 03:26:33 INFO - 'ts_paint', 03:26:33 INFO - 'tpaint', 03:26:33 INFO - 'sessionrestore', 03:26:33 INFO - 'sessionrestore_no_auto_restore', 03:26:33 INFO - 'tabpaint']}, 03:26:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['a11yr', 03:26:33 INFO - 'ts_paint', 03:26:33 INFO - 'tpaint', 03:26:33 INFO - 'sessionrestore', 03:26:33 INFO - 'sessionrestore_no_auto_restore', 03:26:33 INFO - 'tabpaint']}, 03:26:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['tsvgx', 03:26:33 INFO - 'tsvgr_opacity', 03:26:33 INFO - 'tart', 03:26:33 INFO - 'tscrollx', 03:26:33 INFO - 'cart']}, 03:26:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:33 INFO - 'tsvgr_opacity', 03:26:33 INFO - 'tart', 03:26:33 INFO - 'tscrollx', 03:26:33 INFO - 'cart']}, 03:26:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:33 INFO - 'talos_options': ['--disable-e10s'], 03:26:33 INFO - 'tests': ['tp5o']}, 03:26:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:33 INFO - 'tests': ['tp5o']}, 03:26:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:33 INFO - 'talos_options': ['--disable-e10s', 03:26:33 INFO - '--xperf_path', 03:26:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:33 INFO - 'tests': ['tp5n']}, 03:26:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:33 INFO - 'talos_options': ['--xperf_path', 03:26:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:33 INFO - 'tests': ['tp5n']}}, 03:26:33 INFO - 'talos.zip': {'path': '', 03:26:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:33 INFO - Running post-action listener: _resource_record_post_action 03:26:33 INFO - [mozharness: 2016-11-09 11:26:33.093340Z] Finished populate-webroot step (success) 03:26:33 INFO - [mozharness: 2016-11-09 11:26:33.093466Z] Running create-virtualenv step. 03:26:33 INFO - Running pre-action listener: _resource_record_pre_action 03:26:33 INFO - Running main action method: create_virtualenv 03:26:33 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:33 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 03:26:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:33 INFO - Using real prefix '/tools/python27' 03:26:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:36 INFO - Installing pip.................done. 03:26:36 INFO - Return code: 0 03:26:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:36 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')]} 03:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:36 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')]} 03:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:36 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 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:36 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 03:26:36 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 03:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:26:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:36 INFO - 'HOME': '/Users/cltbld', 03:26:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:36 INFO - 'LOGNAME': 'cltbld', 03:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:36 INFO - 'MOZ_NO_REMOTE': '1', 03:26:36 INFO - 'NO_EM_RESTART': '1', 03:26:36 INFO - 'PAGER': '/bin/cat', 03:26:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:36 INFO - 'PWD': '/builds/slave/test', 03:26:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:36 INFO - 'SHELL': '/bin/bash', 03:26:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:26:36 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:26:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:36 INFO - 'USER': 'cltbld', 03:26:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:36 INFO - 'XPC_FLAGS': '0x0', 03:26:36 INFO - 'XPC_SERVICE_NAME': '0', 03:26:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:37 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 03:26:37 INFO - Cleaning up... 03:26:37 INFO - Return code: 0 03:26:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:37 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')]} 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 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')]} 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 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 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:37 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 03:26:37 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 03:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:37 INFO - 'HOME': '/Users/cltbld', 03:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:37 INFO - 'LOGNAME': 'cltbld', 03:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:37 INFO - 'MOZ_NO_REMOTE': '1', 03:26:37 INFO - 'NO_EM_RESTART': '1', 03:26:37 INFO - 'PAGER': '/bin/cat', 03:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:37 INFO - 'PWD': '/builds/slave/test', 03:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:37 INFO - 'SHELL': '/bin/bash', 03:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:26:37 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:37 INFO - 'USER': 'cltbld', 03:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:37 INFO - 'XPC_FLAGS': '0x0', 03:26:37 INFO - 'XPC_SERVICE_NAME': '0', 03:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:37 INFO - Downloading/unpacking psutil>=3.1.1 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:41 INFO - Installing collected packages: psutil 03:26:41 INFO - Running setup.py install for psutil 03:26:41 INFO - building 'psutil._psutil_osx' extension 03:26:41 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 03:26:41 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 03:26:41 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 03:26:41 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 03:26:41 INFO - building 'psutil._psutil_posix' extension 03:26:41 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 03:26:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:26:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:26:42 INFO - ^ 03:26:42 INFO - 1 warning generated. 03:26:42 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 03:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:42 INFO - Successfully installed psutil 03:26:42 INFO - Cleaning up... 03:26:42 INFO - Return code: 0 03:26:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:42 INFO - 'HOME': '/Users/cltbld', 03:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:42 INFO - 'LOGNAME': 'cltbld', 03:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:42 INFO - 'MOZ_NO_REMOTE': '1', 03:26:42 INFO - 'NO_EM_RESTART': '1', 03:26:42 INFO - 'PAGER': '/bin/cat', 03:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:42 INFO - 'PWD': '/builds/slave/test', 03:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:42 INFO - 'SHELL': '/bin/bash', 03:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:26:42 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:42 INFO - 'USER': 'cltbld', 03:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:42 INFO - 'XPC_FLAGS': '0x0', 03:26:42 INFO - 'XPC_SERVICE_NAME': '0', 03:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:42 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 03:26:42 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 03:26:42 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 03:26:42 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 03:26:42 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 03:26:42 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 03:26:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:45 INFO - Installing collected packages: mozsystemmonitor 03:26:45 INFO - Running setup.py install for mozsystemmonitor 03:26:45 INFO - Successfully installed mozsystemmonitor 03:26:45 INFO - Cleaning up... 03:26:45 INFO - Return code: 0 03:26:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:45 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 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:45 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 03:26:45 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 03:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:45 INFO - 'HOME': '/Users/cltbld', 03:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:45 INFO - 'LOGNAME': 'cltbld', 03:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:45 INFO - 'MOZ_NO_REMOTE': '1', 03:26:45 INFO - 'NO_EM_RESTART': '1', 03:26:45 INFO - 'PAGER': '/bin/cat', 03:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:45 INFO - 'PWD': '/builds/slave/test', 03:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:45 INFO - 'SHELL': '/bin/bash', 03:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:26:45 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:45 INFO - 'USER': 'cltbld', 03:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:45 INFO - 'XPC_FLAGS': '0x0', 03:26:45 INFO - 'XPC_SERVICE_NAME': '0', 03:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:45 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:48 INFO - warning: no files found matching '*.txt' 03:26:48 INFO - no previously-included directories found matching 'build' 03:26:48 INFO - no previously-included directories found matching 'dist' 03:26:48 INFO - no previously-included directories found matching '.git*' 03:26:48 INFO - Installing collected packages: jsonschema, functools32 03:26:48 INFO - Running setup.py install for functools32 03:26:48 INFO - warning: no files found matching '*.txt' 03:26:48 INFO - no previously-included directories found matching 'build' 03:26:48 INFO - no previously-included directories found matching 'dist' 03:26:48 INFO - no previously-included directories found matching '.git*' 03:26:48 INFO - Successfully installed jsonschema functools32 03:26:48 INFO - Cleaning up... 03:26:49 INFO - Return code: 0 03:26:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:26:49 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')]} 03:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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')]} 03:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:49 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 03:26:49 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 03:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:49 INFO - 'HOME': '/Users/cltbld', 03:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:49 INFO - 'LOGNAME': 'cltbld', 03:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:49 INFO - 'MOZ_NO_REMOTE': '1', 03:26:49 INFO - 'NO_EM_RESTART': '1', 03:26:49 INFO - 'PAGER': '/bin/cat', 03:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:49 INFO - 'PWD': '/builds/slave/test', 03:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:49 INFO - 'SHELL': '/bin/bash', 03:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:26:49 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:49 INFO - 'USER': 'cltbld', 03:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:49 INFO - 'XPC_FLAGS': '0x0', 03:26:49 INFO - 'XPC_SERVICE_NAME': '0', 03:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:26:49 INFO - Cleaning up... 03:26:49 INFO - Return code: 0 03:26:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:49 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')]} 03:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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')]} 03:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:49 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 03:26:49 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 03:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:49 INFO - 'HOME': '/Users/cltbld', 03:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:49 INFO - 'LOGNAME': 'cltbld', 03:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:49 INFO - 'MOZ_NO_REMOTE': '1', 03:26:49 INFO - 'NO_EM_RESTART': '1', 03:26:49 INFO - 'PAGER': '/bin/cat', 03:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:49 INFO - 'PWD': '/builds/slave/test', 03:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:49 INFO - 'SHELL': '/bin/bash', 03:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:26:49 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:49 INFO - 'USER': 'cltbld', 03:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:49 INFO - 'XPC_FLAGS': '0x0', 03:26:49 INFO - 'XPC_SERVICE_NAME': '0', 03:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:49 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:53 INFO - Downloading docopt-0.6.1.tar.gz 03:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:53 INFO - Running setup.py install for blobuploader 03:26:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:53 INFO - Running setup.py install for requests 03:26:53 INFO - Running setup.py install for docopt 03:26:54 INFO - Successfully installed blobuploader requests docopt 03:26:54 INFO - Cleaning up... 03:26:54 INFO - Return code: 0 03:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:54 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 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:54 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 03:26:54 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 03:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:54 INFO - 'HOME': '/Users/cltbld', 03:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:54 INFO - 'LOGNAME': 'cltbld', 03:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:54 INFO - 'MOZ_NO_REMOTE': '1', 03:26:54 INFO - 'NO_EM_RESTART': '1', 03:26:54 INFO - 'PAGER': '/bin/cat', 03:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:54 INFO - 'PWD': '/builds/slave/test', 03:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:54 INFO - 'SHELL': '/bin/bash', 03:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:26:54 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:54 INFO - 'USER': 'cltbld', 03:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:54 INFO - 'XPC_FLAGS': '0x0', 03:26:54 INFO - 'XPC_SERVICE_NAME': '0', 03:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:54 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-cPT3Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:54 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ulkGqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:54 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-MdSj6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:54 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-u1wr_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:54 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-VwFk_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:54 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-BmDb7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-WSZhXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-PJkyoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Z_4Z4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-gAQwpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-C4ZGiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-R_RwlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-X1ZLdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-UhAKst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-h6qrcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:55 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-NorlVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:56 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-9JXK1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:56 INFO - Running setup.py install for manifestparser 03:26:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Running setup.py install for mozcrash 03:26:56 INFO - Running setup.py install for mozdebug 03:26:56 INFO - Running setup.py install for mozdevice 03:26:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Running setup.py install for mozfile 03:26:56 INFO - Running setup.py install for mozhttpd 03:26:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for mozinfo 03:26:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for mozInstall 03:26:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for mozleak 03:26:57 INFO - Running setup.py install for mozlog 03:26:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for moznetwork 03:26:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for mozprocess 03:26:57 INFO - Running setup.py install for mozprofile 03:26:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Running setup.py install for mozrunner 03:26:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Running setup.py install for mozscreenshot 03:26:58 INFO - Running setup.py install for moztest 03:26:58 INFO - Running setup.py install for mozversion 03:26:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:58 INFO - Cleaning up... 03:26:58 INFO - Return code: 0 03:26:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:58 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')]} 03:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:58 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')]} 03:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:58 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 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:26:58 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 03:26:58 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 03:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:58 INFO - 'HOME': '/Users/cltbld', 03:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:58 INFO - 'LOGNAME': 'cltbld', 03:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:58 INFO - 'MOZ_NO_REMOTE': '1', 03:26:58 INFO - 'NO_EM_RESTART': '1', 03:26:58 INFO - 'PAGER': '/bin/cat', 03:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:58 INFO - 'PWD': '/builds/slave/test', 03:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:58 INFO - 'SHELL': '/bin/bash', 03:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:26:58 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:58 INFO - 'USER': 'cltbld', 03:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:58 INFO - 'XPC_FLAGS': '0x0', 03:26:58 INFO - 'XPC_SERVICE_NAME': '0', 03:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-zN_HIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-VCPocr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-PFNWdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-l_et38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-fWOfk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-wl2tLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-B5YYdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Duv_jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-MA9NR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:59 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-H2MGSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:00 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-exaZXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:00 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-xQ0YYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:00 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-0KOKSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:00 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-yG1lIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:00 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-zRsMj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:00 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-bMVUjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:00 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-2ta1tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:03 INFO - Downloading blessings-1.6.tar.gz 03:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:03 INFO - Installing collected packages: blessings 03:27:03 INFO - Running setup.py install for blessings 03:27:03 INFO - Successfully installed blessings 03:27:03 INFO - Cleaning up... 03:27:03 INFO - Return code: 0 03:27:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:03 INFO - Reading from file tmpfile_stdout 03:27:03 INFO - Current package versions: 03:27:03 INFO - blessings == 1.6 03:27:03 INFO - blobuploader == 1.2.4 03:27:03 INFO - docopt == 0.6.1 03:27:03 INFO - functools32 == 3.2.3-2 03:27:03 INFO - jsonschema == 2.5.1 03:27:03 INFO - manifestparser == 1.1 03:27:03 INFO - mozInstall == 1.12 03:27:03 INFO - mozcrash == 0.17 03:27:03 INFO - mozdebug == 0.1 03:27:03 INFO - mozdevice == 0.48 03:27:03 INFO - mozfile == 1.2 03:27:03 INFO - mozhttpd == 0.7 03:27:03 INFO - mozinfo == 0.9 03:27:03 INFO - mozleak == 0.1 03:27:03 INFO - mozlog == 3.4 03:27:03 INFO - moznetwork == 0.27 03:27:03 INFO - mozprocess == 0.23 03:27:03 INFO - mozprofile == 0.28 03:27:03 INFO - mozrunner == 6.12 03:27:03 INFO - mozscreenshot == 0.1 03:27:03 INFO - mozsystemmonitor == 0.3 03:27:03 INFO - moztest == 0.7 03:27:03 INFO - mozversion == 1.4 03:27:03 INFO - psutil == 3.1.1 03:27:03 INFO - requests == 1.2.3 03:27:03 INFO - wsgiref == 0.1.2 03:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:03 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')]} 03:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:03 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')]} 03:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:03 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 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:27:03 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 03:27:03 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 03:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:03 INFO - 'HOME': '/Users/cltbld', 03:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:03 INFO - 'LOGNAME': 'cltbld', 03:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:03 INFO - 'MOZ_NO_REMOTE': '1', 03:27:03 INFO - 'NO_EM_RESTART': '1', 03:27:03 INFO - 'PAGER': '/bin/cat', 03:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:03 INFO - 'PWD': '/builds/slave/test', 03:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:03 INFO - 'SHELL': '/bin/bash', 03:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:27:03 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:03 INFO - 'USER': 'cltbld', 03:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:03 INFO - 'XPC_FLAGS': '0x0', 03:27:03 INFO - 'XPC_SERVICE_NAME': '0', 03:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 INFO - Cleaning up... 03:27:04 INFO - Return code: 0 03:27:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10105e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d1d72860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, '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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:27: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', 'jsonschema'] in /builds/slave/test/build 03:27: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 jsonschema 03:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:04 INFO - 'HOME': '/Users/cltbld', 03:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:04 INFO - 'LOGNAME': 'cltbld', 03:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:04 INFO - 'MOZ_NO_REMOTE': '1', 03:27:04 INFO - 'NO_EM_RESTART': '1', 03:27:04 INFO - 'PAGER': '/bin/cat', 03:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:04 INFO - 'PWD': '/builds/slave/test', 03:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:04 INFO - 'SHELL': '/bin/bash', 03:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:27:04 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:04 INFO - 'USER': 'cltbld', 03:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:04 INFO - 'XPC_FLAGS': '0x0', 03:27:04 INFO - 'XPC_SERVICE_NAME': '0', 03:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:04 INFO - Cleaning up... 03:27:04 INFO - Return code: 0 03:27:04 INFO - Running post-action listener: _resource_record_post_action 03:27:04 INFO - Running post-action listener: _start_resource_monitoring 03:27:04 INFO - Starting resource monitoring. 03:27:04 INFO - [mozharness: 2016-11-09 11:27:04.540087Z] Finished create-virtualenv step (success) 03:27:04 INFO - [mozharness: 2016-11-09 11:27:04.541071Z] Running install step. 03:27:04 INFO - Running pre-action listener: _resource_record_pre_action 03:27:04 INFO - Running main action method: install 03:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:04 INFO - Reading from file tmpfile_stdout 03:27:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:04 INFO - Reading from file tmpfile_stdout 03:27:04 INFO - Output received: 03:27:04 INFO - Usage: mozinstall [options] installer 03:27:04 INFO - Options: 03:27:04 INFO - -h, --help show this help message and exit 03:27:04 INFO - -d DEST, --destination=DEST 03:27:04 INFO - Directory to install application into. [default: 03:27:04 INFO - "/builds/slave/test"] 03:27:04 INFO - --app=APP Application being installed. [default: firefox] 03:27:04 INFO - mkdir: /builds/slave/test/build/application 03:27:04 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'] 03:27:04 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 03:27:37 INFO - Reading from file tmpfile_stdout 03:27:37 INFO - Output received: 03:27:37 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:27:37 INFO - Running post-action listener: _resource_record_post_action 03:27:37 INFO - [mozharness: 2016-11-09 11:27:37.235281Z] Finished install step (success) 03:27:37 INFO - [mozharness: 2016-11-09 11:27:37.235464Z] Running run-tests step. 03:27:37 INFO - Running pre-action listener: _resource_record_pre_action 03:27:37 INFO - Running main action method: run_tests 03:27:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:37 INFO - 2016-11-09 03:27:37.250 screenresolution[1647:8345] starting screenresolution argv=screenresolution get 03:27:37 INFO - 2016-11-09 03:27:37.252 screenresolution[1647:8345] Display 0: 1600x1200x32@60 03:27:37 INFO - 2016-11-09 03:27:37.258 screenresolution[1648:8348] starting screenresolution argv=screenresolution list 03:27:37 INFO - Available Modes on Display 0 03:27:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:37 INFO - Intel Iris: 03:27:37 INFO - Chipset Model: Intel Iris 03:27:37 INFO - Type: GPU 03:27:37 INFO - Bus: Built-In 03:27:37 INFO - VRAM (Dynamic, Max): 1536 MB 03:27:37 INFO - Vendor: Intel (0x8086) 03:27:37 INFO - Device ID: 0x0a2e 03:27:37 INFO - Revision ID: 0x0009 03:27:37 INFO - Displays: 03:27:37 INFO - Display: 03:27:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:37 INFO - Display Serial Number: 1600x1200 60 03:27:37 INFO - Main Display: Yes 03:27:37 INFO - Mirror: Off 03:27:37 INFO - Online: Yes 03:27:37 INFO - Rotation: Supported 03:27:37 INFO - Return code: 0 03:27:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:37 INFO - Python 2.7.3 03:27:37 INFO - Return code: 0 03:27:37 INFO - grabbing minidump binary from tooltool 03:27:37 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')]} 03:27:37 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 0x100efcd30>, '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 0x100d62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ef4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:37 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 03:27:37 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 03:27:37 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 03:27:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:37 INFO - Return code: 0 03:27:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:27:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:27:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:37 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/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 03:27:37 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/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0281 --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 03:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IYSA9ve9r8/Render', 03:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:37 INFO - 'HOME': '/Users/cltbld', 03:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:37 INFO - 'LOGNAME': 'cltbld', 03:27:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:37 INFO - 'MOZ_NO_REMOTE': '1', 03:27:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:37 INFO - 'NO_EM_RESTART': '1', 03:27:37 INFO - 'PAGER': '/bin/cat', 03:27:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:37 INFO - 'PWD': '/builds/slave/test', 03:27:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:37 INFO - 'SHELL': '/bin/bash', 03:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z1Pgtze5Ks/Listeners', 03:27:37 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:37 INFO - 'USER': 'cltbld', 03:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:37 INFO - 'XPC_FLAGS': '0x0', 03:27:37 INFO - 'XPC_SERVICE_NAME': '0', 03:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:37 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/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 03:27:37 INFO - mozversion application_buildid: 20161108173621 03:27:37 INFO - mozversion application_changeset: ae3b6bfb810476141647ad681b796ed118062412 03:27:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:37 INFO - mozversion application_name: Firefox 03:27:37 INFO - mozversion application_remotingname: firefox-dev 03:27:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:37 INFO - mozversion application_vendor: Mozilla 03:27:37 INFO - mozversion application_version: 51.0a2 03:27:37 INFO - mozversion platform_buildid: 20161108173621 03:27:37 INFO - mozversion platform_changeset: ae3b6bfb810476141647ad681b796ed118062412 03:27:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:37 INFO - mozversion platform_version: 51.0a2 03:27:37 INFO - using testdate: 1478690857 03:27:37 INFO - actual date: 1478690857 03:27:37 INFO - starting webserver on 'localhost:49276' 03:27:37 INFO - SUITE-START | Running 2 tests 03:27:37 INFO - TEST-START | dromaeo_css 03:27:37 INFO - operating with platform_type : mac_ 03:27:37 INFO - Initialising browser for dromaeo_css test... 03:27:37 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpcbJC_I/profile http://localhost:49276/getInfo.html) 03:27:40 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 03:27:40 INFO - PROCESS | 1658 | colorDepth:24 03:27:40 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 03:27:40 INFO - PROCESS | 1658 | __metrics 03:27:40 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:27:41 INFO - TEST-INFO | 1658: exit 0 03:27:41 INFO - Browser initialized. 03:27:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:41 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpcbJC_I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:53 INFO - PROCESS | 1662 | RSS: Main: 225603584 03:27:53 INFO - PROCESS | 1662 | 03:28:43 INFO - PROCESS | 1662 | 1478690923252 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] 03:30:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 03:30:57 INFO - PROCESS | 1662 | RSS: Main: 236908544 03:30:57 INFO - PROCESS | 1662 | 03:33:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 03:33:59 INFO - PROCESS | 1662 | RSS: Main: 249077760 03:33:59 INFO - PROCESS | 1662 | 03:37:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 03:37:02 INFO - PROCESS | 1662 | RSS: Main: 251453440 03:37:02 INFO - PROCESS | 1662 | 03:40:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 03:40:04 INFO - PROCESS | 1662 | RSS: Main: 251678720 03:40:04 INFO - PROCESS | 1662 | 03:43:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 03:43:08 INFO - PROCESS | 1662 | RSS: Main: 256352256 03:43:08 INFO - PROCESS | 1662 | 03:46:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 03:46:11 INFO - PROCESS | 1662 | RSS: Main: 258990080 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - PROCESS | 1662 | __start_tp_report 03:46:11 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 03:46:11 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 03:46:11 INFO - PROCESS | 1662 | |i|pagename|runs| 03:46:11 INFO - PROCESS | 1662 | |0;dojo.html;2840.460312540618;3432.879849205278;3452.6719961603653;3455.654434556546;3484.3902317094517;4982.526659967306;5779.62432441891;5786.305643322808;5801.680907550083;5812.593118481703;4779.402574678165;5769.740361683724;5798.884022319551;5816.651000939946;5840.094785308284;4333.176696427684;5296.947030529704;5298.337707786536;5324.494173053573;5368.087425137736;5361.222622719703;5367.490088441592;5379;5380.192971054354;5418.783248670068;5250.028744682227;5267.420583735786;5353.464653534635;5360.973195134019;5420.078586640261;5239.187925871496;5273.4462881397285;5304.708241046741;5312.574994000471;5315.282436871012;4466.955330446719;5222.112240919053;5283.154695248781;5317.494837990384;5416.864578385533;5669.036263835158;5841.299044114691;5857.414258574151;5927.199828023205;5944.583879128462;5043.722595257259;6162.7534898604;6207.193064901579;6236.095766113934;6247.062940558907;6309.842253943642;6318.557700960934;6320.968395158041;6339.207599050119;6343.397377249154;4526.95473045272;5241.580673546107;5996.19051428056;6003.489703375175;6016.09758536223;4622.95377046232;5239.397469291081;6231.501479881689;6256.718447669866;6355.682215889187;6228.159198508143;6242.188515493048;6245.6252624842655;6253.249610046823;6263.4362907337645;6152.415520525632;6301.52738544611;6314.147590075281;6317.399847014526;6332.651704156316;6170.321264660884;6178.505719542426;6243.219597550306;6260.342664020303;6303.464205542488;5251;6265.4361107500545;6311.684415779285;6316.557840951089;6319.968400158062;4932.60768527264;5016;5023.246513023003;5025.221090730869;5033;4424.380586717862;4446.26636604963;4452.265376212953;4478.2386994211065;4509.729416235036;5735.713214339266;6083.695815209222;6092.086187071886;6093.086037094471;6108.251008765781;6264.123022776815;6276.874462510816;6288.968555157195;6294.748210071637;6302.243730752339;5787.971060144672;5860.384659610765;5968.37332080134;6015.639061656315;6015.699215039231;5505.972470137704;5515.255440515479;5524.1989911463415;5544;5551.639143455663;6361;6372.968135159294;6410.839729006719;6423.96788016057;6437.613743175424;6242.219722534684;6251.9687401562705;6289.119523266838;6321.33625969285;6356.3325850785;6300.369963003663;6425.807225783234;6427.58220715652;6429.813863286505;6441.774537891151;6270.7805226816845;6288.27684816252;6289.905651415141;6306.621602703853;6312;6182.876342473215;6251.062340648939;6282.026285925689;6310.2743184534365;6310.305866354789;6088.025915853442;6130.233720784902;6131.785387511416;6161.383861613803;6181.180433071266;5582.8325150245555;5861.6189947653265;6217.533684973555;6239.282482514569;6250.906236406367;5964.493018093511;6017.097435384728;6071.180390647206;6129.387061293835;6145.84635384119;6136.365905528278;6155.6614386209185;6164.352742961924;6166.105914642262;6257.09272155544;6079.817605471843;6105.358937311518;6109.239976717207;6117.218487018478;6120.2947619997085 03:46:11 INFO - PROCESS | 1662 | |1;ext.html;523.7250443517153;531.0600237579487;537.1325309624957;541.4487493331607;554.4150920778578;40305.79847100764;42200;42257;42287.57712422879;42397.78801105998;32780;43554.60449675267;44091.338629920494;44091.55908440915;44279.77860110695;7599.620018999056;8897.95551022244;9350.672726454575;9960;10008.799824003516;8452.492850428964;9910.810702715684;9945.15466185375;9975.501224938724;10023.248256380764;9980.550875210596;10021.298509104365;10042.297039207258;10047.99520047993;10064.446455444984;8005.799855003614;8295.62669679866;8960.417572857743;9942.602295908155;10002.349847259904;8230.506169629842;8802.691905783331;9940.950295248478;9968.700938971842;9983.900160998443;40964.59035409638;41186;41273.38089928654;41281;41340;3239.0930539448755;3379.526866238704;3419.7093247074026;3420.743444241667;3760.9811950940343;30066.098017059525;30333.848330758425;31467.84266078655;32297.031089067365;32571.51142732861;3216.0834162263877;3286.819224942627;3333.516640087174;3438.535797667333;3443.5523381960184;512355;515309;517598;519724.9999999962;520370;33269;34352.656473434945;60890.391096088475;61276;61348;35540;35765;35787.28425431477;35793;36037.459438108446;14699.779503307458;14861.92569037148;15137.697246055017;15235.695286094216;15311.46409875649;12566.183198092278;12899.419526121346;12989.545365912149;12995.610131696065;13009.414576344087;7643.235676432312;7735.574543400167;7862.567558784322;7919.010123734533;7956.84086318282;3136.4197623439736;3200.647928727838;3244.8053116813066;3271.869125234964;3303.8678452862096;799.1608810748806;883.2227639677043;945.9668911588061;994.751312171957;1038.3873514626407;30140.09579712612;30430.54354184689;30639.387212256075;31056.68943310538;31069.68930310713;1036.8030074285862;1097.9505922233518;1105.2152971390242;1149.5401839264193;1172.9941350293363;14344.067635603653;16449.342026318813;16953.98276103413;17091.48725538236;17145.742813857803;690604;703384;709527;712208;713835;58164.12753808696;58739.70630146822;58763.70618146882;58842;58846;1318.775808112623;1337.5519201067752;1374.8487666356693;1376.8485466598465;1379.2827729580763;30541.09859563338;31805.363892721554;32198.83900580482;32200.677993219768;32236;50549.73625659388;51039.234411483114;51145.744271279895;51154.48845511497;51235.74382128065;649141;649929;651916;655445;655745;22478.550428991002;26373.472530549665;26681.19956401311;26803.659817009462;26863.194104176906;47084.29373559331;48101.27848082212;48577;48691.02617947692;48849.75575122102;39520.60479395284;39969.60030399775;40068.59931400765;40995.79502102471;41002.58997409988;39357.60642393654;39487.80256098701;39782.80108599438;40469.59530404658;40630.59369406268;32545.349093017532;32945;38227.42658860064;38795.418068728424;39138.80430597829;28278.727457264886;33017.50473742944;33301;35097.29805403929;35693.46459803157;19106.80893191106;22930.42673933165;26518.337041574116;26888.32779180536;27178.72821271762 03:46:11 INFO - PROCESS | 1662 | |2;jquery.html;308.27093922872405;374.44955914805263;377.3001082991051;379.5180121246019;401.1635739483177;13755.79366309505;19299.710504342445;19968.101435435405;20617.484562885915;20916.9541522924;13865.584032479042;14071.366788494543;14809.481668141618;18094;19387.903060484678;5861.413858614147;6183.041628547559;6194.380561943792;6208.410201030917;6212.937870621304;3714.4428335749585;5191.5327620514145;6128.724207410677;6641.236257830339;6716.664166791666;6444.516661250402;6542.640154791485;6578.967105164467;6622.238442579092;6627.5029372797235;6635.369639884251;6657.500687448436;6721.966390168067;6772.729090836386;6801.387875091241;5139.383274007143;5410.161424979135;5473.972630136864;5820.650760954314;5890.823275301748;12987.220766754024;13236.602901912862;13407.597772066854;13531.661708457368;13557.389917453738;2106.3786183075877;2200.2189222825987;2385.8926348314367;2485.888135033928;2864.8254215771435;9964;10009.399436033862;10090.293679442442;10351.585936562604;10578.418186999788;1489.6722721001363;1654.2803880312104;1708.7949446066552;1880.341880341883;1887.8861471731607;104958.47520762424;109486.71539853737;109790;110444.89555104426;110472.4476377621;9228.769280768034;11509.424528773528;11947.940260298643;12048.457819397972;12146;14764.557063288119;14874.181919994504;14882.479113230986;14919.627009324637;14931.253437328307;8609.655613775503;8705.956470217736;8730.17063378978;8795.69215077482;8834.116588341114;6153.769246150788;8000.679972801139;8532.744017679479;8634;8807.295416366675;4452.799624016927;4570.200214962369;4592.2422800238255;4633.235516139799;4656.32483289921;1752.8264951460098;1817.5728703754608;1842.2170577504507;1888.8583356248337;1932.7487426634448;876.9780755481037;921.447131720962;922.5617831530104;931.1340453378423;942.783159873233;18133.002684852196;19427.4171774847;20749.688754668692;20941.371758847257;21182.682259766116;921.7188757428914;961.6057416459219;962.1773383756787;997.5211898288862;1041.2450973044633;9255.843019622547;10818.350898946088;11058.889411105947;11126.833097503544;11156.442177891073;498771;516195;552005;630304;662138;98652;126271;130663;134510;138000;959.2278216036018;1000.9349392289478;1013.7719013221966;1027.4811220333684;1034.4414016431042;19206.61586768229;19891.602167956848;19913.900430497753;19932.80403175814;19935.501612459804;44786.3282050776;46672;50598.72305746324;50648;51828;58404.4159558399;74430;77880.2211977873;77887.221127788;78273.95534401931;7922.4850384724805;8209.630566624635;8382;8431.32549396059;8511.276541493795;10284.691459256233;10702.357858528514;12947.611571652866;13151.802722958972;13274.93362533181;8705.825883482168;10294.536745846604;11321;11458.427078645867;11782.293062416282;11116.722081948015;11127.276727012719;11243;11317.755046944994;11611.5355385787;11487.48306326234;11560.132990025613;11862.525498979945;11869.5845645402;11885.643430697093;8226.958865205876;8328.208820162075;8434.620442079999;8446.155384461505;8597.054324024477;10909.563617455213;10937.617183398861;11153.163512736415;11153.609623663133;11546.884531154581 03:46:11 INFO - PROCESS | 1662 | |3;mootools.html;1449.1739708366233;1493.805805245318;1498.8426215247398;1736.9503985297345;1873.1851644534636;7870.685172593089;8084.4745091569;8678.218960293572;9221.446713197212;9238.815223695523;8632.39573229874;8910.242629376511;8928.642854285838;9060.320475964296;9086.13681700239;2386.630072338786;2406.590879550472;2413.3966508372905;2416.9758302417013;2419.0323870451784;2381.0475809676095;2386.6658667786523;2418;2431.6109422492405;2433.0997530913587;2373.1693907132453;2386.427257458206;2410.0721222329353;2410.867402292873;2411.03558576569;2380.916667916632;2386.558486679961;2393.3298676370646;2393.8563686178886;2408;2370.0756704885107;2382.7498112698263;2395.4370722880108;2396.113438027923;2405.398650337416;8868.733937981871;9066.95466522663;9069.410488318239;9090.363674542785;9104;4840.757962101916;4918.975405122951;5264.631475796696;5387.542058924996;5413.2692086568595;3009.5636132760847;3494.825258737053;3665.3402387570227;3676.117731744389;3684.5762737285286;1070.1813112968584;1099.6920862158609;1114.509615769059;1124.246754674362;1808.2857271377732;11707.297562146214;11789.233699809485;11862.466189021514;11978.041756659446;11990;3614.4397618369194;4656.697314674535;4673.042026384583;4716.410448693913;4732.621390288768;7614.581198034161;9099.954500227588;9170;9235.630574777068;9241.353105282566;5266.97366513165;5282.102042652758;5316.65441746293;5317.680939143664;5330.067238233293;4497.865064048084;4632.907341853144;4826.831060912921;4959.958408734206;4963.6277279204205;3831.5210598675167;3854.69162467002;3933.331333673282;3939.2318497892634;3953.2291203215095;1183.627157445402;1190.047961630692;1191.4042978510745;1194.4445832687843;1194.9761004779855;783.4554984285867;874.5889431966965;891.0599317719867;898.8988489100799;900.6532484993324;5043.4956504349275;5196.948030519722;5207.9063396687125;5660.433956604306;5699.544036477072;430.0517359222906;447.8052047359409;451.12256660795094;452.6853836583609;458.12040881507585;3461.3077384523194;3781.149241420713;3827.119762454651;3882.1847412043785;3932.5477570079233;10419;10683.519241634145;10838.295510791773;10979.28634638746;11041.558337666564;10728.141748660088;10783.191260655482;10900.836487452694;10914.72713182161;10932.508037138348;8143.51138931666;8337.291330236998;8470.407071505058;8471.279941204943;8471.364647651451;5592.916106258491;5660.85847853807;5689.772409103755;5744.3394009687745;5747.827565173052;10076.546555405172;10122.089011988955;10147.34042287249;10301.021402966706;10339.483025848827;8627.91372086271;10106.949465252921;10187.643432479828;10446.05985461312;10476.476176191312;6533.934660653523;6741.393274605309;6926.653667316513;7103.538270012433;7155.713771449292;7690;8301.875471867806;8580.785480363042;8591.484510929364;8627.396082274181;6183.628982261079;6998.580085194904;7306.96346518264;7587.658555364911;7690.346320562591;6192.628442293297;7272.745453909088;7417.072865891763;7499.737509187153;7542.886856697044;6990.755323563651;7093.503454758324;7113.0753002109395;7164.713411463692;7174.246704096204;5137.023965446553;5148.2020286855595;5174.068667639711;5181.792728290826;5214.582833373245;4328.177646247203;5153.3815942087185;5270;5280.471952804689;5288.4182739897815 03:46:11 INFO - PROCESS | 1662 | |4;prototype.html;295.68657223343257;299.99550006749894;305.378554641305;305.7874777029965;311.377245508982;5187.610929180308;5401.757595752979;5606.430199544124;5617.269754931858;5732.159453166373;5265.657732247401;5387.811426600069;5460;5539.753555450022;5549.833504994856;4199.412082308464;4202.516710578277;4215.451991241134;4221.965618423491;4251.128518653669;3662.322470342982;3804.7907365094907;4082.632563069323;4194.077302993336;4248.553901840309;3462.809545474998;4152.626263636287;4173.290540608089;4185.037441388483;4221.620054195122;4175;4181.205570941542;4189.958100418988;4207.431996680455;4214.557471465513;3654.8669912327264;3666.7799932004164;3675.9081022974374;3681.5766186888313;3700.148965737895;4616.76916154191;5066.225661881885;5305.310309659758;5308.840734777963;5341.465853414627;4003.399490076512;4508.842190523349;4783.579740485569;4801.399825021872;4805.567498925114;5152.613553983429;5197.636165468419;5464.453554644543;5768.711564421762;5792.652440853562;3179.9682003180133;3873.4577159197734;3894.337962546374;3905.3556163233034;3955.8417663293435;6092.268927728701;6160.722767475474;6224.844378890564;6269.962262264782;6292.307846136967;3223.16197788572;3258.5438038674606;3392.728581713457;3474.965250347464;4025.255327764373;3371.3762953853616;3916.6475017248586;3977.747009691938;3999.7000224983244;4086.1623367210245;4210.263203939298;4718.4809670936165;4733.834315798999;4793.640476964241;4823.879403014953;5363.398751605546;5882.3529411764675;5897.852553686193;5935.406459354116;5951.256092988377;1062.68119564132;1339.397271227932;1350.8716671916152;1352.3643887372918;1385.452746165259;828.6561077152915;842.5660784695887;846.4413487098485;889.0575989451203;904.1907492793913;4129.8967525811495;4390.992170363312;4810.39870016248;4995.800167993312;5002.574781143643;5177.767000484987;5900.7049647518315;5905.261842269716;5925.496332811673;5952.613080149777;4546.363509108727;4804.663673542888;5227.634065615446;5535.280413546213;5542.8337149884765;2200.449887528118;2381.8801266872497;2462.150558057467;2508.0186652544285;2591.90928317508;4318.12161709651;4685.859424217211;5004.449510553836;5096.847094587169;5218.6868787872845;4596.3341262067925;4615.076984603093;4701.717896926195;4797.18447863864;4923.606111511071;4516.3902873112365;5100.821471248489;5130.589552835764;5134.383873935077;5134.614903882299;4213.852515161954;4516.8193272268745;4692.897169165175;4999.575036121971;5010.949890501194;4140.44104045962;4227.793345621127;4368.344748287782;4492.858389211478;4788.95211047899;4606.499060713814;4627.352170696038;4969.82605608802;5204.382953847191;5214.32213812202;3357.52994580754;3444.7244220461803;3475.3396854597545;3537.5047493351467;3546.2907418515883;4497.123061003073;4693.521540714664;4836.322914792002;5013.1701928795;5814.307914474255;4961.0325986433745;5314.760835762323;5779.537636989115;5799.8550036249435;5804.796832110856;5171.689698618095;5798.217240672455;5841.393616755427;5873.823785286449;5885.47030767233;4814.542618451242;5203.791848326025;5632.352279487747;5722.197507785035;5779.612892905757;5914;5916.290045194604;5962.672053037125;5972.820815375546;6015.879682406415;4699.882502937454;4975.039851288478;5095.031943930641;5654.830355089354;5879.265091863517 03:46:11 INFO - PROCESS | 1662 | |5;yui.html;725.6698202317946;755.0976582983334;770.4799260499163;778.4823092643393;781.718581310728;14903.925480372596;15278.312475938581;15664.060156390624;15754.527364179079;15959.281832317545;14112.929435352835;14119.788203176935;14403.423863045491;14420.206888621122;14439.494617688357;663.3797399431547;684.8253695307715;822.2106777493599;851.7317045130764;852.5524099847568;667.883120453921;705.9833839271432;816.96732130715;862.0991064337782;864.8227113441761;889.5418859287472;897.5467388968594;902.9006809250977;903.7153296711548;906.1708536688955;889.1553024626598;889.9822003559892;896.0457113174481;897.8383890899668;899.2760827533833;654.5908806995627;661.9536632435731;662.1193812229772;662.1822049768532;664.0935123556311;14757.852421475862;14892.404303827834;14893.851061489464;14911;14922.776158357634;14654.633634159125;14687.70624587513;14733.92633036828;14769.852301476954;14928.25358732059;11607.071434285237;11893.583724569598;12048.397580120958;12064.276143431422;12418.875811241862;3755.342815007363;3785.337565925952;3828.559715632682;3854.653081222675;3979.5423526294267;92226.07773922243;105662;107648.4617576907;108913.99999999921;111392;11076.778464430667;11182.552697892155;11348.978591926601;11438;11449.771004579861;22287.331380058626;22336.776632233796;22408.327750167522;22565.774342256696;22826.201082962016;7180.832563177659;7342.779716608404;7345;7379.88930166048;7550.735724249625;3472.4270495368487;4348.130373925164;4478.39541661878;4495.370648109268;4554.749488778149;3509.5262139611336;3578.177019285579;3606.6032736398975;3632.3098611263777;3638.4178531434845;531.8856445864158;586.1559354529464;590.9333652756729;595.407569468373;599.1462166412845;602.770947040122;650.2034363648025;660.1780782925289;661.7452280871803;694.7707256605308;8236.258736713724;9150.816983660423;9259.583318750672;9319.347645664873;9387.5306234688;556.8774869528778;595.5622617376225;637.6365471681097;649.4804156674642;665.4077870695086;3524.3127590120193;4312.892177695583;4379.693421460467;4546.477155127137;4681.485036645966;99742;115310;132229;133180.3340983289;171922;144270.83593746103;147165.26417367844;150049;154288;157410;93196.53401733084;126723;129683.70316296905;131891.34054329668;132473;7411.446302703513;7482.513636613603;7631.69473221065;9454.290928180277;9538.85691714611;44879.551204487536;52734.736326318125;54993;57759;58852.822943541745;79981.20018799737;83182.16817831986;85111.5744421274;87867;90216.548917255;12153.392330383622;12159.452824622736;12356.876431235933;12425.565105221274;12535.623931282076;13141.734705012726;13626;13760.477965051756;14112.223827689575;14864.331105100513;11509.928212921754;11888.405579721153;13306.866931330564;13309.66725831862;13784.517541885985;13201.801972970605;13247.403866825824;13445.865541344461;13483.46066157382;13813.654658633615;12584.18202816814;12675.873241267838;12912.483500659868;13002.95976321873;13229.867701322864;11281.232856216451;11453.885461145283;11548.364839933884;11836.881631183922;11850;10550;11314.720330216809;11566.595169169039;11582.189246752647;11635.709107272385 03:46:11 INFO - PROCESS | 1662 | __end_tp_report 03:46:11 INFO - PROCESS | 1662 | __start_cc_report 03:46:11 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,376 03:46:11 INFO - PROCESS | 1662 | __end_cc_report 03:46:11 INFO - PROCESS | 1662 | __startTimestamp1478691971115__endTimestamp 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - PROCESS | 1662 | ------- Summary: start ------- 03:46:11 INFO - PROCESS | 1662 | Number of tests: 6 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5774.22 Median:6088.03 stddev:686.03 (11.3%) stddev-sans-first:648.38 03:46:11 INFO - PROCESS | 1662 | Values: 2840.5 3432.9 3452.7 3455.7 3484.4 4982.5 5779.6 5786.3 5801.7 5812.6 4779.4 5769.7 5798.9 5816.7 5840.1 4333.2 5296.9 5298.3 5324.5 5368.1 5361.2 5367.5 5379.0 5380.2 5418.8 5250.0 5267.4 5353.5 5361.0 5420.1 5239.2 5273.4 5304.7 5312.6 5315.3 4467.0 5222.1 5283.2 5317.5 5416.9 5669.0 5841.3 5857.4 5927.2 5944.6 5043.7 6162.8 6207.2 6236.1 6247.1 6309.8 6318.6 6321.0 6339.2 6343.4 4527.0 5241.6 5996.2 6003.5 6016.1 4623.0 5239.4 6231.5 6256.7 6355.7 6228.2 6242.2 6245.6 6253.2 6263.4 6152.4 6301.5 6314.1 6317.4 6332.7 6170.3 6178.5 6243.2 6260.3 6303.5 5251.0 6265.4 6311.7 6316.6 6320.0 4932.6 5016.0 5023.2 5025.2 5033.0 4424.4 4446.3 4452.3 4478.2 4509.7 5735.7 6083.7 6092.1 6093.1 6108.3 6264.1 6276.9 6289.0 6294.7 6302.2 5788.0 5860.4 5968.4 6015.6 6015.7 5506.0 5515.3 5524.2 5544.0 5551.6 6361.0 6373.0 6410.8 6424.0 6437.6 6242.2 6252.0 6289.1 6321.3 6356.3 6300.4 6425.8 6427.6 6429.8 6441.8 6270.8 6288.3 6289.9 6306.6 6312.0 6182.9 6251.1 6282.0 6310.3 6310.3 6088.0 6130.2 6131.8 6161.4 6181.2 5582.8 5861.6 6217.5 6239.3 6250.9 5964.5 6017.1 6071.2 6129.4 6145.8 6136.4 6155.7 6164.4 6166.1 6257.1 6079.8 6105.4 6109.2 6117.2 6120.3 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:73652.47 Median:39248.21 stddev:169191.37 (431.1%) stddev-sans-first:169576.90 03:46:11 INFO - PROCESS | 1662 | Values: 523.7 531.1 537.1 541.4 554.4 40305.8 42200.0 42257.0 42287.6 42397.8 32780.0 43554.6 44091.3 44091.6 44279.8 7599.6 8898.0 9350.7 9960.0 10008.8 8452.5 9910.8 9945.2 9975.5 10023.2 9980.6 10021.3 10042.3 10048.0 10064.4 8005.8 8295.6 8960.4 9942.6 10002.3 8230.5 8802.7 9941.0 9968.7 9983.9 40964.6 41186.0 41273.4 41281.0 41340.0 3239.1 3379.5 3419.7 3420.7 3761.0 30066.1 30333.8 31467.8 32297.0 32571.5 3216.1 3286.8 3333.5 3438.5 3443.6 512355.0 515309.0 517598.0 519725.0 520370.0 33269.0 34352.7 60890.4 61276.0 61348.0 35540.0 35765.0 35787.3 35793.0 36037.5 14699.8 14861.9 15137.7 15235.7 15311.5 12566.2 12899.4 12989.5 12995.6 13009.4 7643.2 7735.6 7862.6 7919.0 7956.8 3136.4 3200.6 3244.8 3271.9 3303.9 799.2 883.2 946.0 994.8 1038.4 30140.1 30430.5 30639.4 31056.7 31069.7 1036.8 1098.0 1105.2 1149.5 1173.0 14344.1 16449.3 16954.0 17091.5 17145.7 690604.0 703384.0 709527.0 712208.0 713835.0 58164.1 58739.7 58763.7 58842.0 58846.0 1318.8 1337.6 1374.8 1376.8 1379.3 30541.1 31805.4 32198.8 32200.7 32236.0 50549.7 51039.2 51145.7 51154.5 51235.7 649141.0 649929.0 651916.0 655445.0 655745.0 22478.6 26373.5 26681.2 26803.7 26863.2 47084.3 48101.3 48577.0 48691.0 48849.8 39520.6 39969.6 40068.6 40995.8 41002.6 39357.6 39487.8 39782.8 40469.6 40630.6 32545.3 32945.0 38227.4 38795.4 39138.8 28278.7 33017.5 33301.0 35097.3 35693.5 19106.8 22930.4 26518.3 26888.3 27178.7 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33305.03 Median:11691.45 stddev:96044.68 (821.5%) stddev-sans-first:96282.16 03:46:11 INFO - PROCESS | 1662 | Values: 308.3 374.4 377.3 379.5 401.2 13755.8 19299.7 19968.1 20617.5 20917.0 13865.6 14071.4 14809.5 18094.0 19387.9 5861.4 6183.0 6194.4 6208.4 6212.9 3714.4 5191.5 6128.7 6641.2 6716.7 6444.5 6542.6 6579.0 6622.2 6627.5 6635.4 6657.5 6722.0 6772.7 6801.4 5139.4 5410.2 5474.0 5820.7 5890.8 12987.2 13236.6 13407.6 13531.7 13557.4 2106.4 2200.2 2385.9 2485.9 2864.8 9964.0 10009.4 10090.3 10351.6 10578.4 1489.7 1654.3 1708.8 1880.3 1887.9 104958.5 109486.7 109790.0 110444.9 110472.4 9228.8 11509.4 11947.9 12048.5 12146.0 14764.6 14874.2 14882.5 14919.6 14931.3 8609.7 8706.0 8730.2 8795.7 8834.1 6153.8 8000.7 8532.7 8634.0 8807.3 4452.8 4570.2 4592.2 4633.2 4656.3 1752.8 1817.6 1842.2 1888.9 1932.7 877.0 921.4 922.6 931.1 942.8 18133.0 19427.4 20749.7 20941.4 21182.7 921.7 961.6 962.2 997.5 1041.2 9255.8 10818.4 11058.9 11126.8 11156.4 498771.0 516195.0 552005.0 630304.0 662138.0 98652.0 126271.0 130663.0 134510.0 138000.0 959.2 1000.9 1013.8 1027.5 1034.4 19206.6 19891.6 19913.9 19932.8 19935.5 44786.3 46672.0 50598.7 50648.0 51828.0 58404.4 74430.0 77880.2 77887.2 78274.0 7922.5 8209.6 8382.0 8431.3 8511.3 10284.7 10702.4 12947.6 13151.8 13274.9 8705.8 10294.5 11321.0 11458.4 11782.3 11116.7 11127.3 11243.0 11317.8 11611.5 11487.5 11560.1 11862.5 11869.6 11885.6 8227.0 8328.2 8434.6 8446.2 8597.1 10909.6 10937.6 11153.2 11153.6 11546.9 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5659.98 Median:4724.52 stddev:3220.63 (68.2%) stddev-sans-first:3214.12 03:46:11 INFO - PROCESS | 1662 | Values: 1449.2 1493.8 1498.8 1737.0 1873.2 7870.7 8084.5 8678.2 9221.4 9238.8 8632.4 8910.2 8928.6 9060.3 9086.1 2386.6 2406.6 2413.4 2417.0 2419.0 2381.0 2386.7 2418.0 2431.6 2433.1 2373.2 2386.4 2410.1 2410.9 2411.0 2380.9 2386.6 2393.3 2393.9 2408.0 2370.1 2382.7 2395.4 2396.1 2405.4 8868.7 9067.0 9069.4 9090.4 9104.0 4840.8 4919.0 5264.6 5387.5 5413.3 3009.6 3494.8 3665.3 3676.1 3684.6 1070.2 1099.7 1114.5 1124.2 1808.3 11707.3 11789.2 11862.5 11978.0 11990.0 3614.4 4656.7 4673.0 4716.4 4732.6 7614.6 9100.0 9170.0 9235.6 9241.4 5267.0 5282.1 5316.7 5317.7 5330.1 4497.9 4632.9 4826.8 4960.0 4963.6 3831.5 3854.7 3933.3 3939.2 3953.2 1183.6 1190.0 1191.4 1194.4 1195.0 783.5 874.6 891.1 898.9 900.7 5043.5 5196.9 5207.9 5660.4 5699.5 430.1 447.8 451.1 452.7 458.1 3461.3 3781.1 3827.1 3882.2 3932.5 10419.0 10683.5 10838.3 10979.3 11041.6 10728.1 10783.2 10900.8 10914.7 10932.5 8143.5 8337.3 8470.4 8471.3 8471.4 5592.9 5660.9 5689.8 5744.3 5747.8 10076.5 10122.1 10147.3 10301.0 10339.5 8627.9 10106.9 10187.6 10446.1 10476.5 6533.9 6741.4 6926.7 7103.5 7155.7 7690.0 8301.9 8580.8 8591.5 8627.4 6183.6 6998.6 7307.0 7587.7 7690.3 6192.6 7272.7 7417.1 7499.7 7542.9 6990.8 7093.5 7113.1 7164.7 7174.2 5137.0 5148.2 5174.1 5181.8 5214.6 4328.2 5153.4 5270.0 5280.5 5288.4 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4429.02 Median:4799.29 stddev:1386.27 (28.9%) stddev-sans-first:1355.00 03:46:11 INFO - PROCESS | 1662 | Values: 295.7 300.0 305.4 305.8 311.4 5187.6 5401.8 5606.4 5617.3 5732.2 5265.7 5387.8 5460.0 5539.8 5549.8 4199.4 4202.5 4215.5 4222.0 4251.1 3662.3 3804.8 4082.6 4194.1 4248.6 3462.8 4152.6 4173.3 4185.0 4221.6 4175.0 4181.2 4190.0 4207.4 4214.6 3654.9 3666.8 3675.9 3681.6 3700.1 4616.8 5066.2 5305.3 5308.8 5341.5 4003.4 4508.8 4783.6 4801.4 4805.6 5152.6 5197.6 5464.5 5768.7 5792.7 3180.0 3873.5 3894.3 3905.4 3955.8 6092.3 6160.7 6224.8 6270.0 6292.3 3223.2 3258.5 3392.7 3475.0 4025.3 3371.4 3916.6 3977.7 3999.7 4086.2 4210.3 4718.5 4733.8 4793.6 4823.9 5363.4 5882.4 5897.9 5935.4 5951.3 1062.7 1339.4 1350.9 1352.4 1385.5 828.7 842.6 846.4 889.1 904.2 4129.9 4391.0 4810.4 4995.8 5002.6 5177.8 5900.7 5905.3 5925.5 5952.6 4546.4 4804.7 5227.6 5535.3 5542.8 2200.4 2381.9 2462.2 2508.0 2591.9 4318.1 4685.9 5004.4 5096.8 5218.7 4596.3 4615.1 4701.7 4797.2 4923.6 4516.4 5100.8 5130.6 5134.4 5134.6 4213.9 4516.8 4692.9 4999.6 5010.9 4140.4 4227.8 4368.3 4492.9 4789.0 4606.5 4627.4 4969.8 5204.4 5214.3 3357.5 3444.7 3475.3 3537.5 3546.3 4497.1 4693.5 4836.3 5013.2 5814.3 4961.0 5314.8 5779.5 5799.9 5804.8 5171.7 5798.2 5841.4 5873.8 5885.5 4814.5 5203.8 5632.4 5722.2 5779.6 5914.0 5916.3 5962.7 5972.8 6015.9 4699.9 4975.0 5095.0 5654.8 5879.3 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:24694.78 Median:3592.39 stddev:40263.15 (1120.8%) stddev-sans-first:40335.88 03:46:11 INFO - PROCESS | 1662 | Values: 725.7 755.1 770.5 778.5 781.7 14903.9 15278.3 15664.1 15754.5 15959.3 14112.9 14119.8 14403.4 14420.2 14439.5 663.4 684.8 822.2 851.7 852.6 667.9 706.0 817.0 862.1 864.8 889.5 897.5 902.9 903.7 906.2 889.2 890.0 896.0 897.8 899.3 654.6 662.0 662.1 662.2 664.1 14757.9 14892.4 14893.9 14911.0 14922.8 14654.6 14687.7 14733.9 14769.9 14928.3 11607.1 11893.6 12048.4 12064.3 12418.9 3755.3 3785.3 3828.6 3854.7 3979.5 92226.1 105662.0 107648.5 108914.0 111392.0 11076.8 11182.6 11349.0 11438.0 11449.8 22287.3 22336.8 22408.3 22565.8 22826.2 7180.8 7342.8 7345.0 7379.9 7550.7 3472.4 4348.1 4478.4 4495.4 4554.7 3509.5 3578.2 3606.6 3632.3 3638.4 531.9 586.2 590.9 595.4 599.1 602.8 650.2 660.2 661.7 694.8 8236.3 9150.8 9259.6 9319.3 9387.5 556.9 595.6 637.6 649.5 665.4 3524.3 4312.9 4379.7 4546.5 4681.5 99742.0 115310.0 132229.0 133180.3 171922.0 144270.8 147165.3 150049.0 154288.0 157410.0 93196.5 126723.0 129683.7 131891.3 132473.0 7411.4 7482.5 7631.7 9454.3 9538.9 44879.6 52734.7 54993.0 57759.0 58852.8 79981.2 83182.2 85111.6 87867.0 90216.5 12153.4 12159.5 12356.9 12425.6 12535.6 13141.7 13626.0 13760.5 14112.2 14864.3 11509.9 11888.4 13306.9 13309.7 13784.5 13201.8 13247.4 13445.9 13483.5 13813.7 12584.2 12675.9 12912.5 13003.0 13229.9 11281.2 11453.9 11548.4 11836.9 11850.0 10550.0 11314.7 11566.6 11582.2 11635.7 03:46:11 INFO - PROCESS | 1662 | -------- Summary: end -------- 03:46:11 INFO - PROCESS | 1662 | 03:46:11 INFO - TEST-INFO | 1662: exit 0 03:46:11 INFO - TEST-OK | dromaeo_css | took 1113889ms 03:46:11 INFO - TEST-START | kraken 03:46:11 INFO - operating with platform_type : mac_ 03:46:11 INFO - Initialising browser for kraken test... 03:46:11 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpODT6LB/profile http://localhost:49276/getInfo.html) 03:46:14 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 03:46:14 INFO - PROCESS | 1694 | colorDepth:24 03:46:14 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 03:46:14 INFO - PROCESS | 1694 | __metrics 03:46:14 ERROR - PROCESS | 1694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:46:15 INFO - TEST-INFO | 1694: exit 0 03:46:15 INFO - Browser initialized. 03:46:15 INFO - Running cycle 1/1 for kraken test... 03:46:15 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpODT6LB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:27 INFO - PROCESS | 1696 | RSS: Main: 225431552 03:46:27 INFO - PROCESS | 1696 | 03:46:30 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:30 INFO - PROCESS | 1696 | RSS: Main: 238043136 03:46:30 INFO - PROCESS | 1696 | 03:46:33 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 03:46:34 INFO - PROCESS | 1696 | RSS: Main: 245493760 03:46:34 INFO - PROCESS | 1696 | 03:46:37 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 03:46:37 INFO - PROCESS | 1696 | RSS: Main: 249196544 03:46:37 INFO - PROCESS | 1696 | 03:46:39 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 03:46:40 INFO - PROCESS | 1696 | RSS: Main: 250765312 03:46:40 INFO - PROCESS | 1696 | 03:46:42 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:43 INFO - PROCESS | 1696 | RSS: Main: 250880000 03:46:43 INFO - PROCESS | 1696 | 03:46:45 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:46 INFO - PROCESS | 1696 | RSS: Main: 251609088 03:46:46 INFO - PROCESS | 1696 | 03:46:49 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:50 INFO - PROCESS | 1696 | RSS: Main: 251670528 03:46:50 INFO - PROCESS | 1696 | 03:46:53 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 03:46:53 INFO - PROCESS | 1696 | RSS: Main: 251932672 03:46:53 INFO - PROCESS | 1696 | 03:46:55 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:56 INFO - PROCESS | 1696 | RSS: Main: 251322368 03:46:56 INFO - PROCESS | 1696 | 03:46:58 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:58 INFO - PROCESS | 1696 | RSS: Main: 251420672 03:46:58 INFO - PROCESS | 1696 | 03:47:00 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:01 INFO - PROCESS | 1696 | RSS: Main: 251281408 03:47:01 INFO - PROCESS | 1696 | 03:47:04 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:05 INFO - PROCESS | 1696 | RSS: Main: 251334656 03:47:05 INFO - PROCESS | 1696 | 03:47:07 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:08 INFO - PROCESS | 1696 | RSS: Main: 251707392 03:47:08 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 03:47:10 INFO - PROCESS | 1696 | RSS: Main: 253239296 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | __start_tp_report 03:47:10 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 03:47:10 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 03:47:10 INFO - PROCESS | 1696 | |i|pagename|runs| 03:47:10 INFO - PROCESS | 1696 | |0;ai-astar;85;133;176;179;116;119;119;119;119;115 03:47:10 INFO - PROCESS | 1696 | |1;audio-beat-detection;142;110;115;149;110;111;115;112;138;115 03:47:10 INFO - PROCESS | 1696 | |2;audio-dft;195;202;197;190;195;201;197;194;195;238 03:47:10 INFO - PROCESS | 1696 | |3;audio-fft;74;61;64;82;61;60;84;81;98;83 03:47:10 INFO - PROCESS | 1696 | |4;audio-oscillator;82;69;89;71;71;81;96;65;68;94 03:47:10 INFO - PROCESS | 1696 | |5;imaging-gaussian-blur;91;90;91;89;91;87;92;90;91;87 03:47:10 INFO - PROCESS | 1696 | |6;imaging-darkroom;112;101;103;147;118;174;164;101;109;132 03:47:10 INFO - PROCESS | 1696 | |7;imaging-desaturate;91;92;92;99;88;150;160;91;90;125 03:47:10 INFO - PROCESS | 1696 | |8;json-parse-financial;56;58;56;57;59;61;60;60;61;59 03:47:10 INFO - PROCESS | 1696 | |9;json-stringify-tinderbox;67;70;71;80;76;71;72;69;74;72 03:47:10 INFO - PROCESS | 1696 | |10;stanford-crypto-aes;82;90;84;84;86;86;85;84;83;87 03:47:10 INFO - PROCESS | 1696 | |11;stanford-crypto-ccm;143;146;140;142;142;152;160;161;173;142 03:47:10 INFO - PROCESS | 1696 | |12;stanford-crypto-pbkdf2;183;170;200;168;167;208;181;168;165;166 03:47:10 INFO - PROCESS | 1696 | |13;stanford-crypto-sha256-iterative;68;68;70;82;68;66;70;62;64;64 03:47:10 INFO - PROCESS | 1696 | __end_tp_report 03:47:10 INFO - PROCESS | 1696 | __start_cc_report 03:47:10 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,943 03:47:10 INFO - PROCESS | 1696 | __end_cc_report 03:47:10 INFO - PROCESS | 1696 | __startTimestamp1478692030522__endTimestamp 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | ------- Summary: start ------- 03:47:10 INFO - PROCESS | 1696 | Number of tests: 14 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#0] ai-astar Cycles:10 Average:128.00 Median:126.00 stddev:28.71 (22.8%) stddev-sans-first:25.89 03:47:10 INFO - PROCESS | 1696 | Values: 85.0 133.0 176.0 179.0 116.0 119.0 119.0 119.0 119.0 115.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#1] audio-beat-detection Cycles:10 Average:121.70 Median:115.00 stddev:15.06 (13.1%) stddev-sans-first:14.06 03:47:10 INFO - PROCESS | 1696 | Values: 142.0 110.0 115.0 149.0 110.0 111.0 115.0 112.0 138.0 115.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#2] audio-dft Cycles:10 Average:200.40 Median:197.00 stddev:13.65 (6.9%) stddev-sans-first:14.34 03:47:10 INFO - PROCESS | 1696 | Values: 195.0 202.0 197.0 190.0 195.0 201.0 197.0 194.0 195.0 238.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#3] audio-fft Cycles:10 Average:74.80 Median:81.50 stddev:12.90 (15.8%) stddev-sans-first:13.68 03:47:10 INFO - PROCESS | 1696 | Values: 74.0 61.0 64.0 82.0 61.0 60.0 84.0 81.0 98.0 83.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:81.50 stddev:11.40 (14.0%) stddev-sans-first:12.03 03:47:10 INFO - PROCESS | 1696 | Values: 82.0 69.0 89.0 71.0 71.0 81.0 96.0 65.0 68.0 94.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:91.00 stddev:1.73 (1.9%) stddev-sans-first:1.79 03:47:10 INFO - PROCESS | 1696 | Values: 91.0 90.0 91.0 89.0 91.0 87.0 92.0 90.0 91.0 87.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#6] imaging-darkroom Cycles:10 Average:126.10 Median:125.00 stddev:26.98 (21.6%) stddev-sans-first:28.13 03:47:10 INFO - PROCESS | 1696 | Values: 112.0 101.0 103.0 147.0 118.0 174.0 164.0 101.0 109.0 132.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:91.00 stddev:27.19 (29.9%) stddev-sans-first:28.15 03:47:10 INFO - PROCESS | 1696 | Values: 91.0 92.0 92.0 99.0 88.0 150.0 160.0 91.0 90.0 125.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.50 stddev:1.89 (3.2%) stddev-sans-first:1.73 03:47:10 INFO - PROCESS | 1696 | Values: 56.0 58.0 56.0 57.0 59.0 61.0 60.0 60.0 61.0 59.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:3.71 (5.1%) stddev-sans-first:3.42 03:47:10 INFO - PROCESS | 1696 | Values: 67.0 70.0 71.0 80.0 76.0 71.0 72.0 69.0 74.0 72.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.50 stddev:2.28 (2.7%) stddev-sans-first:2.13 03:47:10 INFO - PROCESS | 1696 | Values: 82.0 90.0 84.0 84.0 86.0 86.0 85.0 84.0 83.0 87.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:149.00 stddev:11.11 (7.5%) stddev-sans-first:11.48 03:47:10 INFO - PROCESS | 1696 | Values: 143.0 146.0 140.0 142.0 142.0 152.0 160.0 161.0 173.0 142.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:175.50 stddev:15.33 (8.7%) stddev-sans-first:16.13 03:47:10 INFO - PROCESS | 1696 | Values: 183.0 170.0 200.0 168.0 167.0 208.0 181.0 168.0 165.0 166.0 03:47:10 INFO - PROCESS | 1696 | 03:47:10 INFO - PROCESS | 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:5.53 (8.1%) stddev-sans-first:5.87 03:47:10 INFO - PROCESS | 1696 | Values: 68.0 68.0 70.0 82.0 68.0 66.0 70.0 62.0 64.0 64.0 03:47:10 INFO - PROCESS | 1696 | -------- Summary: end -------- 03:47:10 INFO - PROCESS | 1696 | 03:47:11 INFO - TEST-INFO | 1696: exit 0 03:47:11 INFO - TEST-OK | kraken | took 59656ms 03:47:11 INFO - SUITE-END | took 1173s 03:47:11 INFO - Completed test suite (00:19:33) 03:47:11 INFO - javascript benchmark 03:47:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7190.495248219138, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2840.460312540618, 3432.879849205278, 3452.6719961603653, 3455.654434556546, 3484.3902317094517, 4982.526659967306, 5779.62432441891, 5786.305643322808, 5801.680907550083, 5812.593118481703, 4779.402574678165, 5769.740361683724, 5798.884022319551, 5816.651000939946, 5840.094785308284, 4333.176696427684, 5296.947030529704, 5298.337707786536, 5324.494173053573, 5368.087425137736, 5361.222622719703, 5367.490088441592, 5379.0, 5380.192971054354, 5418.783248670068, 5250.028744682227, 5267.420583735786, 5353.464653534635, 5360.973195134019, 5420.078586640261, 5239.187925871496, 5273.4462881397285, 5304.708241046741, 5312.574994000471, 5315.282436871012, 4466.955330446719, 5222.112240919053, 5283.154695248781, 5317.494837990384, 5416.864578385533, 5669.036263835158, 5841.299044114691, 5857.414258574151, 5927.199828023205, 5944.583879128462, 5043.722595257259, 6162.7534898604, 6207.193064901579, 6236.095766113934, 6247.062940558907, 6309.842253943642, 6318.557700960934, 6320.968395158041, 6339.207599050119, 6343.397377249154, 4526.95473045272, 5241.580673546107, 5996.19051428056, 6003.489703375175, 6016.09758536223, 4622.95377046232, 5239.397469291081, 6231.501479881689, 6256.718447669866, 6355.682215889187, 6228.159198508143, 6242.188515493048, 6245.6252624842655, 6253.249610046823, 6263.4362907337645, 6152.415520525632, 6301.52738544611, 6314.147590075281, 6317.399847014526, 6332.651704156316, 6170.321264660884, 6178.505719542426, 6243.219597550306, 6260.342664020303, 6303.464205542488, 5251.0, 6265.4361107500545, 6311.684415779285, 6316.557840951089, 6319.968400158062, 4932.60768527264, 5016.0, 5023.246513023003, 5025.221090730869, 5033.0, 4424.380586717862, 4446.26636604963, 4452.265376212953, 4478.2386994211065, 4509.729416235036, 5735.713214339266, 6083.695815209222, 6092.086187071886, 6093.086037094471, 6108.251008765781, 6264.123022776815, 6276.874462510816, 6288.968555157195, 6294.748210071637, 6302.243730752339, 5787.971060144672, 5860.384659610765, 5968.37332080134, 6015.639061656315, 6015.699215039231, 5505.972470137704, 5515.255440515479, 5524.1989911463415, 5544.0, 5551.639143455663, 6361.0, 6372.968135159294, 6410.839729006719, 6423.96788016057, 6437.613743175424, 6242.219722534684, 6251.9687401562705, 6289.119523266838, 6321.33625969285, 6356.3325850785, 6300.369963003663, 6425.807225783234, 6427.58220715652, 6429.813863286505, 6441.774537891151, 6270.7805226816845, 6288.27684816252, 6289.905651415141, 6306.621602703853, 6312.0, 6182.876342473215, 6251.062340648939, 6282.026285925689, 6310.2743184534365, 6310.305866354789, 6088.025915853442, 6130.233720784902, 6131.785387511416, 6161.383861613803, 6181.180433071266, 5582.8325150245555, 5861.6189947653265, 6217.533684973555, 6239.282482514569, 6250.906236406367, 5964.493018093511, 6017.097435384728, 6071.180390647206, 6129.387061293835, 6145.84635384119, 6136.365905528278, 6155.6614386209185, 6164.352742961924, 6166.105914642262, 6257.09272155544, 6079.817605471843, 6105.358937311518, 6109.239976717207, 6117.218487018478, 6120.2947619997085], "value": 5731.788962418175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.7250443517153, 531.0600237579487, 537.1325309624957, 541.4487493331607, 554.4150920778578, 40305.79847100764, 42200.0, 42257.0, 42287.57712422879, 42397.78801105998, 32780.0, 43554.60449675267, 44091.338629920494, 44091.55908440915, 44279.77860110695, 7599.620018999056, 8897.95551022244, 9350.672726454575, 9960.0, 10008.799824003516, 8452.492850428964, 9910.810702715684, 9945.15466185375, 9975.501224938724, 10023.248256380764, 9980.550875210596, 10021.298509104365, 10042.297039207258, 10047.99520047993, 10064.446455444984, 8005.799855003614, 8295.62669679866, 8960.417572857743, 9942.602295908155, 10002.349847259904, 8230.506169629842, 8802.691905783331, 9940.950295248478, 9968.700938971842, 9983.900160998443, 40964.59035409638, 41186.0, 41273.38089928654, 41281.0, 41340.0, 3239.0930539448755, 3379.526866238704, 3419.7093247074026, 3420.743444241667, 3760.9811950940343, 30066.098017059525, 30333.848330758425, 31467.84266078655, 32297.031089067365, 32571.51142732861, 3216.0834162263877, 3286.819224942627, 3333.516640087174, 3438.535797667333, 3443.5523381960184, 512355.0, 515309.0, 517598.0, 519724.9999999962, 520370.0, 33269.0, 34352.656473434945, 60890.391096088475, 61276.0, 61348.0, 35540.0, 35765.0, 35787.28425431477, 35793.0, 36037.459438108446, 14699.779503307458, 14861.92569037148, 15137.697246055017, 15235.695286094216, 15311.46409875649, 12566.183198092278, 12899.419526121346, 12989.545365912149, 12995.610131696065, 13009.414576344087, 7643.235676432312, 7735.574543400167, 7862.567558784322, 7919.010123734533, 7956.84086318282, 3136.4197623439736, 3200.647928727838, 3244.8053116813066, 3271.869125234964, 3303.8678452862096, 799.1608810748806, 883.2227639677043, 945.9668911588061, 994.751312171957, 1038.3873514626407, 30140.09579712612, 30430.54354184689, 30639.387212256075, 31056.68943310538, 31069.68930310713, 1036.8030074285862, 1097.9505922233518, 1105.2152971390242, 1149.5401839264193, 1172.9941350293363, 14344.067635603653, 16449.342026318813, 16953.98276103413, 17091.48725538236, 17145.742813857803, 690604.0, 703384.0, 709527.0, 712208.0, 713835.0, 58164.12753808696, 58739.70630146822, 58763.70618146882, 58842.0, 58846.0, 1318.775808112623, 1337.5519201067752, 1374.8487666356693, 1376.8485466598465, 1379.2827729580763, 30541.09859563338, 31805.363892721554, 32198.83900580482, 32200.677993219768, 32236.0, 50549.73625659388, 51039.234411483114, 51145.744271279895, 51154.48845511497, 51235.74382128065, 649141.0, 649929.0, 651916.0, 655445.0, 655745.0, 22478.550428991002, 26373.472530549665, 26681.19956401311, 26803.659817009462, 26863.194104176906, 47084.29373559331, 48101.27848082212, 48577.0, 48691.02617947692, 48849.75575122102, 39520.60479395284, 39969.60030399775, 40068.59931400765, 40995.79502102471, 41002.58997409988, 39357.60642393654, 39487.80256098701, 39782.80108599438, 40469.59530404658, 40630.59369406268, 32545.349093017532, 32945.0, 38227.42658860064, 38795.418068728424, 39138.80430597829, 28278.727457264886, 33017.50473742944, 33301.0, 35097.29805403929, 35693.46459803157, 19106.80893191106, 22930.42673933165, 26518.337041574116, 26888.32779180536, 27178.72821271762], "value": 18894.340734544527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.27093922872405, 374.44955914805263, 377.3001082991051, 379.5180121246019, 401.1635739483177, 13755.79366309505, 19299.710504342445, 19968.101435435405, 20617.484562885915, 20916.9541522924, 13865.584032479042, 14071.366788494543, 14809.481668141618, 18094.0, 19387.903060484678, 5861.413858614147, 6183.041628547559, 6194.380561943792, 6208.410201030917, 6212.937870621304, 3714.4428335749585, 5191.5327620514145, 6128.724207410677, 6641.236257830339, 6716.664166791666, 6444.516661250402, 6542.640154791485, 6578.967105164467, 6622.238442579092, 6627.5029372797235, 6635.369639884251, 6657.500687448436, 6721.966390168067, 6772.729090836386, 6801.387875091241, 5139.383274007143, 5410.161424979135, 5473.972630136864, 5820.650760954314, 5890.823275301748, 12987.220766754024, 13236.602901912862, 13407.597772066854, 13531.661708457368, 13557.389917453738, 2106.3786183075877, 2200.2189222825987, 2385.8926348314367, 2485.888135033928, 2864.8254215771435, 9964.0, 10009.399436033862, 10090.293679442442, 10351.585936562604, 10578.418186999788, 1489.6722721001363, 1654.2803880312104, 1708.7949446066552, 1880.341880341883, 1887.8861471731607, 104958.47520762424, 109486.71539853737, 109790.0, 110444.89555104426, 110472.4476377621, 9228.769280768034, 11509.424528773528, 11947.940260298643, 12048.457819397972, 12146.0, 14764.557063288119, 14874.181919994504, 14882.479113230986, 14919.627009324637, 14931.253437328307, 8609.655613775503, 8705.956470217736, 8730.17063378978, 8795.69215077482, 8834.116588341114, 6153.769246150788, 8000.679972801139, 8532.744017679479, 8634.0, 8807.295416366675, 4452.799624016927, 4570.200214962369, 4592.2422800238255, 4633.235516139799, 4656.32483289921, 1752.8264951460098, 1817.5728703754608, 1842.2170577504507, 1888.8583356248337, 1932.7487426634448, 876.9780755481037, 921.447131720962, 922.5617831530104, 931.1340453378423, 942.783159873233, 18133.002684852196, 19427.4171774847, 20749.688754668692, 20941.371758847257, 21182.682259766116, 921.7188757428914, 961.6057416459219, 962.1773383756787, 997.5211898288862, 1041.2450973044633, 9255.843019622547, 10818.350898946088, 11058.889411105947, 11126.833097503544, 11156.442177891073, 498771.0, 516195.0, 552005.0, 630304.0, 662138.0, 98652.0, 126271.0, 130663.0, 134510.0, 138000.0, 959.2278216036018, 1000.9349392289478, 1013.7719013221966, 1027.4811220333684, 1034.4414016431042, 19206.61586768229, 19891.602167956848, 19913.900430497753, 19932.80403175814, 19935.501612459804, 44786.3282050776, 46672.0, 50598.72305746324, 50648.0, 51828.0, 58404.4159558399, 74430.0, 77880.2211977873, 77887.221127788, 78273.95534401931, 7922.4850384724805, 8209.630566624635, 8382.0, 8431.32549396059, 8511.276541493795, 10284.691459256233, 10702.357858528514, 12947.611571652866, 13151.802722958972, 13274.93362533181, 8705.825883482168, 10294.536745846604, 11321.0, 11458.427078645867, 11782.293062416282, 11116.722081948015, 11127.276727012719, 11243.0, 11317.755046944994, 11611.5355385787, 11487.48306326234, 11560.132990025613, 11862.525498979945, 11869.5845645402, 11885.643430697093, 8226.958865205876, 8328.208820162075, 8434.620442079999, 8446.155384461505, 8597.054324024477, 10909.563617455213, 10937.617183398861, 11153.163512736415, 11153.609623663133, 11546.884531154581], "value": 9315.398786297226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.1739708366233, 1493.805805245318, 1498.8426215247398, 1736.9503985297345, 1873.1851644534636, 7870.685172593089, 8084.4745091569, 8678.218960293572, 9221.446713197212, 9238.815223695523, 8632.39573229874, 8910.242629376511, 8928.642854285838, 9060.320475964296, 9086.13681700239, 2386.630072338786, 2406.590879550472, 2413.3966508372905, 2416.9758302417013, 2419.0323870451784, 2381.0475809676095, 2386.6658667786523, 2418.0, 2431.6109422492405, 2433.0997530913587, 2373.1693907132453, 2386.427257458206, 2410.0721222329353, 2410.867402292873, 2411.03558576569, 2380.916667916632, 2386.558486679961, 2393.3298676370646, 2393.8563686178886, 2408.0, 2370.0756704885107, 2382.7498112698263, 2395.4370722880108, 2396.113438027923, 2405.398650337416, 8868.733937981871, 9066.95466522663, 9069.410488318239, 9090.363674542785, 9104.0, 4840.757962101916, 4918.975405122951, 5264.631475796696, 5387.542058924996, 5413.2692086568595, 3009.5636132760847, 3494.825258737053, 3665.3402387570227, 3676.117731744389, 3684.5762737285286, 1070.1813112968584, 1099.6920862158609, 1114.509615769059, 1124.246754674362, 1808.2857271377732, 11707.297562146214, 11789.233699809485, 11862.466189021514, 11978.041756659446, 11990.0, 3614.4397618369194, 4656.697314674535, 4673.042026384583, 4716.410448693913, 4732.621390288768, 7614.581198034161, 9099.954500227588, 9170.0, 9235.630574777068, 9241.353105282566, 5266.97366513165, 5282.102042652758, 5316.65441746293, 5317.680939143664, 5330.067238233293, 4497.865064048084, 4632.907341853144, 4826.831060912921, 4959.958408734206, 4963.6277279204205, 3831.5210598675167, 3854.69162467002, 3933.331333673282, 3939.2318497892634, 3953.2291203215095, 1183.627157445402, 1190.047961630692, 1191.4042978510745, 1194.4445832687843, 1194.9761004779855, 783.4554984285867, 874.5889431966965, 891.0599317719867, 898.8988489100799, 900.6532484993324, 5043.4956504349275, 5196.948030519722, 5207.9063396687125, 5660.433956604306, 5699.544036477072, 430.0517359222906, 447.8052047359409, 451.12256660795094, 452.6853836583609, 458.12040881507585, 3461.3077384523194, 3781.149241420713, 3827.119762454651, 3882.1847412043785, 3932.5477570079233, 10419.0, 10683.519241634145, 10838.295510791773, 10979.28634638746, 11041.558337666564, 10728.141748660088, 10783.191260655482, 10900.836487452694, 10914.72713182161, 10932.508037138348, 8143.51138931666, 8337.291330236998, 8470.407071505058, 8471.279941204943, 8471.364647651451, 5592.916106258491, 5660.85847853807, 5689.772409103755, 5744.3394009687745, 5747.827565173052, 10076.546555405172, 10122.089011988955, 10147.34042287249, 10301.021402966706, 10339.483025848827, 8627.91372086271, 10106.949465252921, 10187.643432479828, 10446.05985461312, 10476.476176191312, 6533.934660653523, 6741.393274605309, 6926.653667316513, 7103.538270012433, 7155.713771449292, 7690.0, 8301.875471867806, 8580.785480363042, 8591.484510929364, 8627.396082274181, 6183.628982261079, 6998.580085194904, 7306.96346518264, 7587.658555364911, 7690.346320562591, 6192.628442293297, 7272.745453909088, 7417.072865891763, 7499.737509187153, 7542.886856697044, 6990.755323563651, 7093.503454758324, 7113.0753002109395, 7164.713411463692, 7174.246704096204, 5137.023965446553, 5148.2020286855595, 5174.068667639711, 5181.792728290826, 5214.582833373245, 4328.177646247203, 5153.3815942087185, 5270.0, 5280.471952804689, 5288.4182739897815], "value": 4478.423930112316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.68657223343257, 299.99550006749894, 305.378554641305, 305.7874777029965, 311.377245508982, 5187.610929180308, 5401.757595752979, 5606.430199544124, 5617.269754931858, 5732.159453166373, 5265.657732247401, 5387.811426600069, 5460.0, 5539.753555450022, 5549.833504994856, 4199.412082308464, 4202.516710578277, 4215.451991241134, 4221.965618423491, 4251.128518653669, 3662.322470342982, 3804.7907365094907, 4082.632563069323, 4194.077302993336, 4248.553901840309, 3462.809545474998, 4152.626263636287, 4173.290540608089, 4185.037441388483, 4221.620054195122, 4175.0, 4181.205570941542, 4189.958100418988, 4207.431996680455, 4214.557471465513, 3654.8669912327264, 3666.7799932004164, 3675.9081022974374, 3681.5766186888313, 3700.148965737895, 4616.76916154191, 5066.225661881885, 5305.310309659758, 5308.840734777963, 5341.465853414627, 4003.399490076512, 4508.842190523349, 4783.579740485569, 4801.399825021872, 4805.567498925114, 5152.613553983429, 5197.636165468419, 5464.453554644543, 5768.711564421762, 5792.652440853562, 3179.9682003180133, 3873.4577159197734, 3894.337962546374, 3905.3556163233034, 3955.8417663293435, 6092.268927728701, 6160.722767475474, 6224.844378890564, 6269.962262264782, 6292.307846136967, 3223.16197788572, 3258.5438038674606, 3392.728581713457, 3474.965250347464, 4025.255327764373, 3371.3762953853616, 3916.6475017248586, 3977.747009691938, 3999.7000224983244, 4086.1623367210245, 4210.263203939298, 4718.4809670936165, 4733.834315798999, 4793.640476964241, 4823.879403014953, 5363.398751605546, 5882.3529411764675, 5897.852553686193, 5935.406459354116, 5951.256092988377, 1062.68119564132, 1339.397271227932, 1350.8716671916152, 1352.3643887372918, 1385.452746165259, 828.6561077152915, 842.5660784695887, 846.4413487098485, 889.0575989451203, 904.1907492793913, 4129.8967525811495, 4390.992170363312, 4810.39870016248, 4995.800167993312, 5002.574781143643, 5177.767000484987, 5900.7049647518315, 5905.261842269716, 5925.496332811673, 5952.613080149777, 4546.363509108727, 4804.663673542888, 5227.634065615446, 5535.280413546213, 5542.8337149884765, 2200.449887528118, 2381.8801266872497, 2462.150558057467, 2508.0186652544285, 2591.90928317508, 4318.12161709651, 4685.859424217211, 5004.449510553836, 5096.847094587169, 5218.6868787872845, 4596.3341262067925, 4615.076984603093, 4701.717896926195, 4797.18447863864, 4923.606111511071, 4516.3902873112365, 5100.821471248489, 5130.589552835764, 5134.383873935077, 5134.614903882299, 4213.852515161954, 4516.8193272268745, 4692.897169165175, 4999.575036121971, 5010.949890501194, 4140.44104045962, 4227.793345621127, 4368.344748287782, 4492.858389211478, 4788.95211047899, 4606.499060713814, 4627.352170696038, 4969.82605608802, 5204.382953847191, 5214.32213812202, 3357.52994580754, 3444.7244220461803, 3475.3396854597545, 3537.5047493351467, 3546.2907418515883, 4497.123061003073, 4693.521540714664, 4836.322914792002, 5013.1701928795, 5814.307914474255, 4961.0325986433745, 5314.760835762323, 5779.537636989115, 5799.8550036249435, 5804.796832110856, 5171.689698618095, 5798.217240672455, 5841.393616755427, 5873.823785286449, 5885.47030767233, 4814.542618451242, 5203.791848326025, 5632.352279487747, 5722.197507785035, 5779.612892905757, 5914.0, 5916.290045194604, 5962.672053037125, 5972.820815375546, 6015.879682406415, 4699.882502937454, 4975.039851288478, 5095.031943930641, 5654.830355089354, 5879.265091863517], "value": 3988.856559033375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.6698202317946, 755.0976582983334, 770.4799260499163, 778.4823092643393, 781.718581310728, 14903.925480372596, 15278.312475938581, 15664.060156390624, 15754.527364179079, 15959.281832317545, 14112.929435352835, 14119.788203176935, 14403.423863045491, 14420.206888621122, 14439.494617688357, 663.3797399431547, 684.8253695307715, 822.2106777493599, 851.7317045130764, 852.5524099847568, 667.883120453921, 705.9833839271432, 816.96732130715, 862.0991064337782, 864.8227113441761, 889.5418859287472, 897.5467388968594, 902.9006809250977, 903.7153296711548, 906.1708536688955, 889.1553024626598, 889.9822003559892, 896.0457113174481, 897.8383890899668, 899.2760827533833, 654.5908806995627, 661.9536632435731, 662.1193812229772, 662.1822049768532, 664.0935123556311, 14757.852421475862, 14892.404303827834, 14893.851061489464, 14911.0, 14922.776158357634, 14654.633634159125, 14687.70624587513, 14733.92633036828, 14769.852301476954, 14928.25358732059, 11607.071434285237, 11893.583724569598, 12048.397580120958, 12064.276143431422, 12418.875811241862, 3755.342815007363, 3785.337565925952, 3828.559715632682, 3854.653081222675, 3979.5423526294267, 92226.07773922243, 105662.0, 107648.4617576907, 108913.99999999921, 111392.0, 11076.778464430667, 11182.552697892155, 11348.978591926601, 11438.0, 11449.771004579861, 22287.331380058626, 22336.776632233796, 22408.327750167522, 22565.774342256696, 22826.201082962016, 7180.832563177659, 7342.779716608404, 7345.0, 7379.88930166048, 7550.735724249625, 3472.4270495368487, 4348.130373925164, 4478.39541661878, 4495.370648109268, 4554.749488778149, 3509.5262139611336, 3578.177019285579, 3606.6032736398975, 3632.3098611263777, 3638.4178531434845, 531.8856445864158, 586.1559354529464, 590.9333652756729, 595.407569468373, 599.1462166412845, 602.770947040122, 650.2034363648025, 660.1780782925289, 661.7452280871803, 694.7707256605308, 8236.258736713724, 9150.816983660423, 9259.583318750672, 9319.347645664873, 9387.5306234688, 556.8774869528778, 595.5622617376225, 637.6365471681097, 649.4804156674642, 665.4077870695086, 3524.3127590120193, 4312.892177695583, 4379.693421460467, 4546.477155127137, 4681.485036645966, 99742.0, 115310.0, 132229.0, 133180.3340983289, 171922.0, 144270.83593746103, 147165.26417367844, 150049.0, 154288.0, 157410.0, 93196.53401733084, 126723.0, 129683.70316296905, 131891.34054329668, 132473.0, 7411.446302703513, 7482.513636613603, 7631.69473221065, 9454.290928180277, 9538.85691714611, 44879.551204487536, 52734.736326318125, 54993.0, 57759.0, 58852.822943541745, 79981.20018799737, 83182.16817831986, 85111.5744421274, 87867.0, 90216.548917255, 12153.392330383622, 12159.452824622736, 12356.876431235933, 12425.565105221274, 12535.623931282076, 13141.734705012726, 13626.0, 13760.477965051756, 14112.223827689575, 14864.331105100513, 11509.928212921754, 11888.405579721153, 13306.866931330564, 13309.66725831862, 13784.517541885985, 13201.801972970605, 13247.403866825824, 13445.865541344461, 13483.46066157382, 13813.654658633615, 12584.18202816814, 12675.873241267838, 12912.483500659868, 13002.95976321873, 13229.867701322864, 11281.232856216451, 11453.885461145283, 11548.364839933884, 11836.881631183922, 11850.0, 10550.0, 11314.720330216809, 11566.595169169039, 11582.189246752647, 11635.709107272385], "value": 7668.498840137081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 133.0, 176.0, 179.0, 116.0, 119.0, 119.0, 119.0, 119.0, 115.0], "value": 128.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 115.0, 149.0, 110.0, 111.0, 115.0, 112.0, 138.0, 115.0], "value": 121.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 202.0, 197.0, 190.0, 195.0, 201.0, 197.0, 194.0, 195.0, 238.0], "value": 200.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 61.0, 64.0, 82.0, 61.0, 60.0, 84.0, 81.0, 98.0, 83.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 89.0, 71.0, 71.0, 81.0, 96.0, 65.0, 68.0, 94.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 91.0, 89.0, 91.0, 87.0, 92.0, 90.0, 91.0, 87.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 101.0, 103.0, 147.0, 118.0, 174.0, 164.0, 101.0, 109.0, 132.0], "value": 126.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 99.0, 88.0, 150.0, 160.0, 91.0, 90.0, 125.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 57.0, 59.0, 61.0, 60.0, 60.0, 61.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 71.0, 80.0, 76.0, 71.0, 72.0, 69.0, 74.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 90.0, 84.0, 84.0, 86.0, 86.0, 85.0, 84.0, 83.0, 87.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 140.0, 142.0, 142.0, 152.0, 160.0, 161.0, 173.0, 142.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 170.0, 200.0, 168.0, 167.0, 208.0, 181.0, 168.0, 165.0, 166.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 82.0, 68.0, 66.0, 70.0, 62.0, 64.0, 64.0], "value": 68.2, "unit": "score"}]}]} 03:47:11 INFO - Return code: 0 03:47:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:11 ERROR - # TBPL SUCCESS # 03:47:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:47:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:47:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:47:11 INFO - 2016-11-09 03:47:11.852 screenresolution[1701:11465] starting screenresolution argv=screenresolution get 03:47:11 INFO - 2016-11-09 03:47:11.855 screenresolution[1701:11465] Display 0: 1600x1200x32@60 03:47:11 INFO - 2016-11-09 03:47:11.861 screenresolution[1702:11467] starting screenresolution argv=screenresolution list 03:47:11 INFO - Available Modes on Display 0 03:47:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:47:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:47:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:47:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:47:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:47:12 INFO - Intel Iris: 03:47:12 INFO - Chipset Model: Intel Iris 03:47:12 INFO - Type: GPU 03:47:12 INFO - Bus: Built-In 03:47:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:47:12 INFO - Vendor: Intel (0x8086) 03:47:12 INFO - Device ID: 0x0a2e 03:47:12 INFO - Revision ID: 0x0009 03:47:12 INFO - Displays: 03:47:12 INFO - Display: 03:47:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:47:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:47:12 INFO - Display Serial Number: 1600x1200 60 03:47:12 INFO - Main Display: Yes 03:47:12 INFO - Mirror: Off 03:47:12 INFO - Online: Yes 03:47:12 INFO - Rotation: Supported 03:47:12 INFO - Return code: 0 03:47:12 INFO - Running post-action listener: _resource_record_post_action 03:47:12 INFO - [mozharness: 2016-11-09 11:47:12.095729Z] Finished run-tests step (success) 03:47:12 INFO - Running post-run listener: _resource_record_post_run 03:47:12 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 32242688; Write bytes: 670746624; Read time: 198; Write time: 2024 03:47:12 INFO - TinderboxPrint: CPU usage
54.3% 03:47:12 INFO - TinderboxPrint: I/O read bytes / time
32,242,688 / 198 03:47:12 INFO - TinderboxPrint: I/O write bytes / time
670,746,624 / 2,024 03:47:12 INFO - TinderboxPrint: CPU idle
2,206.5 (45.7%) 03:47:12 INFO - TinderboxPrint: CPU system
977.8 (20.2%) 03:47:12 INFO - TinderboxPrint: CPU user
1,645.4 (34.1%) 03:47:12 INFO - TinderboxPrint: Swap in / out
392,105,984 / 0 03:47:12 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356577792; Write bytes: 357170688; Read time: 27565; Write time: 773 03:47:12 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 31321088; Write bytes: 303417856; Read time: 188; Write time: 1215 03:47:12 INFO - Running post-run listener: _upload_blobber_files 03:47:12 INFO - Blob upload gear active. 03:47:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:12 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 03:47:12 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'] 03:47:12 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 03:47:12 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:14 INFO - (blobuploader) - INFO - Done attempting. 03:47:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:47:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:47:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:15 INFO - (blobuploader) - INFO - Done attempting. 03:47:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:17 INFO - (blobuploader) - INFO - Done attempting. 03:47:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:17 INFO - Return code: 0 03:47:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4f9c76e5437e8c529e834bd2452b5a438d6d9cf71e77e4ff1cd394102b3cc4cc9f5af90c84584aa48fe979a31a9ae9df0189fd773e28138945f65c14bd80a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8871a33eea14ad7e3cc4deef30d4cf6591f9757353faa8008f65579edf3a066ff9da82ed46f8fe40087a0f36aa821d2edb40134a50d38d7845b87f05ef5cb75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/904deeffa5f8f9b425c9f244ca44425fe5c28037991bf2ba948f0ec1b74eab00065654cb4ca2a1abc21fcb9d53335d8aca05bb1df5d4449fb71b70ded2db28d7"} 03:47:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:17 INFO - Contents: 03:47:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4f9c76e5437e8c529e834bd2452b5a438d6d9cf71e77e4ff1cd394102b3cc4cc9f5af90c84584aa48fe979a31a9ae9df0189fd773e28138945f65c14bd80a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8871a33eea14ad7e3cc4deef30d4cf6591f9757353faa8008f65579edf3a066ff9da82ed46f8fe40087a0f36aa821d2edb40134a50d38d7845b87f05ef5cb75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/904deeffa5f8f9b425c9f244ca44425fe5c28037991bf2ba948f0ec1b74eab00065654cb4ca2a1abc21fcb9d53335d8aca05bb1df5d4449fb71b70ded2db28d7"} 03:47:17 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:17 INFO - Copying logs to upload dir... 03:47:17 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.708449 ========= master_lag: 2.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-09 03:47:19.703115) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:19.706680) ========= 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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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/d4f9c76e5437e8c529e834bd2452b5a438d6d9cf71e77e4ff1cd394102b3cc4cc9f5af90c84584aa48fe979a31a9ae9df0189fd773e28138945f65c14bd80a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8871a33eea14ad7e3cc4deef30d4cf6591f9757353faa8008f65579edf3a066ff9da82ed46f8fe40087a0f36aa821d2edb40134a50d38d7845b87f05ef5cb75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/904deeffa5f8f9b425c9f244ca44425fe5c28037991bf2ba948f0ec1b74eab00065654cb4ca2a1abc21fcb9d53335d8aca05bb1df5d4449fb71b70ded2db28d7"} build_url:https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010866 build_url: 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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/d4f9c76e5437e8c529e834bd2452b5a438d6d9cf71e77e4ff1cd394102b3cc4cc9f5af90c84584aa48fe979a31a9ae9df0189fd773e28138945f65c14bd80a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8871a33eea14ad7e3cc4deef30d4cf6591f9757353faa8008f65579edf3a066ff9da82ed46f8fe40087a0f36aa821d2edb40134a50d38d7845b87f05ef5cb75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/904deeffa5f8f9b425c9f244ca44425fe5c28037991bf2ba948f0ec1b74eab00065654cb4ca2a1abc21fcb9d53335d8aca05bb1df5d4449fb71b70ded2db28d7"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:19.766386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:19.766663) ========= 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.IYSA9ve9r8/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.Z1Pgtze5Ks/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.004535 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:20.044988) ========= ========= Started reboot skipped (results: 3, elapsed: 16 secs) (at 2016-11-09 03:47:20.045261) ========= ========= Finished reboot skipped (results: 3, elapsed: 16 secs) (at 2016-11-09 03:47:36.651000) ========= ========= Total master_lag: 2.61 =========