builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0289 starttime: 1478690766.51 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.514066) ========= 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.514591) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.515611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.992028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.992273) ========= 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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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% 8.13M=0.001s 2016-11-09 03:26:07 (8.13 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.603599 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:07.626419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:07.626696) ========= 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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.019724 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:07.674739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 03:26:07.675040) ========= 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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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,760 truncating revision to first 12 chars 2016-11-09 03:26:07,760 Setting DEBUG logging. 2016-11-09 03:26:07,760 attempt 1/10 2016-11-09 03:26:07,760 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,608 unpacking tar archive at: mozilla-aurora-ae3b6bfb8104/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140814 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 03:26:08.853629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:08.853914) ========= script_repo_revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:08.854297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:08.858615) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:08.881028) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-11-09 03:26:08.881309) ========= /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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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-0289', 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.080635Z] 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:10 INFO - Running post-action listener: _resource_record_post_action 03:26:10 INFO - [mozharness: 2016-11-09 11:26:10.658637Z] Finished clobber step (success) 03:26:10 INFO - [mozharness: 2016-11-09 11:26:10.658783Z] Running read-buildbot-config step. 03:26:10 INFO - Running pre-action listener: _resource_record_pre_action 03:26:10 INFO - Running main action method: read_buildbot_config 03:26:10 INFO - Using buildbot properties: 03:26:10 INFO - { 03:26:10 INFO - "project": "", 03:26:10 INFO - "product": "firefox", 03:26:10 INFO - "script_repo_revision": "production", 03:26:10 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:26:10 INFO - "repository": "", 03:26:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:26:10 INFO - "buildid": "20161108173621", 03:26:10 INFO - "pgo_build": "False", 03:26:10 INFO - "basedir": "/builds/slave/test", 03:26:10 INFO - "buildnumber": 31, 03:26:10 INFO - "slavename": "t-yosemite-r7-0289", 03:26:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:26:10 INFO - "platform": "yosemite_r7", 03:26:10 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:26:10 INFO - "branch": "mozilla-aurora", 03:26:10 INFO - "repo_path": "releases/mozilla-aurora", 03:26:10 INFO - "revision": "ae3b6bfb810476141647ad681b796ed118062412", 03:26:10 INFO - "stage_platform": "macosx64", 03:26:10 INFO - "builduid": "083c302c289d4fffa60edb78cf695dbd", 03:26:10 INFO - "slavebuilddir": "test" 03:26:10 INFO - } 03:26:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:26:10 INFO - Running post-action listener: _resource_record_post_action 03:26:10 INFO - [mozharness: 2016-11-09 11:26:10.662157Z] Finished read-buildbot-config step (success) 03:26:10 INFO - [mozharness: 2016-11-09 11:26:10.662308Z] Running download-and-extract step. 03:26:10 INFO - Running pre-action listener: _resource_record_pre_action 03:26:10 INFO - Running main action method: download_and_extract 03:26:10 INFO - mkdir: /builds/slave/test/build/tests 03:26:10 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:10 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:26:10 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:10 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:11 INFO - Downloaded 1199 bytes. 03:26:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:26:11 INFO - Using the following test package requirements: 03:26:11 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:26:11 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:11 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:26:11 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:11 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:26:11 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:11 INFO - u'jsshell-mac.zip'], 03:26:11 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:11 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:26:11 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:26:11 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:11 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:26:11 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:11 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:26:11 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:11 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:26:11 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:11 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:26:11 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:26:11 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:11 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:11 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:19 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:26 INFO - Expected file size: 14414089 03:26:27 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:27 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:26:27 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:27 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:30 INFO - Downloaded 115464056 bytes. 03:26:30 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:30 INFO - mkdir: /builds/slave/test/properties 03:26:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:30 INFO - Contents: 03:26:30 INFO - build_url:https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:26:32 INFO - Running post-action listener: _resource_record_post_action 03:26:32 INFO - Running post-action listener: set_extra_try_arguments 03:26:32 INFO - [mozharness: 2016-11-09 11:26:32.117252Z] Finished download-and-extract step (success) 03:26:32 INFO - [mozharness: 2016-11-09 11:26:32.117370Z] Running populate-webroot step. 03:26:32 INFO - Running pre-action listener: _resource_record_pre_action 03:26:32 INFO - Running main action method: populate_webroot 03:26:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:32 INFO - '--tppagecycles', 03:26:32 INFO - '7'], 03:26:32 INFO - 'tests': ['tsvgm']}}, 03:26:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:32 INFO - 'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:32 INFO - 'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['damp', 'tps']}, 03:26:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:32 INFO - 'tests': ['damp', 'tps']}, 03:26:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['dromaeo_dom']}, 03:26:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['basic_compositor_video']}, 03:26:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:26:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['a11yr', 03:26:32 INFO - 'ts_paint', 03:26:32 INFO - 'tpaint', 03:26:32 INFO - 'sessionrestore', 03:26:32 INFO - 'sessionrestore_no_auto_restore', 03:26:32 INFO - 'tabpaint']}, 03:26:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:32 INFO - 'ts_paint', 03:26:32 INFO - 'tpaint', 03:26:32 INFO - 'sessionrestore', 03:26:32 INFO - 'sessionrestore_no_auto_restore', 03:26:32 INFO - 'tabpaint']}, 03:26:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:32 INFO - 'ts_paint', 03:26:32 INFO - 'tpaint', 03:26:32 INFO - 'sessionrestore', 03:26:32 INFO - 'sessionrestore_no_auto_restore', 03:26:32 INFO - 'tabpaint']}, 03:26:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:32 INFO - 'ts_paint', 03:26:32 INFO - 'tpaint', 03:26:32 INFO - 'sessionrestore', 03:26:32 INFO - 'sessionrestore_no_auto_restore', 03:26:32 INFO - 'tabpaint']}, 03:26:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['a11yr', 03:26:32 INFO - 'ts_paint', 03:26:32 INFO - 'tpaint', 03:26:32 INFO - 'sessionrestore', 03:26:32 INFO - 'sessionrestore_no_auto_restore', 03:26:32 INFO - 'tabpaint']}, 03:26:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['a11yr', 03:26:32 INFO - 'ts_paint', 03:26:32 INFO - 'tpaint', 03:26:32 INFO - 'sessionrestore', 03:26:32 INFO - 'sessionrestore_no_auto_restore', 03:26:32 INFO - 'tabpaint']}, 03:26:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['tsvgx', 03:26:32 INFO - 'tsvgr_opacity', 03:26:32 INFO - 'tart', 03:26:32 INFO - 'tscrollx', 03:26:32 INFO - 'cart']}, 03:26:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:32 INFO - 'tsvgr_opacity', 03:26:32 INFO - 'tart', 03:26:32 INFO - 'tscrollx', 03:26:32 INFO - 'cart']}, 03:26:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:32 INFO - 'talos_options': ['--disable-e10s'], 03:26:32 INFO - 'tests': ['tp5o']}, 03:26:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:32 INFO - 'tests': ['tp5o']}, 03:26:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:32 INFO - 'talos_options': ['--disable-e10s', 03:26:32 INFO - '--xperf_path', 03:26:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:32 INFO - 'tests': ['tp5n']}, 03:26:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:32 INFO - 'talos_options': ['--xperf_path', 03:26:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:32 INFO - 'tests': ['tp5n']}}, 03:26:32 INFO - 'talos.zip': {'path': '', 03:26:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:32 INFO - Running post-action listener: _resource_record_post_action 03:26:32 INFO - [mozharness: 2016-11-09 11:26:32.135781Z] Finished populate-webroot step (success) 03:26:32 INFO - [mozharness: 2016-11-09 11:26:32.135916Z] Running create-virtualenv step. 03:26:32 INFO - Running pre-action listener: _resource_record_pre_action 03:26:32 INFO - Running main action method: create_virtualenv 03:26:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:32 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:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:32 INFO - Using real prefix '/tools/python27' 03:26:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:35 INFO - Installing pip.................done. 03:26:35 INFO - Return code: 0 03:26:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:35 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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:35 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:35 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:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:26:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:35 INFO - 'HOME': '/Users/cltbld', 03:26:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:35 INFO - 'LOGNAME': 'cltbld', 03:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:35 INFO - 'MOZ_NO_REMOTE': '1', 03:26:35 INFO - 'NO_EM_RESTART': '1', 03:26:35 INFO - 'PAGER': '/bin/cat', 03:26:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:35 INFO - 'PWD': '/builds/slave/test', 03:26:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:35 INFO - 'SHELL': '/bin/bash', 03:26:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:26:35 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:26:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:35 INFO - 'USER': 'cltbld', 03:26:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:35 INFO - 'XPC_FLAGS': '0x0', 03:26:35 INFO - 'XPC_SERVICE_NAME': '0', 03:26:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:36 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:36 INFO - Cleaning up... 03:26:36 INFO - Return code: 0 03:26:36 INFO - Installing psutil>=3.1.1 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', '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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 03:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 03:26:36 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:36 INFO - Downloading/unpacking psutil>=3.1.1 03:26:36 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:36 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:36 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:36 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:36 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:36 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:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:39 INFO - Installing collected packages: psutil 03:26:39 INFO - Running setup.py install for psutil 03:26:40 INFO - building 'psutil._psutil_osx' extension 03:26:40 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:40 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:40 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:40 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:40 INFO - building 'psutil._psutil_posix' extension 03:26:40 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:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:26:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:26:40 INFO - ^ 03:26:40 INFO - 1 warning generated. 03:26:40 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:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:40 INFO - Successfully installed psutil 03:26:40 INFO - Cleaning up... 03:26:40 INFO - Return code: 0 03:26:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:40 INFO - 'HOME': '/Users/cltbld', 03:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:40 INFO - 'LOGNAME': 'cltbld', 03:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:40 INFO - 'MOZ_NO_REMOTE': '1', 03:26:40 INFO - 'NO_EM_RESTART': '1', 03:26:40 INFO - 'PAGER': '/bin/cat', 03:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:40 INFO - 'PWD': '/builds/slave/test', 03:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:40 INFO - 'SHELL': '/bin/bash', 03:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:26:40 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:40 INFO - 'USER': 'cltbld', 03:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:40 INFO - 'XPC_FLAGS': '0x0', 03:26:40 INFO - 'XPC_SERVICE_NAME': '0', 03:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:41 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:41 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:41 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:41 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:41 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:41 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:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:43 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:43 INFO - Installing collected packages: mozsystemmonitor 03:26:43 INFO - Running setup.py install for mozsystemmonitor 03:26:43 INFO - Successfully installed mozsystemmonitor 03:26:43 INFO - Cleaning up... 03:26:43 INFO - Return code: 0 03:26:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:43 INFO - 'HOME': '/Users/cltbld', 03:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:43 INFO - 'LOGNAME': 'cltbld', 03:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:43 INFO - 'MOZ_NO_REMOTE': '1', 03:26:43 INFO - 'NO_EM_RESTART': '1', 03:26:43 INFO - 'PAGER': '/bin/cat', 03:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:43 INFO - 'PWD': '/builds/slave/test', 03:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:43 INFO - 'SHELL': '/bin/bash', 03:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:26:43 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:43 INFO - 'USER': 'cltbld', 03:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:43 INFO - 'XPC_FLAGS': '0x0', 03:26:43 INFO - 'XPC_SERVICE_NAME': '0', 03:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:44 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:44 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:44 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:44 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:44 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:44 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:44 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:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:46 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:46 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:46 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:46 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:46 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:46 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:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:47 INFO - warning: no files found matching '*.txt' 03:26:47 INFO - no previously-included directories found matching 'build' 03:26:47 INFO - no previously-included directories found matching 'dist' 03:26:47 INFO - no previously-included directories found matching '.git*' 03:26:47 INFO - Installing collected packages: jsonschema, functools32 03:26:47 INFO - Running setup.py install for functools32 03:26:47 INFO - warning: no files found matching '*.txt' 03:26:47 INFO - no previously-included directories found matching 'build' 03:26:47 INFO - no previously-included directories found matching 'dist' 03:26:47 INFO - no previously-included directories found matching '.git*' 03:26:47 INFO - Successfully installed jsonschema functools32 03:26:47 INFO - Cleaning up... 03:26:47 INFO - Return code: 0 03:26:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:26:47 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:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 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:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:47 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:47 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:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:47 INFO - 'HOME': '/Users/cltbld', 03:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PAGER': '/bin/cat', 03:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:26:47 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - 'XPC_FLAGS': '0x0', 03:26:47 INFO - 'XPC_SERVICE_NAME': '0', 03:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:26:47 INFO - Cleaning up... 03:26:47 INFO - Return code: 0 03:26:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:47 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:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 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:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:47 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:47 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:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:47 INFO - 'HOME': '/Users/cltbld', 03:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PAGER': '/bin/cat', 03:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:26:47 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - 'XPC_FLAGS': '0x0', 03:26:47 INFO - 'XPC_SERVICE_NAME': '0', 03:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:51 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:51 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 - 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:51 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:51 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:51 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 docopt-0.6.1.tar.gz 03:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:51 INFO - Running setup.py install for blobuploader 03:26:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:51 INFO - Running setup.py install for requests 03:26:52 INFO - Running setup.py install for docopt 03:26:52 INFO - Successfully installed blobuploader requests docopt 03:26:52 INFO - Cleaning up... 03:26:52 INFO - Return code: 0 03:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:52 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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:52 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:52 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:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:52 INFO - 'HOME': '/Users/cltbld', 03:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:52 INFO - 'LOGNAME': 'cltbld', 03:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:52 INFO - 'MOZ_NO_REMOTE': '1', 03:26:52 INFO - 'NO_EM_RESTART': '1', 03:26:52 INFO - 'PAGER': '/bin/cat', 03:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:52 INFO - 'PWD': '/builds/slave/test', 03:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:52 INFO - 'SHELL': '/bin/bash', 03:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:26:52 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:52 INFO - 'USER': 'cltbld', 03:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:52 INFO - 'XPC_FLAGS': '0x0', 03:26:52 INFO - 'XPC_SERVICE_NAME': '0', 03:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:52 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-EoxNKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Ev8JSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-3QQqEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-H1ekka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-K2bWlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-F9yViB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-9kHcFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-HVKiFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-nPRwnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:53 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Er0y3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ELlIWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-s0kBn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-vfo8vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-hEKfff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Eg2w7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-1Ki2z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-6RpVyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:54 INFO - Running setup.py install for manifestparser 03:26:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:54 INFO - Running setup.py install for mozcrash 03:26:55 INFO - Running setup.py install for mozdebug 03:26:55 INFO - Running setup.py install for mozdevice 03:26:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozfile 03:26:55 INFO - Running setup.py install for mozhttpd 03:26:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozinfo 03:26:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozInstall 03:26:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozleak 03:26:56 INFO - Running setup.py install for mozlog 03:26:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Running setup.py install for moznetwork 03:26:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Running setup.py install for mozprocess 03:26:56 INFO - Running setup.py install for mozprofile 03:26:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Running setup.py install for mozrunner 03:26:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Running setup.py install for mozscreenshot 03:26:57 INFO - Running setup.py install for moztest 03:26:57 INFO - Running setup.py install for mozversion 03:26:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:57 INFO - Cleaning up... 03:26:57 INFO - Return code: 0 03:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:57 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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:57 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:57 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:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:57 INFO - 'HOME': '/Users/cltbld', 03:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:57 INFO - 'LOGNAME': 'cltbld', 03:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:57 INFO - 'MOZ_NO_REMOTE': '1', 03:26:57 INFO - 'NO_EM_RESTART': '1', 03:26:57 INFO - 'PAGER': '/bin/cat', 03:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:57 INFO - 'PWD': '/builds/slave/test', 03:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:57 INFO - 'SHELL': '/bin/bash', 03:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:26:57 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:57 INFO - 'USER': 'cltbld', 03:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:57 INFO - 'XPC_FLAGS': '0x0', 03:26:57 INFO - 'XPC_SERVICE_NAME': '0', 03:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:57 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-6Asr4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:57 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-epyTGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:57 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-8S7odr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:57 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-lUE_mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-bXDnqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-A8QYPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-sR4AK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-jQUpMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ZAqKRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:58 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:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-tSv76n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:58 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:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-fz8UHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:58 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:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-BL_nAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:58 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:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:58 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-pp06gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:58 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:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:59 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-QIlyWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:59 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:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:59 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-RUZc6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:59 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:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:59 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-TZgIiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:59 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:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:59 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-g_OPbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:59 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:26:59 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:26:59 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:26:59 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:26:59 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:26:59 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:26:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:59 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:59 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:59 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:59 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:59 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:59 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:01 INFO - Downloading blessings-1.6.tar.gz 03:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:02 INFO - Installing collected packages: blessings 03:27:02 INFO - Running setup.py install for blessings 03:27:02 INFO - Successfully installed blessings 03:27:02 INFO - Cleaning up... 03:27:02 INFO - Return code: 0 03:27:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:02 INFO - Reading from file tmpfile_stdout 03:27:02 INFO - Current package versions: 03:27:02 INFO - blessings == 1.6 03:27:02 INFO - blobuploader == 1.2.4 03:27:02 INFO - docopt == 0.6.1 03:27:02 INFO - functools32 == 3.2.3-2 03:27:02 INFO - jsonschema == 2.5.1 03:27:02 INFO - manifestparser == 1.1 03:27:02 INFO - mozInstall == 1.12 03:27:02 INFO - mozcrash == 0.17 03:27:02 INFO - mozdebug == 0.1 03:27:02 INFO - mozdevice == 0.48 03:27:02 INFO - mozfile == 1.2 03:27:02 INFO - mozhttpd == 0.7 03:27:02 INFO - mozinfo == 0.9 03:27:02 INFO - mozleak == 0.1 03:27:02 INFO - mozlog == 3.4 03:27:02 INFO - moznetwork == 0.27 03:27:02 INFO - mozprocess == 0.23 03:27:02 INFO - mozprofile == 0.28 03:27:02 INFO - mozrunner == 6.12 03:27:02 INFO - mozscreenshot == 0.1 03:27:02 INFO - mozsystemmonitor == 0.3 03:27:02 INFO - moztest == 0.7 03:27:02 INFO - mozversion == 1.4 03:27:02 INFO - psutil == 3.1.1 03:27:02 INFO - requests == 1.2.3 03:27:02 INFO - wsgiref == 0.1.2 03:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:02 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:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:02 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:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:02 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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:02 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:02 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:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:02 INFO - 'HOME': '/Users/cltbld', 03:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:02 INFO - 'LOGNAME': 'cltbld', 03:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:02 INFO - 'MOZ_NO_REMOTE': '1', 03:27:02 INFO - 'NO_EM_RESTART': '1', 03:27:02 INFO - 'PAGER': '/bin/cat', 03:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:02 INFO - 'PWD': '/builds/slave/test', 03:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:02 INFO - 'SHELL': '/bin/bash', 03:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:27:02 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:02 INFO - 'USER': 'cltbld', 03:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:02 INFO - 'XPC_FLAGS': '0x0', 03:27:02 INFO - 'XPC_SERVICE_NAME': '0', 03:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 INFO - Cleaning up... 03:27:02 INFO - Return code: 0 03:27:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:02 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:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:02 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:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:02 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 0x10872c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88434649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, '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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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:02 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:02 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:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:02 INFO - 'HOME': '/Users/cltbld', 03:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:02 INFO - 'LOGNAME': 'cltbld', 03:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:02 INFO - 'MOZ_NO_REMOTE': '1', 03:27:02 INFO - 'NO_EM_RESTART': '1', 03:27:02 INFO - 'PAGER': '/bin/cat', 03:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:02 INFO - 'PWD': '/builds/slave/test', 03:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:02 INFO - 'SHELL': '/bin/bash', 03:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:27:02 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:02 INFO - 'USER': 'cltbld', 03:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:02 INFO - 'XPC_FLAGS': '0x0', 03:27:02 INFO - 'XPC_SERVICE_NAME': '0', 03:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:03 INFO - Cleaning up... 03:27:03 INFO - Return code: 0 03:27:03 INFO - Running post-action listener: _resource_record_post_action 03:27:03 INFO - Running post-action listener: _start_resource_monitoring 03:27:03 INFO - Starting resource monitoring. 03:27:03 INFO - [mozharness: 2016-11-09 11:27:03.152985Z] Finished create-virtualenv step (success) 03:27:03 INFO - [mozharness: 2016-11-09 11:27:03.153944Z] Running install step. 03:27:03 INFO - Running pre-action listener: _resource_record_pre_action 03:27:03 INFO - Running main action method: install 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 - Detecting whether we're running mozinstall >=1.0... 03:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:03 INFO - Reading from file tmpfile_stdout 03:27:03 INFO - Output received: 03:27:03 INFO - Usage: mozinstall [options] installer 03:27:03 INFO - Options: 03:27:03 INFO - -h, --help show this help message and exit 03:27:03 INFO - -d DEST, --destination=DEST 03:27:03 INFO - Directory to install application into. [default: 03:27:03 INFO - "/builds/slave/test"] 03:27:03 INFO - --app=APP Application being installed. [default: firefox] 03:27:03 INFO - mkdir: /builds/slave/test/build/application 03:27:03 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:03 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:35 INFO - Reading from file tmpfile_stdout 03:27:35 INFO - Output received: 03:27:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:27:35 INFO - Running post-action listener: _resource_record_post_action 03:27:35 INFO - [mozharness: 2016-11-09 11:27:35.761103Z] Finished install step (success) 03:27:35 INFO - [mozharness: 2016-11-09 11:27:35.761258Z] Running run-tests step. 03:27:35 INFO - Running pre-action listener: _resource_record_pre_action 03:27:35 INFO - Running main action method: run_tests 03:27:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:35 INFO - 2016-11-09 03:27:35.775 screenresolution[1920:16262] starting screenresolution argv=screenresolution get 03:27:35 INFO - 2016-11-09 03:27:35.778 screenresolution[1920:16262] Display 0: 1600x1200x32@60 03:27:35 INFO - 2016-11-09 03:27:35.784 screenresolution[1921:16265] starting screenresolution argv=screenresolution list 03:27:35 INFO - Available Modes on Display 0 03:27:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:36 INFO - Intel Iris: 03:27:36 INFO - Chipset Model: Intel Iris 03:27:36 INFO - Type: GPU 03:27:36 INFO - Bus: Built-In 03:27:36 INFO - VRAM (Dynamic, Max): 1536 MB 03:27:36 INFO - Vendor: Intel (0x8086) 03:27:36 INFO - Device ID: 0x0a2e 03:27:36 INFO - Revision ID: 0x0009 03:27:36 INFO - Displays: 03:27:36 INFO - Display: 03:27:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:36 INFO - Display Serial Number: 1600x1200 60 03:27:36 INFO - Main Display: Yes 03:27:36 INFO - Mirror: Off 03:27:36 INFO - Online: Yes 03:27:36 INFO - Rotation: Supported 03:27:36 INFO - Return code: 0 03:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:36 INFO - Python 2.7.3 03:27:36 INFO - Return code: 0 03:27:36 INFO - grabbing minidump binary from tooltool 03:27: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:27:36 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 0x108540d30>, '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 0x1083a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108538b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:36 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:36 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:36 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:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:36 INFO - Return code: 0 03:27:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:27:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:27:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:36 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-0289', '--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:36 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-0289 --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:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubtj6IMOjZ/Render', 03:27:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:36 INFO - 'HOME': '/Users/cltbld', 03:27:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:36 INFO - 'LOGNAME': 'cltbld', 03:27:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:36 INFO - 'MOZ_NO_REMOTE': '1', 03:27:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:36 INFO - 'NO_EM_RESTART': '1', 03:27:36 INFO - 'PAGER': '/bin/cat', 03:27:36 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:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:36 INFO - 'PWD': '/builds/slave/test', 03:27:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:36 INFO - 'SHELL': '/bin/bash', 03:27:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PfUp6kV1pA/Listeners', 03:27:36 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:27:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:36 INFO - 'USER': 'cltbld', 03:27:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:36 INFO - 'XPC_FLAGS': '0x0', 03:27:36 INFO - 'XPC_SERVICE_NAME': '0', 03:27:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:36 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-0289', '--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:36 INFO - mozversion application_buildid: 20161108173621 03:27:36 INFO - mozversion application_changeset: ae3b6bfb810476141647ad681b796ed118062412 03:27:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:36 INFO - mozversion application_name: Firefox 03:27:36 INFO - mozversion application_remotingname: firefox-dev 03:27:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:36 INFO - mozversion application_vendor: Mozilla 03:27:36 INFO - mozversion application_version: 51.0a2 03:27:36 INFO - mozversion platform_buildid: 20161108173621 03:27:36 INFO - mozversion platform_changeset: ae3b6bfb810476141647ad681b796ed118062412 03:27:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:36 INFO - mozversion platform_version: 51.0a2 03:27:36 INFO - using testdate: 1478690856 03:27:36 INFO - actual date: 1478690856 03:27:36 INFO - starting webserver on 'localhost:49470' 03:27:36 INFO - SUITE-START | Running 2 tests 03:27:36 INFO - TEST-START | dromaeo_css 03:27:36 INFO - operating with platform_type : mac_ 03:27:36 INFO - Initialising browser for dromaeo_css test... 03:27:36 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmp5yugjt/profile http://localhost:49470/getInfo.html) 03:27:39 INFO - PROCESS | 1931 | __metrics Screen width/height:1600/1200 03:27:39 INFO - PROCESS | 1931 | colorDepth:24 03:27:39 INFO - PROCESS | 1931 | Browser inner width/height: 1024/689 03:27:39 INFO - PROCESS | 1931 | __metrics 03:27:39 ERROR - PROCESS | 1931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:27:39 INFO - TEST-INFO | 1931: exit 0 03:27:39 INFO - Browser initialized. 03:27:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:39 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmp5yugjt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:51 INFO - PROCESS | 1934 | RSS: Main: 225333248 03:27:51 INFO - PROCESS | 1934 | 03:28:41 INFO - PROCESS | 1934 | 1478690921502 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:53 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49470/tests/dromaeo/cssquery-ext.html) 03:30:55 INFO - PROCESS | 1934 | RSS: Main: 237068288 03:30:55 INFO - PROCESS | 1934 | 03:33:57 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-ext.html (next: http://localhost:49470/tests/dromaeo/cssquery-jquery.html) 03:33:57 INFO - PROCESS | 1934 | RSS: Main: 248074240 03:33:57 INFO - PROCESS | 1934 | 03:36:59 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49470/tests/dromaeo/cssquery-mootools.html) 03:37:00 INFO - PROCESS | 1934 | RSS: Main: 251641856 03:37:00 INFO - PROCESS | 1934 | 03:40:02 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49470/tests/dromaeo/cssquery-prototype.html) 03:40:02 INFO - PROCESS | 1934 | RSS: Main: 251949056 03:40:02 INFO - PROCESS | 1934 | 03:43:05 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49470/tests/dromaeo/cssquery-yui.html) 03:43:06 INFO - PROCESS | 1934 | RSS: Main: 256401408 03:43:06 INFO - PROCESS | 1934 | 03:46:08 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-yui.html (next: http://localhost:49470/tests/dromaeo/cssquery-dojo.html) 03:46:09 INFO - PROCESS | 1934 | RSS: Main: 258199552 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - PROCESS | 1934 | __start_tp_report 03:46:09 INFO - PROCESS | 1934 | _x_x_mozilla_page_load 03:46:09 INFO - PROCESS | 1934 | _x_x_mozilla_page_load_details 03:46:09 INFO - PROCESS | 1934 | |i|pagename|runs| 03:46:09 INFO - PROCESS | 1934 | |0;dojo.html;2923.9853800730993;3007.8044927079736;3431.6053653829817;3444.2594842108974;3450.8964731058077;5869.207656966309;5951.285845698522;5955.166276721263;5964.13520039594;6012.098185272206;4475.28395456727;5843.094320380348;5860.062390017598;5868.76524939003;5951.404859514047;5301.5228629423345;5350.545203657674;5355.9196612050655;5381.757820898049;5391.973040134794;5407;5420.376656684492;5423.755930983096;5433.347998240217;5458.153986132136;5285.920711189336;5304.655197412175;5390.811321603745;5400.540954018913;5407.594430417715;5283.365996080456;5308.601854860882;5323.627346085776;5396.082665946759;5428.267183930158;5174.586033117342;5307.761150748187;5312.814051508179;5339.41266460689;5381.300430943991;5817.7382017809305;5838.795642152504;5872.901822246186;5938.079597662369;5998.6100903441575;6081.087836824468;6180.783672571483;6188.195534580521;6247.281562620311;6256.562040657156;6353.587016843937;6356.173697419352;6362.427381535684;6373.3945275198785;6382.8723425531225;6053;6054.939450605481;6073.1497590337385;6076.936536106164;6077.088436734525;6181.258249010148;6281.497480201573;6287.182666253358;6323.019931910561;6431.13179720741;4953.8018479261145;6210.72051757672;6247.750089996349;6250.562460627803;6266.811995640138;6253;6328.240611126695;6351.396617321347;6355.205599300088;6427.389398007182;6142;6170.50635949123;6180.072989051679;6201.968990155111;6214.067889816473;5227.947720522746;5261.842144735664;6152.446279834837;6191.226096737908;6209.720562574695;5004.624653150955;5013.373328333958;5018.272350509155;5044.369453818273;5062.316587260672;4404.757738324359;4451.732896026248;4525.321201819687;4529.230030894756;4532.79602417892;5410.48600382963;5896.056630939029;6004.279486461565;6138.554517756338;6146.508279337642;6284.685765711696;6349.8730025400155;6359;6359.841003974845;6381.1066450696935;5998.4601385875485;6061.090836374491;6071.51427885768;6071.574989750763;6086.421789929949;5538;5562.610617256834;5565.1095824667855;5574.386817450078;5596.104623260258;6473.158489396348;6500.739970401131;6503.6097834130105;6520.282768895323;6521.869562608721;5014.974925125497;6012.939870601238;6221.657808820558;6230;6341.746330146742;6311.305756366704;6479.8056058318325;6480.7731729391135;6491.610503369813;6549.934500654933;5226.372835259641;6230.813075607739;6233.937660623335;6249.0626406039455;6257.1552840367785;6195.783147589813;6198.566100372931;6341.682915854281;6346.873062538816;6348.428641422294;6147.508199343953;6162.784302549389;6202.596831205957;6241.719122639402;6252.9062064069985;5511.586631002771;6202.875942481035;6239.126522286792;6250.812475625738;6250.968745156245;5230.398504172069;5993.0710739835395;6003.609765365237;6131.264248290234;6202.41077097675;6151.354107818794;6158.568900176944;6185.690715464299;6208.441240288395;6245.250569931455;6204.348543403058;6205.503559715122;6205.565610407228;6212.596181248205;6241.625502469867 03:46:09 INFO - PROCESS | 1934 | |1;ext.html;478.5262590035866;490.74726515844344;504.61986467012713;519.9896002079956;529.7642549065666;36170.457443138344;39997.20005599886;40072;41471;41539.58460415395;40916;41390.96522586937;41445;41467.79266103673;41496.58503414965;9684.370515916478;9878.061584149495;9891.703248902544;9895.406275623485;9912.355696879717;8221.671133154667;9829.262805289596;9859.852102218472;9860.60557577696;9873.210143188528;9757.316987810857;9852.408855468659;9855.655052073178;9863.063009014133;9876.654317098903;8189.79525511864;9822.116009559173;9831.31180817343;9832;9877.259205559612;9731.41611503312;9806.803863922682;9810;9843.261755368305;9866.753331166707;39393.60606393928;39853.20293594141;39872.40510379581;40099.59900401017;40158.196836063114;3240.22234663679;3383.272596391763;3537.6816086552335;3757.2861156380472;3762.5484941806885;25532.978680852742;27336;30563.38873222523;30810;30891.536626950612;3094.0408473373327;3152.8738850445957;3163.9050828475183;3193.2815116598813;3195.3130077033547;409836;491838;498933;499121;501127;33069;59417.70291148603;59669.403305966385;59856.70071649614;59881.70059149677;34406.31187376239;35404.468932966025;35698.821505892825;35733;35779.4633080504;14406.207658578878;14531.491397801237;14536.63658408527;14561.563153105424;14613.19627420502;12114.091443141624;12221.633350999484;12285.631431057083;12295.200811947196;12321.876781232253;7685.846283074307;7827.6477558510005;7847;7898.210178982171;7920.643571039317;3221.3235220603938;3244.270039241152;3263.2983908459796;3271.6237632672073;3294.159989202738;890.3011136258007;949.4350861237552;955.0926619711302;1007.9143272821746;1045.7594753206804;26011;29539.556906646416;30553.388932221675;30770.38459230803;30958.22604434907;1055.9704288318828;1060.2207377577474;1071.0681706915034;1136.7101389145714;1182.7102359921873;13821.654458638615;15717.292721827545;15734.291956861969;15861.603459913364;15990.36038558468;710955;721901;727151;730981.690183102;741766;57174;57495.850082998106;57510.71244643834;57533.13700294499;57613.423865761644;1167.3346192670267;1171.6367925942984;1189.6787867275787;1352.4319785690034;1395.0513650717407;29382.943193977073;29892.55161172541;30147.69852301449;30484.542731858597;30620.060457264546;50128.749356252985;50265.74867125641;50356.49643503664;50423.49576504188;50501.242481363544;630993.6900630934;631084;631283;632940;635520;26704.8664756675;26897.596536051584;27009.784559694468;27066.45867082608;27169.72830271751;45981.080378392915;46283.53716462792;46682.53317466917;47481.52518474771;47933.76033119812;37482.250354993295;38525.80737096297;39130.6086939127;39360;40174;38219;38707.6129238704;38871.40198756785;39272;39387;37362.06594835151;38146;38216;38333;39875.60124398835;32576;34698.306033878674;35256;35437.29125417529;35511.82244088763;25904.22287331383;26171;26188.73811261863;26220.344491387106;26696.332591685365 03:46:09 INFO - PROCESS | 1934 | |2;jquery.html;366.10669965284706;372.72045965525854;375.40685716567816;381.14433097695644;396.952046596984;18933.242670293188;20247.696284555706;20463.897680511596;20512.76923384598;20697.275595354167;15653.765193522106;17937.820621793777;18019.09904504773;18633.627327453443;19067.71398429021;4381;4803.975980120112;4899.706017638944;4938.925916111243;5580.469855363734;5004.349434573501;5211.5309622134;6209.099680546318;6216.844578885519;6302.842428939291;5444.50999410053;5534.584906132036;5558.583106267026;6249;6258.249010118792;5521.116621340586;5552.3892371839065;5559.19391688207;5572.331320241597;5585.078462053756;4498.595126438636;5415.593830462692;5431.375391829911;5431.8098866539485;5474.151506516497;13030.80453793194;13057.151285166434;13118.147320424237;13128.409221585052;13243.933780331037;2133.328001679466;2313.294445194232;2581.3933725574475;2670;2942.7204415580486;8341.332693384515;9853.753656158582;9917;10029.648962286357;10411.479426028669;1806.8825526340745;1873.8500919926373;1919.280269898788;1922.1542521290587;1933.5649478867283;122814.99999999911;123274;123999;125660;125787.37106314501;11360.318380897173;11375.715607109889;11593.76812463746;11635.941820290844;12082.093842961813;14484.420623174956;14545;14574.417023318949;14583.416663333348;14603.707925841636;8222.753317400488;8454.661813527513;8468.745937621881;8551.273141782895;8569.571521424028;8272.875906861402;8297.668093276323;8327.292180164633;8456.788580285542;8531.872021919551;4467.084247729208;4502.594766470967;4503.347014682852;4517.254652982287;4568.70303430276;1630.9429169978994;1902.7526421565108;1914.961700765977;1958.2950137950327;1958.9216431342873;849.2442025626881;911.2755359489222;923.3628796130782;924.4499522783933;997.4115271989416;21107.366778996653;21420.892895535424;21493.892530537247;21700.891495542422;21769.891150544147;940.2431043010442;943.6084025129632;949.8337790886706;966.5843687214565;1024.3034736379184;10738;11270.718232044264;11368.545258189744;11413.828792568118;11416.257943233662;565755.9597245981;589933;615369;619919.9004004952;623311;78373.60813195897;85287;102687;142794;146245;965.3194497878978;981.7790997025612;985.1183191043975;989.0258095775655;989.1443901025561;18535.44393668192;19164.8083519163;19346.903265483583;19433.222671092997;19573.02134893278;42314.307427702544;48522.27216591824;50491;56309.71845140748;59959;82474.58762706148;83292.16707832844;84803.87990300292;85704.57147714222;88412;8136.22705842944;8140.674373025249;8437;8602.569871506525;8605.225529702357;10630.415327157081;12926.935365323114;13045.608631741063;13537.864621353661;13631.386587603383;11025.889741102486;11161.218714689894;11182.384968826793;11569.710757231136;11685.591004314809;10994.670159895217;11073.889261107286;11363.034142098015;11474.598389056677;11768.52925882955;10966.122710183006;11223.933726295989;11475.540978360772;11786.823197652213;11960.282383057045;8048.678052877819;8068.515889046676;8094.51432914027;8440.451370660887;8489.235968762841;8308.459950103224;10352.482375881327;11486.655400338002;11500.309981401142;11813.940930295294 03:46:09 INFO - PROCESS | 1934 | |3;mootools.html;1515.568063102016;1531.058399084563;1738.6783445062665;1808.6834803909312;1845.510939601006;8220.054693710224;8466.068732439428;8705.912940870588;9349.953250233748;9364.250859931206;8300.335973122152;9036.006039335667;9053.45679259245;9178.495182764946;9186.862197067032;1986.7516560429947;2272.7954484096426;2362.775536324051;2389.5340408620327;2391.784739373456;2341.8243631727605;2345.2377977157407;2366.2546297916188;2392.83250172488;2395.9760402395927;2362.137819695807;2369.6327069304284;2376.1327115602767;2377.8097752179783;2378.0606660369144;2326.255598208574;2342.203650758742;2355.187460326185;2358.3160883343808;2361.901715702198;2360.775726305998;2361.645753137026;2363.137454828975;2365.3731761083327;2370.573296806574;9077.818443631091;9131.726048218565;9168.404053736485;9223.077692230723;9236.769080772967;5149.716765577892;5172.094883395391;5252.159654455307;5380.919286210671;5383.084875571162;3528.1708798432346;3605.8918232452806;3625.166211771281;3681.576618688858;3684;1057.3919996002253;1075.2795626929976;1092.4865313302735;1099.5766629847567;1104.0284549596383;12182.756344873142;12183.573574924834;12245.448954796966;12292.201006934522;12312.569060082855;4724.551167639069;4788.090262850117;4796.471103676271;4905.337779399807;4937.876553086202;10167.593296268215;10335.22485813567;10337;10343.896561034293;10351.534180961875;5298.569386265764;5366.060939335601;5376.1129413647095;5380.488853558905;5393.352797664227;4328.069465065026;4556.954430455653;4833.951660483421;4844.103840789465;4881.487443818348;3991.501062367204;4044.3529035354204;4087.7751723655483;4095.447114639545;4158.272302347077;1327.0710502648185;1330.4877622115362;1336.4453751693134;1338.3241463061092;1345.784674452083;828.1801016993254;838.3502785341409;887.8668199770086;907.9966636866168;940.8541676040225;6020.909686354708;6022.728977196037;6045.637261764308;6078.574499784972;6264.718087686065;761.6077719974218;889.2663552569156;889.6975028490215;907.3920473282916;925.7639301977953;3854.9421758673643;4019.8392064317686;4032.495938007749;4069.8168582413864;4135.834566617302;9282.907170928203;10362.740931476623;11175.497102630401;11193.552257909756;11247.156463265288;10591.258611897247;10871.619493317854;11147.442627868573;11163.441827908571;11176.552937882394;6467.773627923;8367.832643347221;8386.329093672492;8424.62089205975;8426.325893928593;5853.619514731528;5904.173415721888;5972.611780234271;6020.969895150496;6040.546958978182;9931.801363972825;10237.74405639865;10312.27814053009;10433.582656693647;10538.473076346305;10526.684199474028;10559.841602376124;10640.148788096778;10643.574257029632;10648.148148147975;6681.33186681328;6888.896666550106;7031.753888613874;7199.2440793715905;7340.596267205141;8336.62485188156;8501.404901656824;8610.612522436631;8618.750281209315;8630.266427353745;7585.6965721370525;7661.693532258647;7722.034745656793;7786.221377862168;7848.372130229453;7450.8882366763455;7529.849403012018;7582.469227154046;7641.159472457914;7730.647136750934;6855.760048398282;7001.439884809101;7018.192907815463;7021.754238601625;7022.473314501331;4321.7839108043845;5012.724300163526;5069.138246498031;5084.2627818966785;5116.155834287301;5014.771381011676;5076.390833100052;5076.60167130928;5248.396434410091;5337.119375303031 03:46:09 INFO - PROCESS | 1934 | |4;prototype.html;298.8475877302575;299.8665593810754;308.92585779412934;309.9302656902196;310.5729621770066;4495.707778994371;4819.542143496366;5374.274472946151;5476.78092876285;5624.915626265604;4592.770361481929;5020.698758074518;5249.448807875176;5448.346198456181;5472.20653005314;4141.834326626931;4175.832966681329;4179.937300940481;4181.435506206653;4224.260754367989;3908.257431088098;4149.709520333563;4181.916361672765;4204.747715137086;4209.779164042424;3571.910702232439;4060.533038700543;4128.401381799637;4144.399062135988;4147.5645057269;3743.251349730051;3822.719389004673;4120.5989963412585;4153.605407486284;4158.792060396968;2977.6426828780686;3390.55922730046;3581.212133330663;3585.6772890439984;3586.569611646593;4607.378003969455;4853.005133947532;4898.975505122487;5010.974945125287;5302.814401495929;3758.699304055669;4002.079521710023;4739.748619405789;4756.217612696577;4818.614510839125;4231.767252801094;4811.501246334653;5822.796202132948;5845.561582881301;5925.288965324189;3011.1869795155403;3729.757565758217;3824.737836513944;3909.1853865217;3956.7823769692654;5965.5525835562075;5988.341017738239;6032.547558933054;6034.637921724667;6174.197354343952;3364.4280472319765;4023.2355852387955;4024.1750441159493;4032.475778148822;4035.2131334389514;3871.5160604924386;3999.280129576704;4037.7577345359373;4060.939085913714;4102.528209255914;4269.167512335127;4585.977070114628;4709.246520556763;4732.692374995614;4748.406449193851;5370.409254981949;5524.4199359067525;5894.7915677286055;5908.350081491032;5938.940610593839;1206.7526157137765;1293.5447621425897;1319.4524272426836;1333.1068184316532;1336.2850874782139;820.2125959079232;897.5736525150631;912.2291663544295;916.1662886773005;923.2244914272044;4282.443282373334;5411.323584551931;5439.3200849893765;5439.945600544023;5467.234587157801;5504.605496608988;5709.457601527848;5937.198478205387;5947.37552556984;5963.940360596425;5130.538251557303;5219.791208351699;5413.783448662089;5469.835904922858;5470.617056805985;2895.7828162887868;3123.7969531980348;3179.920501987469;3190.3619276144864;3190.8564114614896;6227.532935029891;6252.624842509464;6278.591891527128;6297.716602752887;6356.410897275681;5164.431912489623;5633.3944825724475;5855.795047173328;6253.437190652863;6310.9368906311265;5390.649607775482;6352.744775604779;6368.490520758328;6373.298937116913;6391.520635952322;5740.856478588069;6098.176746139392;6111.327753946974;6134.693265336626;6187.051078910129;4838;5431.375391829832;6079.540910181436;6149.169862068564;6174.536909731698;5053.545180933586;6188.031644471004;6392.169018027626;6411.96794016027;6419.775307864203;3481.2863363010015;3891.8248678810087;4020.819063142107;4046.4537287465814;4048.805602347256;5874;5877.324107727666;5989.101634754822;6039.701464185221;6194.225721784777;4713.740744259098;4923.793670550738;5094.974525127351;5722.885542289047;5926.851828704144;5922.851928701817;5956.910646340395;5966.582339236212;5969.164316995537;5972.3859572002175;4800.279958006187;5100.668456550312;5491.395946445968;5735.311762588516;5781.398370733103;5897.292324921037;5903.144044113494;5943.910841337297;5947;5980.372060933713;4784.497627749036;4808.567228949411;5768.653880767168;5802.564807639359;5825.70871456434 03:46:09 INFO - PROCESS | 1934 | |5;yui.html;755.8979537762403;755.9773206803798;782.7651704488653;803.1286054630725;814.7026335387584;14900.701985960275;15381.769273460906;15403.152826594533;15510.302036408375;15594.06435613864;13840.723185536282;13901;13913;13917.443302267922;13934.233617151052;818.5211651184064;827.7020272701823;856.824351008045;861.4745005546612;868.8870446841902;833.1668331668332;841.7558907916728;842.3934766967774;843.0431460292551;843.9535825529593;891.4205766251923;892.2950868813662;893.2898345815092;897.6185121323444;897.7935074932736;875.5184648443394;889.9110088991114;891.0821853490914;891.79488717595;896.6010125494158;624.6533174088379;638.2819328255713;658.2528829778188;658.6311665467354;660.085781193051;15141.318640661086;15186;15266.542003739905;15310.157941313224;15327.770083448757;13865.653358666013;13888;13998.230097344642;14098;14221.644458888508;11356;11623.07015438763;11723.531058757639;11851.40742962857;11880.762384752343;3705.40713485841;3778.5087938568086;3806.8667596634264;3877.5734669186368;3882.107115363454;90580;115044;115702.42148789202;119545;121143;8583.828323433496;10304.332617060587;10458.895411045944;10866.728331791768;11090.500927458123;20759.58480830405;20794.792052079287;21033.474163145736;21071.20894723935;21086.945652717302;6545.738170473128;6748.190217173872;6884.552504087218;7984.121746607869;8020.5588692621295;4370.868873933787;4457.64338852891;4482.7758612069265;4513.413256276663;4545.340925565774;3402.4896265560365;3498.772579782306;3518.2787528557096;3522.471629255581;3522.735794815399;545.4027839515724;557.3200695151908;563.7942151114813;591.5947575910515;641.7721708793312;561.6770357044716;577.2322810661893;591.5829340315067;608.8843119807223;634.8825467288474;8412;8571.057183709787;8581.227689507974;8590.303973813963;8827.823443531093;542.1271752478507;550.7521615273143;559.3679142568952;606.4026933470528;613.1967123068794;3892.8637497687446;4071.0229544909007;4176.477940257468;4416.359627854007;4526.072155208174;88040;114723;134802;137221;141073.29463352618;115562;116656;117029;126884.36557817152;127418.36290818486;91142.08857911469;108737.45631271793;111876;111982;113151.86848131577;9100.59047342858;9437.103475169848;9512.904870951203;9517.666881659386;9531.857022144812;59779.70110149596;65221;65829.67085164544;67453;67858;61243.693781530805;65360.34639653733;71170.28829711844;88285;93904;12271.07966902468;12431.067669924973;12491.812622810847;12834.614961551168;13025.739485210432;14003.299835008413;14649.633759156106;14753.041052331564;15376.692466150838;15483.5354939352;13158.60524184276;13263;13351.532696355582;13763.587092386844;13824.792628110788;12676.936615316865;12685.619431417072;13081.738365232452;13108.885744711424;13555.932220338835;12853.228806271654;13245.337733113498;13263.602091937257;13591.592252232449;13826.792598110835;11055.83416248773;11073.390963497084;11166.1067114629;11306.717332066764;11666.949974502335;10993.725156871142;11076.538903642915;11181.440927953407;11194.552217911192;11240.494177762184 03:46:09 INFO - PROCESS | 1934 | __end_tp_report 03:46:09 INFO - PROCESS | 1934 | __start_cc_report 03:46:09 INFO - PROCESS | 1934 | _x_x_mozilla_cycle_collect,376 03:46:09 INFO - PROCESS | 1934 | __end_cc_report 03:46:09 INFO - PROCESS | 1934 | __startTimestamp1478691969229__endTimestamp 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - PROCESS | 1934 | ------- Summary: start ------- 03:46:09 INFO - PROCESS | 1934 | Number of tests: 6 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - PROCESS | 1934 | [#0] dojo.html Cycles:165 Average:5818.37 Median:6081.09 stddev:675.76 (11.1%) stddev-sans-first:638.55 03:46:09 INFO - PROCESS | 1934 | Values: 2924.0 3007.8 3431.6 3444.3 3450.9 5869.2 5951.3 5955.2 5964.1 6012.1 4475.3 5843.1 5860.1 5868.8 5951.4 5301.5 5350.5 5355.9 5381.8 5392.0 5407.0 5420.4 5423.8 5433.3 5458.2 5285.9 5304.7 5390.8 5400.5 5407.6 5283.4 5308.6 5323.6 5396.1 5428.3 5174.6 5307.8 5312.8 5339.4 5381.3 5817.7 5838.8 5872.9 5938.1 5998.6 6081.1 6180.8 6188.2 6247.3 6256.6 6353.6 6356.2 6362.4 6373.4 6382.9 6053.0 6054.9 6073.1 6076.9 6077.1 6181.3 6281.5 6287.2 6323.0 6431.1 4953.8 6210.7 6247.8 6250.6 6266.8 6253.0 6328.2 6351.4 6355.2 6427.4 6142.0 6170.5 6180.1 6202.0 6214.1 5227.9 5261.8 6152.4 6191.2 6209.7 5004.6 5013.4 5018.3 5044.4 5062.3 4404.8 4451.7 4525.3 4529.2 4532.8 5410.5 5896.1 6004.3 6138.6 6146.5 6284.7 6349.9 6359.0 6359.8 6381.1 5998.5 6061.1 6071.5 6071.6 6086.4 5538.0 5562.6 5565.1 5574.4 5596.1 6473.2 6500.7 6503.6 6520.3 6521.9 5015.0 6012.9 6221.7 6230.0 6341.7 6311.3 6479.8 6480.8 6491.6 6549.9 5226.4 6230.8 6233.9 6249.1 6257.2 6195.8 6198.6 6341.7 6346.9 6348.4 6147.5 6162.8 6202.6 6241.7 6252.9 5511.6 6202.9 6239.1 6250.8 6251.0 5230.4 5993.1 6003.6 6131.3 6202.4 6151.4 6158.6 6185.7 6208.4 6245.3 6204.3 6205.5 6205.6 6212.6 6241.6 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - PROCESS | 1934 | [#1] ext.html Cycles:180 Average:72494.25 Median:39373.50 stddev:167019.42 (424.2%) stddev-sans-first:167400.43 03:46:09 INFO - PROCESS | 1934 | Values: 478.5 490.7 504.6 520.0 529.8 36170.5 39997.2 40072.0 41471.0 41539.6 40916.0 41391.0 41445.0 41467.8 41496.6 9684.4 9878.1 9891.7 9895.4 9912.4 8221.7 9829.3 9859.9 9860.6 9873.2 9757.3 9852.4 9855.7 9863.1 9876.7 8189.8 9822.1 9831.3 9832.0 9877.3 9731.4 9806.8 9810.0 9843.3 9866.8 39393.6 39853.2 39872.4 40099.6 40158.2 3240.2 3383.3 3537.7 3757.3 3762.5 25533.0 27336.0 30563.4 30810.0 30891.5 3094.0 3152.9 3163.9 3193.3 3195.3 409836.0 491838.0 498933.0 499121.0 501127.0 33069.0 59417.7 59669.4 59856.7 59881.7 34406.3 35404.5 35698.8 35733.0 35779.5 14406.2 14531.5 14536.6 14561.6 14613.2 12114.1 12221.6 12285.6 12295.2 12321.9 7685.8 7827.6 7847.0 7898.2 7920.6 3221.3 3244.3 3263.3 3271.6 3294.2 890.3 949.4 955.1 1007.9 1045.8 26011.0 29539.6 30553.4 30770.4 30958.2 1056.0 1060.2 1071.1 1136.7 1182.7 13821.7 15717.3 15734.3 15861.6 15990.4 710955.0 721901.0 727151.0 730981.7 741766.0 57174.0 57495.9 57510.7 57533.1 57613.4 1167.3 1171.6 1189.7 1352.4 1395.1 29382.9 29892.6 30147.7 30484.5 30620.1 50128.7 50265.7 50356.5 50423.5 50501.2 630993.7 631084.0 631283.0 632940.0 635520.0 26704.9 26897.6 27009.8 27066.5 27169.7 45981.1 46283.5 46682.5 47481.5 47933.8 37482.3 38525.8 39130.6 39360.0 40174.0 38219.0 38707.6 38871.4 39272.0 39387.0 37362.1 38146.0 38216.0 38333.0 39875.6 32576.0 34698.3 35256.0 35437.3 35511.8 25904.2 26171.0 26188.7 26220.3 26696.3 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - PROCESS | 1934 | [#2] jquery.html Cycles:180 Average:34613.54 Median:369.41 stddev:100659.17 (27248.4%) stddev-sans-first:100908.70 03:46:09 INFO - PROCESS | 1934 | Values: 366.1 372.7 375.4 381.1 397.0 18933.2 20247.7 20463.9 20512.8 20697.3 15653.8 17937.8 18019.1 18633.6 19067.7 4381.0 4804.0 4899.7 4938.9 5580.5 5004.3 5211.5 6209.1 6216.8 6302.8 5444.5 5534.6 5558.6 6249.0 6258.2 5521.1 5552.4 5559.2 5572.3 5585.1 4498.6 5415.6 5431.4 5431.8 5474.2 13030.8 13057.2 13118.1 13128.4 13243.9 2133.3 2313.3 2581.4 2670.0 2942.7 8341.3 9853.8 9917.0 10029.6 10411.5 1806.9 1873.9 1919.3 1922.2 1933.6 122815.0 123274.0 123999.0 125660.0 125787.4 11360.3 11375.7 11593.8 11635.9 12082.1 14484.4 14545.0 14574.4 14583.4 14603.7 8222.8 8454.7 8468.7 8551.3 8569.6 8272.9 8297.7 8327.3 8456.8 8531.9 4467.1 4502.6 4503.3 4517.3 4568.7 1630.9 1902.8 1915.0 1958.3 1958.9 849.2 911.3 923.4 924.4 997.4 21107.4 21420.9 21493.9 21700.9 21769.9 940.2 943.6 949.8 966.6 1024.3 10738.0 11270.7 11368.5 11413.8 11416.3 565756.0 589933.0 615369.0 619919.9 623311.0 78373.6 85287.0 102687.0 142794.0 146245.0 965.3 981.8 985.1 989.0 989.1 18535.4 19164.8 19346.9 19433.2 19573.0 42314.3 48522.3 50491.0 56309.7 59959.0 82474.6 83292.2 84803.9 85704.6 88412.0 8136.2 8140.7 8437.0 8602.6 8605.2 10630.4 12926.9 13045.6 13537.9 13631.4 11025.9 11161.2 11182.4 11569.7 11685.6 10994.7 11073.9 11363.0 11474.6 11768.5 10966.1 11223.9 11475.5 11786.8 11960.3 8048.7 8068.5 8094.5 8440.5 8489.2 8308.5 10352.5 11486.7 11500.3 11813.9 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - PROCESS | 1934 | [#3] mootools.html Cycles:180 Average:5819.17 Median:4862.80 stddev:3309.22 (68.1%) stddev-sans-first:3302.70 03:46:09 INFO - PROCESS | 1934 | Values: 1515.6 1531.1 1738.7 1808.7 1845.5 8220.1 8466.1 8705.9 9350.0 9364.3 8300.3 9036.0 9053.5 9178.5 9186.9 1986.8 2272.8 2362.8 2389.5 2391.8 2341.8 2345.2 2366.3 2392.8 2396.0 2362.1 2369.6 2376.1 2377.8 2378.1 2326.3 2342.2 2355.2 2358.3 2361.9 2360.8 2361.6 2363.1 2365.4 2370.6 9077.8 9131.7 9168.4 9223.1 9236.8 5149.7 5172.1 5252.2 5380.9 5383.1 3528.2 3605.9 3625.2 3681.6 3684.0 1057.4 1075.3 1092.5 1099.6 1104.0 12182.8 12183.6 12245.4 12292.2 12312.6 4724.6 4788.1 4796.5 4905.3 4937.9 10167.6 10335.2 10337.0 10343.9 10351.5 5298.6 5366.1 5376.1 5380.5 5393.4 4328.1 4557.0 4834.0 4844.1 4881.5 3991.5 4044.4 4087.8 4095.4 4158.3 1327.1 1330.5 1336.4 1338.3 1345.8 828.2 838.4 887.9 908.0 940.9 6020.9 6022.7 6045.6 6078.6 6264.7 761.6 889.3 889.7 907.4 925.8 3854.9 4019.8 4032.5 4069.8 4135.8 9282.9 10362.7 11175.5 11193.6 11247.2 10591.3 10871.6 11147.4 11163.4 11176.6 6467.8 8367.8 8386.3 8424.6 8426.3 5853.6 5904.2 5972.6 6021.0 6040.5 9931.8 10237.7 10312.3 10433.6 10538.5 10526.7 10559.8 10640.1 10643.6 10648.1 6681.3 6888.9 7031.8 7199.2 7340.6 8336.6 8501.4 8610.6 8618.8 8630.3 7585.7 7661.7 7722.0 7786.2 7848.4 7450.9 7529.8 7582.5 7641.2 7730.6 6855.8 7001.4 7018.2 7021.8 7022.5 4321.8 5012.7 5069.1 5084.3 5116.2 5014.8 5076.4 5076.6 5248.4 5337.1 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - PROCESS | 1934 | [#4] prototype.html Cycles:180 Average:4686.38 Median:5147.49 stddev:1492.70 (29.0%) stddev-sans-first:1460.11 03:46:09 INFO - PROCESS | 1934 | Values: 298.8 299.9 308.9 309.9 310.6 4495.7 4819.5 5374.3 5476.8 5624.9 4592.8 5020.7 5249.4 5448.3 5472.2 4141.8 4175.8 4179.9 4181.4 4224.3 3908.3 4149.7 4181.9 4204.7 4209.8 3571.9 4060.5 4128.4 4144.4 4147.6 3743.3 3822.7 4120.6 4153.6 4158.8 2977.6 3390.6 3581.2 3585.7 3586.6 4607.4 4853.0 4899.0 5011.0 5302.8 3758.7 4002.1 4739.7 4756.2 4818.6 4231.8 4811.5 5822.8 5845.6 5925.3 3011.2 3729.8 3824.7 3909.2 3956.8 5965.6 5988.3 6032.5 6034.6 6174.2 3364.4 4023.2 4024.2 4032.5 4035.2 3871.5 3999.3 4037.8 4060.9 4102.5 4269.2 4586.0 4709.2 4732.7 4748.4 5370.4 5524.4 5894.8 5908.4 5938.9 1206.8 1293.5 1319.5 1333.1 1336.3 820.2 897.6 912.2 916.2 923.2 4282.4 5411.3 5439.3 5439.9 5467.2 5504.6 5709.5 5937.2 5947.4 5963.9 5130.5 5219.8 5413.8 5469.8 5470.6 2895.8 3123.8 3179.9 3190.4 3190.9 6227.5 6252.6 6278.6 6297.7 6356.4 5164.4 5633.4 5855.8 6253.4 6310.9 5390.6 6352.7 6368.5 6373.3 6391.5 5740.9 6098.2 6111.3 6134.7 6187.1 4838.0 5431.4 6079.5 6149.2 6174.5 5053.5 6188.0 6392.2 6412.0 6419.8 3481.3 3891.8 4020.8 4046.5 4048.8 5874.0 5877.3 5989.1 6039.7 6194.2 4713.7 4923.8 5095.0 5722.9 5926.9 5922.9 5956.9 5966.6 5969.2 5972.4 4800.3 5100.7 5491.4 5735.3 5781.4 5897.3 5903.1 5943.9 5947.0 5980.4 4784.5 4808.6 5768.7 5802.6 5825.7 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - PROCESS | 1934 | [#5] yui.html Cycles:180 Average:23441.76 Median:3614.07 stddev:36587.86 (1012.4%) stddev-sans-first:36650.84 03:46:09 INFO - PROCESS | 1934 | Values: 755.9 756.0 782.8 803.1 814.7 14900.7 15381.8 15403.2 15510.3 15594.1 13840.7 13901.0 13913.0 13917.4 13934.2 818.5 827.7 856.8 861.5 868.9 833.2 841.8 842.4 843.0 844.0 891.4 892.3 893.3 897.6 897.8 875.5 889.9 891.1 891.8 896.6 624.7 638.3 658.3 658.6 660.1 15141.3 15186.0 15266.5 15310.2 15327.8 13865.7 13888.0 13998.2 14098.0 14221.6 11356.0 11623.1 11723.5 11851.4 11880.8 3705.4 3778.5 3806.9 3877.6 3882.1 90580.0 115044.0 115702.4 119545.0 121143.0 8583.8 10304.3 10458.9 10866.7 11090.5 20759.6 20794.8 21033.5 21071.2 21086.9 6545.7 6748.2 6884.6 7984.1 8020.6 4370.9 4457.6 4482.8 4513.4 4545.3 3402.5 3498.8 3518.3 3522.5 3522.7 545.4 557.3 563.8 591.6 641.8 561.7 577.2 591.6 608.9 634.9 8412.0 8571.1 8581.2 8590.3 8827.8 542.1 550.8 559.4 606.4 613.2 3892.9 4071.0 4176.5 4416.4 4526.1 88040.0 114723.0 134802.0 137221.0 141073.3 115562.0 116656.0 117029.0 126884.4 127418.4 91142.1 108737.5 111876.0 111982.0 113151.9 9100.6 9437.1 9512.9 9517.7 9531.9 59779.7 65221.0 65829.7 67453.0 67858.0 61243.7 65360.3 71170.3 88285.0 93904.0 12271.1 12431.1 12491.8 12834.6 13025.7 14003.3 14649.6 14753.0 15376.7 15483.5 13158.6 13263.0 13351.5 13763.6 13824.8 12676.9 12685.6 13081.7 13108.9 13555.9 12853.2 13245.3 13263.6 13591.6 13826.8 11055.8 11073.4 11166.1 11306.7 11666.9 10993.7 11076.5 11181.4 11194.6 11240.5 03:46:09 INFO - PROCESS | 1934 | -------- Summary: end -------- 03:46:09 INFO - PROCESS | 1934 | 03:46:09 INFO - TEST-INFO | 1934: exit 0 03:46:09 INFO - TEST-OK | dromaeo_css | took 1113590ms 03:46:09 INFO - TEST-START | kraken 03:46:09 INFO - operating with platform_type : mac_ 03:46:09 INFO - Initialising browser for kraken test... 03:46:09 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpgV1ZPs/profile http://localhost:49470/getInfo.html) 03:46:12 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 03:46:12 INFO - PROCESS | 1962 | colorDepth:24 03:46:12 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 03:46:12 INFO - PROCESS | 1962 | __metrics 03:46:12 ERROR - PROCESS | 1962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:46:13 INFO - TEST-INFO | 1962: exit 0 03:46:13 INFO - Browser initialized. 03:46:13 INFO - Running cycle 1/1 for kraken test... 03:46:13 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpgV1ZPs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:25 INFO - PROCESS | 1964 | RSS: Main: 225935360 03:46:25 INFO - PROCESS | 1964 | 03:46:28 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49470/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:29 INFO - PROCESS | 1964 | RSS: Main: 238211072 03:46:29 INFO - PROCESS | 1964 | 03:46:31 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49470/tests/kraken/driver.html?testName=audio-dft) 03:46:32 INFO - PROCESS | 1964 | RSS: Main: 245608448 03:46:32 INFO - PROCESS | 1964 | 03:46:35 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49470/tests/kraken/driver.html?testName=audio-fft) 03:46:36 INFO - PROCESS | 1964 | RSS: Main: 249581568 03:46:36 INFO - PROCESS | 1964 | 03:46:38 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49470/tests/kraken/driver.html?testName=audio-oscillator) 03:46:38 INFO - PROCESS | 1964 | RSS: Main: 250789888 03:46:38 INFO - PROCESS | 1964 | 03:46:41 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:41 INFO - PROCESS | 1964 | RSS: Main: 251129856 03:46:41 INFO - PROCESS | 1964 | 03:46:44 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49470/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:45 INFO - PROCESS | 1964 | RSS: Main: 251858944 03:46:45 INFO - PROCESS | 1964 | 03:46:48 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49470/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:49 INFO - PROCESS | 1964 | RSS: Main: 251957248 03:46:49 INFO - PROCESS | 1964 | 03:46:52 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49470/tests/kraken/driver.html?testName=json-parse-financial) 03:46:52 INFO - PROCESS | 1964 | RSS: Main: 251912192 03:46:52 INFO - PROCESS | 1964 | 03:46:54 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:55 INFO - PROCESS | 1964 | RSS: Main: 251457536 03:46:55 INFO - PROCESS | 1964 | 03:46:57 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:57 INFO - PROCESS | 1964 | RSS: Main: 251514880 03:46:57 INFO - PROCESS | 1964 | 03:46:59 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:00 INFO - PROCESS | 1964 | RSS: Main: 251531264 03:47:00 INFO - PROCESS | 1964 | 03:47:03 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:04 INFO - PROCESS | 1964 | RSS: Main: 251936768 03:47:04 INFO - PROCESS | 1964 | 03:47:06 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:07 INFO - PROCESS | 1964 | RSS: Main: 251650048 03:47:07 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49470/tests/kraken/driver.html?testName=ai-astar) 03:47:09 INFO - PROCESS | 1964 | RSS: Main: 253337600 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | __start_tp_report 03:47:09 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 03:47:09 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 03:47:09 INFO - PROCESS | 1964 | |i|pagename|runs| 03:47:09 INFO - PROCESS | 1964 | |0;ai-astar;158;173;140;121;117;120;120;119;119;118 03:47:09 INFO - PROCESS | 1964 | |1;audio-beat-detection;138;111;119;179;125;113;112;119;138;123 03:47:09 INFO - PROCESS | 1964 | |2;audio-dft;193;200;236;256;221;202;197;196;192;199 03:47:09 INFO - PROCESS | 1964 | |3;audio-fft;84;60;61;86;64;62;61;60;79;60 03:47:09 INFO - PROCESS | 1964 | |4;audio-oscillator;110;90;101;104;74;70;91;70;71;86 03:47:09 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;110;86;89;106;116;86;125;86;124;134 03:47:09 INFO - PROCESS | 1964 | |6;imaging-darkroom;100;102;101;100;102;102;128;125;174;158 03:47:09 INFO - PROCESS | 1964 | |7;imaging-desaturate;139;125;92;123;115;101;147;98;134;104 03:47:09 INFO - PROCESS | 1964 | |8;json-parse-financial;58;54;56;58;58;59;61;60;60;60 03:47:09 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;68;76;69;76;75;69;70;94;107;111 03:47:09 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;82;80;76;73;99;108;71;92;104;106 03:47:09 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;132;131;150;134;149;158;159;161;201;158 03:47:09 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;166;165;164;164;169;168;165;166;165;164 03:47:09 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;67;81;87;91;74;69;66;67;65;68 03:47:09 INFO - PROCESS | 1964 | __end_tp_report 03:47:09 INFO - PROCESS | 1964 | __start_cc_report 03:47:09 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,939 03:47:09 INFO - PROCESS | 1964 | __end_cc_report 03:47:09 INFO - PROCESS | 1964 | __startTimestamp1478692029639__endTimestamp 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | ------- Summary: start ------- 03:47:09 INFO - PROCESS | 1964 | Number of tests: 14 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:130.50 Median:120.50 stddev:19.91 (16.5%) stddev-sans-first:18.46 03:47:09 INFO - PROCESS | 1964 | Values: 158.0 173.0 140.0 121.0 117.0 120.0 120.0 119.0 119.0 118.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:124.00 stddev:20.46 (16.5%) stddev-sans-first:21.35 03:47:09 INFO - PROCESS | 1964 | Values: 138.0 111.0 119.0 179.0 125.0 113.0 112.0 119.0 138.0 123.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:209.20 Median:201.00 stddev:21.52 (10.7%) stddev-sans-first:22.02 03:47:09 INFO - PROCESS | 1964 | Values: 193.0 200.0 236.0 256.0 221.0 202.0 197.0 196.0 192.0 199.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:67.70 Median:63.00 stddev:10.76 (17.1%) stddev-sans-first:9.66 03:47:09 INFO - PROCESS | 1964 | Values: 84.0 60.0 61.0 86.0 64.0 62.0 61.0 60.0 79.0 60.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:72.50 stddev:15.06 (20.8%) stddev-sans-first:13.41 03:47:09 INFO - PROCESS | 1964 | Values: 110.0 90.0 101.0 104.0 74.0 70.0 91.0 70.0 71.0 86.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:106.20 Median:110.00 stddev:18.48 (16.8%) stddev-sans-first:19.55 03:47:09 INFO - PROCESS | 1964 | Values: 110.0 86.0 89.0 106.0 116.0 86.0 125.0 86.0 124.0 134.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:119.20 Median:113.50 stddev:27.03 (23.8%) stddev-sans-first:27.76 03:47:09 INFO - PROCESS | 1964 | Values: 100.0 102.0 101.0 100.0 102.0 102.0 128.0 125.0 174.0 158.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:117.80 Median:136.50 stddev:18.80 (13.8%) stddev-sans-first:18.31 03:47:09 INFO - PROCESS | 1964 | Values: 139.0 125.0 92.0 123.0 115.0 101.0 147.0 98.0 134.0 104.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.50 stddev:2.12 (3.6%) stddev-sans-first:2.24 03:47:09 INFO - PROCESS | 1964 | Values: 58.0 54.0 56.0 58.0 58.0 59.0 61.0 60.0 60.0 60.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:81.50 Median:72.50 stddev:16.35 (22.6%) stddev-sans-first:16.60 03:47:09 INFO - PROCESS | 1964 | Values: 68.0 76.0 69.0 76.0 75.0 69.0 70.0 94.0 107.0 111.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:78.00 stddev:14.39 (18.4%) stddev-sans-first:15.03 03:47:09 INFO - PROCESS | 1964 | Values: 82.0 80.0 76.0 73.0 99.0 108.0 71.0 92.0 104.0 106.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:153.30 Median:158.00 stddev:20.45 (12.9%) stddev-sans-first:20.19 03:47:09 INFO - PROCESS | 1964 | Values: 132.0 131.0 150.0 134.0 149.0 158.0 159.0 161.0 201.0 158.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.50 stddev:1.71 (1.0%) stddev-sans-first:1.81 03:47:09 INFO - PROCESS | 1964 | Values: 166.0 165.0 164.0 164.0 169.0 168.0 165.0 166.0 165.0 164.0 03:47:09 INFO - PROCESS | 1964 | 03:47:09 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:71.50 stddev:9.48 (13.3%) stddev-sans-first:9.76 03:47:09 INFO - PROCESS | 1964 | Values: 67.0 81.0 87.0 91.0 74.0 69.0 66.0 67.0 65.0 68.0 03:47:09 INFO - PROCESS | 1964 | -------- Summary: end -------- 03:47:09 INFO - PROCESS | 1964 | 03:47:10 INFO - TEST-INFO | 1964: exit 0 03:47:10 INFO - TEST-OK | kraken | took 60593ms 03:47:10 INFO - SUITE-END | took 1174s 03:47:10 INFO - Completed test suite (00:19:34) 03:47:10 INFO - javascript benchmark 03:47:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7287.961706616864, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2923.9853800730993, 3007.8044927079736, 3431.6053653829817, 3444.2594842108974, 3450.8964731058077, 5869.207656966309, 5951.285845698522, 5955.166276721263, 5964.13520039594, 6012.098185272206, 4475.28395456727, 5843.094320380348, 5860.062390017598, 5868.76524939003, 5951.404859514047, 5301.5228629423345, 5350.545203657674, 5355.9196612050655, 5381.757820898049, 5391.973040134794, 5407.0, 5420.376656684492, 5423.755930983096, 5433.347998240217, 5458.153986132136, 5285.920711189336, 5304.655197412175, 5390.811321603745, 5400.540954018913, 5407.594430417715, 5283.365996080456, 5308.601854860882, 5323.627346085776, 5396.082665946759, 5428.267183930158, 5174.586033117342, 5307.761150748187, 5312.814051508179, 5339.41266460689, 5381.300430943991, 5817.7382017809305, 5838.795642152504, 5872.901822246186, 5938.079597662369, 5998.6100903441575, 6081.087836824468, 6180.783672571483, 6188.195534580521, 6247.281562620311, 6256.562040657156, 6353.587016843937, 6356.173697419352, 6362.427381535684, 6373.3945275198785, 6382.8723425531225, 6053.0, 6054.939450605481, 6073.1497590337385, 6076.936536106164, 6077.088436734525, 6181.258249010148, 6281.497480201573, 6287.182666253358, 6323.019931910561, 6431.13179720741, 4953.8018479261145, 6210.72051757672, 6247.750089996349, 6250.562460627803, 6266.811995640138, 6253.0, 6328.240611126695, 6351.396617321347, 6355.205599300088, 6427.389398007182, 6142.0, 6170.50635949123, 6180.072989051679, 6201.968990155111, 6214.067889816473, 5227.947720522746, 5261.842144735664, 6152.446279834837, 6191.226096737908, 6209.720562574695, 5004.624653150955, 5013.373328333958, 5018.272350509155, 5044.369453818273, 5062.316587260672, 4404.757738324359, 4451.732896026248, 4525.321201819687, 4529.230030894756, 4532.79602417892, 5410.48600382963, 5896.056630939029, 6004.279486461565, 6138.554517756338, 6146.508279337642, 6284.685765711696, 6349.8730025400155, 6359.0, 6359.841003974845, 6381.1066450696935, 5998.4601385875485, 6061.090836374491, 6071.51427885768, 6071.574989750763, 6086.421789929949, 5538.0, 5562.610617256834, 5565.1095824667855, 5574.386817450078, 5596.104623260258, 6473.158489396348, 6500.739970401131, 6503.6097834130105, 6520.282768895323, 6521.869562608721, 5014.974925125497, 6012.939870601238, 6221.657808820558, 6230.0, 6341.746330146742, 6311.305756366704, 6479.8056058318325, 6480.7731729391135, 6491.610503369813, 6549.934500654933, 5226.372835259641, 6230.813075607739, 6233.937660623335, 6249.0626406039455, 6257.1552840367785, 6195.783147589813, 6198.566100372931, 6341.682915854281, 6346.873062538816, 6348.428641422294, 6147.508199343953, 6162.784302549389, 6202.596831205957, 6241.719122639402, 6252.9062064069985, 5511.586631002771, 6202.875942481035, 6239.126522286792, 6250.812475625738, 6250.968745156245, 5230.398504172069, 5993.0710739835395, 6003.609765365237, 6131.264248290234, 6202.41077097675, 6151.354107818794, 6158.568900176944, 6185.690715464299, 6208.441240288395, 6245.250569931455, 6204.348543403058, 6205.503559715122, 6205.565610407228, 6212.596181248205, 6241.625502469867], "value": 5775.28450305453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.5262590035866, 490.74726515844344, 504.61986467012713, 519.9896002079956, 529.7642549065666, 36170.457443138344, 39997.20005599886, 40072.0, 41471.0, 41539.58460415395, 40916.0, 41390.96522586937, 41445.0, 41467.79266103673, 41496.58503414965, 9684.370515916478, 9878.061584149495, 9891.703248902544, 9895.406275623485, 9912.355696879717, 8221.671133154667, 9829.262805289596, 9859.852102218472, 9860.60557577696, 9873.210143188528, 9757.316987810857, 9852.408855468659, 9855.655052073178, 9863.063009014133, 9876.654317098903, 8189.79525511864, 9822.116009559173, 9831.31180817343, 9832.0, 9877.259205559612, 9731.41611503312, 9806.803863922682, 9810.0, 9843.261755368305, 9866.753331166707, 39393.60606393928, 39853.20293594141, 39872.40510379581, 40099.59900401017, 40158.196836063114, 3240.22234663679, 3383.272596391763, 3537.6816086552335, 3757.2861156380472, 3762.5484941806885, 25532.978680852742, 27336.0, 30563.38873222523, 30810.0, 30891.536626950612, 3094.0408473373327, 3152.8738850445957, 3163.9050828475183, 3193.2815116598813, 3195.3130077033547, 409836.0, 491838.0, 498933.0, 499121.0, 501127.0, 33069.0, 59417.70291148603, 59669.403305966385, 59856.70071649614, 59881.70059149677, 34406.31187376239, 35404.468932966025, 35698.821505892825, 35733.0, 35779.4633080504, 14406.207658578878, 14531.491397801237, 14536.63658408527, 14561.563153105424, 14613.19627420502, 12114.091443141624, 12221.633350999484, 12285.631431057083, 12295.200811947196, 12321.876781232253, 7685.846283074307, 7827.6477558510005, 7847.0, 7898.210178982171, 7920.643571039317, 3221.3235220603938, 3244.270039241152, 3263.2983908459796, 3271.6237632672073, 3294.159989202738, 890.3011136258007, 949.4350861237552, 955.0926619711302, 1007.9143272821746, 1045.7594753206804, 26011.0, 29539.556906646416, 30553.388932221675, 30770.38459230803, 30958.22604434907, 1055.9704288318828, 1060.2207377577474, 1071.0681706915034, 1136.7101389145714, 1182.7102359921873, 13821.654458638615, 15717.292721827545, 15734.291956861969, 15861.603459913364, 15990.36038558468, 710955.0, 721901.0, 727151.0, 730981.690183102, 741766.0, 57174.0, 57495.850082998106, 57510.71244643834, 57533.13700294499, 57613.423865761644, 1167.3346192670267, 1171.6367925942984, 1189.6787867275787, 1352.4319785690034, 1395.0513650717407, 29382.943193977073, 29892.55161172541, 30147.69852301449, 30484.542731858597, 30620.060457264546, 50128.749356252985, 50265.74867125641, 50356.49643503664, 50423.49576504188, 50501.242481363544, 630993.6900630934, 631084.0, 631283.0, 632940.0, 635520.0, 26704.8664756675, 26897.596536051584, 27009.784559694468, 27066.45867082608, 27169.72830271751, 45981.080378392915, 46283.53716462792, 46682.53317466917, 47481.52518474771, 47933.76033119812, 37482.250354993295, 38525.80737096297, 39130.6086939127, 39360.0, 40174.0, 38219.0, 38707.6129238704, 38871.40198756785, 39272.0, 39387.0, 37362.06594835151, 38146.0, 38216.0, 38333.0, 39875.60124398835, 32576.0, 34698.306033878674, 35256.0, 35437.29125417529, 35511.82244088763, 25904.22287331383, 26171.0, 26188.73811261863, 26220.344491387106, 26696.332591685365], "value": 18724.20240604574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.10669965284706, 372.72045965525854, 375.40685716567816, 381.14433097695644, 396.952046596984, 18933.242670293188, 20247.696284555706, 20463.897680511596, 20512.76923384598, 20697.275595354167, 15653.765193522106, 17937.820621793777, 18019.09904504773, 18633.627327453443, 19067.71398429021, 4381.0, 4803.975980120112, 4899.706017638944, 4938.925916111243, 5580.469855363734, 5004.349434573501, 5211.5309622134, 6209.099680546318, 6216.844578885519, 6302.842428939291, 5444.50999410053, 5534.584906132036, 5558.583106267026, 6249.0, 6258.249010118792, 5521.116621340586, 5552.3892371839065, 5559.19391688207, 5572.331320241597, 5585.078462053756, 4498.595126438636, 5415.593830462692, 5431.375391829911, 5431.8098866539485, 5474.151506516497, 13030.80453793194, 13057.151285166434, 13118.147320424237, 13128.409221585052, 13243.933780331037, 2133.328001679466, 2313.294445194232, 2581.3933725574475, 2670.0, 2942.7204415580486, 8341.332693384515, 9853.753656158582, 9917.0, 10029.648962286357, 10411.479426028669, 1806.8825526340745, 1873.8500919926373, 1919.280269898788, 1922.1542521290587, 1933.5649478867283, 122814.99999999911, 123274.0, 123999.0, 125660.0, 125787.37106314501, 11360.318380897173, 11375.715607109889, 11593.76812463746, 11635.941820290844, 12082.093842961813, 14484.420623174956, 14545.0, 14574.417023318949, 14583.416663333348, 14603.707925841636, 8222.753317400488, 8454.661813527513, 8468.745937621881, 8551.273141782895, 8569.571521424028, 8272.875906861402, 8297.668093276323, 8327.292180164633, 8456.788580285542, 8531.872021919551, 4467.084247729208, 4502.594766470967, 4503.347014682852, 4517.254652982287, 4568.70303430276, 1630.9429169978994, 1902.7526421565108, 1914.961700765977, 1958.2950137950327, 1958.9216431342873, 849.2442025626881, 911.2755359489222, 923.3628796130782, 924.4499522783933, 997.4115271989416, 21107.366778996653, 21420.892895535424, 21493.892530537247, 21700.891495542422, 21769.891150544147, 940.2431043010442, 943.6084025129632, 949.8337790886706, 966.5843687214565, 1024.3034736379184, 10738.0, 11270.718232044264, 11368.545258189744, 11413.828792568118, 11416.257943233662, 565755.9597245981, 589933.0, 615369.0, 619919.9004004952, 623311.0, 78373.60813195897, 85287.0, 102687.0, 142794.0, 146245.0, 965.3194497878978, 981.7790997025612, 985.1183191043975, 989.0258095775655, 989.1443901025561, 18535.44393668192, 19164.8083519163, 19346.903265483583, 19433.222671092997, 19573.02134893278, 42314.307427702544, 48522.27216591824, 50491.0, 56309.71845140748, 59959.0, 82474.58762706148, 83292.16707832844, 84803.87990300292, 85704.57147714222, 88412.0, 8136.22705842944, 8140.674373025249, 8437.0, 8602.569871506525, 8605.225529702357, 10630.415327157081, 12926.935365323114, 13045.608631741063, 13537.864621353661, 13631.386587603383, 11025.889741102486, 11161.218714689894, 11182.384968826793, 11569.710757231136, 11685.591004314809, 10994.670159895217, 11073.889261107286, 11363.034142098015, 11474.598389056677, 11768.52925882955, 10966.122710183006, 11223.933726295989, 11475.540978360772, 11786.823197652213, 11960.282383057045, 8048.678052877819, 8068.515889046676, 8094.51432914027, 8440.451370660887, 8489.235968762841, 8308.459950103224, 10352.482375881327, 11486.655400338002, 11500.309981401142, 11813.940930295294], "value": 9333.673423462276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.568063102016, 1531.058399084563, 1738.6783445062665, 1808.6834803909312, 1845.510939601006, 8220.054693710224, 8466.068732439428, 8705.912940870588, 9349.953250233748, 9364.250859931206, 8300.335973122152, 9036.006039335667, 9053.45679259245, 9178.495182764946, 9186.862197067032, 1986.7516560429947, 2272.7954484096426, 2362.775536324051, 2389.5340408620327, 2391.784739373456, 2341.8243631727605, 2345.2377977157407, 2366.2546297916188, 2392.83250172488, 2395.9760402395927, 2362.137819695807, 2369.6327069304284, 2376.1327115602767, 2377.8097752179783, 2378.0606660369144, 2326.255598208574, 2342.203650758742, 2355.187460326185, 2358.3160883343808, 2361.901715702198, 2360.775726305998, 2361.645753137026, 2363.137454828975, 2365.3731761083327, 2370.573296806574, 9077.818443631091, 9131.726048218565, 9168.404053736485, 9223.077692230723, 9236.769080772967, 5149.716765577892, 5172.094883395391, 5252.159654455307, 5380.919286210671, 5383.084875571162, 3528.1708798432346, 3605.8918232452806, 3625.166211771281, 3681.576618688858, 3684.0, 1057.3919996002253, 1075.2795626929976, 1092.4865313302735, 1099.5766629847567, 1104.0284549596383, 12182.756344873142, 12183.573574924834, 12245.448954796966, 12292.201006934522, 12312.569060082855, 4724.551167639069, 4788.090262850117, 4796.471103676271, 4905.337779399807, 4937.876553086202, 10167.593296268215, 10335.22485813567, 10337.0, 10343.896561034293, 10351.534180961875, 5298.569386265764, 5366.060939335601, 5376.1129413647095, 5380.488853558905, 5393.352797664227, 4328.069465065026, 4556.954430455653, 4833.951660483421, 4844.103840789465, 4881.487443818348, 3991.501062367204, 4044.3529035354204, 4087.7751723655483, 4095.447114639545, 4158.272302347077, 1327.0710502648185, 1330.4877622115362, 1336.4453751693134, 1338.3241463061092, 1345.784674452083, 828.1801016993254, 838.3502785341409, 887.8668199770086, 907.9966636866168, 940.8541676040225, 6020.909686354708, 6022.728977196037, 6045.637261764308, 6078.574499784972, 6264.718087686065, 761.6077719974218, 889.2663552569156, 889.6975028490215, 907.3920473282916, 925.7639301977953, 3854.9421758673643, 4019.8392064317686, 4032.495938007749, 4069.8168582413864, 4135.834566617302, 9282.907170928203, 10362.740931476623, 11175.497102630401, 11193.552257909756, 11247.156463265288, 10591.258611897247, 10871.619493317854, 11147.442627868573, 11163.441827908571, 11176.552937882394, 6467.773627923, 8367.832643347221, 8386.329093672492, 8424.62089205975, 8426.325893928593, 5853.619514731528, 5904.173415721888, 5972.611780234271, 6020.969895150496, 6040.546958978182, 9931.801363972825, 10237.74405639865, 10312.27814053009, 10433.582656693647, 10538.473076346305, 10526.684199474028, 10559.841602376124, 10640.148788096778, 10643.574257029632, 10648.148148147975, 6681.33186681328, 6888.896666550106, 7031.753888613874, 7199.2440793715905, 7340.596267205141, 8336.62485188156, 8501.404901656824, 8610.612522436631, 8618.750281209315, 8630.266427353745, 7585.6965721370525, 7661.693532258647, 7722.034745656793, 7786.221377862168, 7848.372130229453, 7450.8882366763455, 7529.849403012018, 7582.469227154046, 7641.159472457914, 7730.647136750934, 6855.760048398282, 7001.439884809101, 7018.192907815463, 7021.754238601625, 7022.473314501331, 4321.7839108043845, 5012.724300163526, 5069.138246498031, 5084.2627818966785, 5116.155834287301, 5014.771381011676, 5076.390833100052, 5076.60167130928, 5248.396434410091, 5337.119375303031], "value": 4651.556000934997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.8475877302575, 299.8665593810754, 308.92585779412934, 309.9302656902196, 310.5729621770066, 4495.707778994371, 4819.542143496366, 5374.274472946151, 5476.78092876285, 5624.915626265604, 4592.770361481929, 5020.698758074518, 5249.448807875176, 5448.346198456181, 5472.20653005314, 4141.834326626931, 4175.832966681329, 4179.937300940481, 4181.435506206653, 4224.260754367989, 3908.257431088098, 4149.709520333563, 4181.916361672765, 4204.747715137086, 4209.779164042424, 3571.910702232439, 4060.533038700543, 4128.401381799637, 4144.399062135988, 4147.5645057269, 3743.251349730051, 3822.719389004673, 4120.5989963412585, 4153.605407486284, 4158.792060396968, 2977.6426828780686, 3390.55922730046, 3581.212133330663, 3585.6772890439984, 3586.569611646593, 4607.378003969455, 4853.005133947532, 4898.975505122487, 5010.974945125287, 5302.814401495929, 3758.699304055669, 4002.079521710023, 4739.748619405789, 4756.217612696577, 4818.614510839125, 4231.767252801094, 4811.501246334653, 5822.796202132948, 5845.561582881301, 5925.288965324189, 3011.1869795155403, 3729.757565758217, 3824.737836513944, 3909.1853865217, 3956.7823769692654, 5965.5525835562075, 5988.341017738239, 6032.547558933054, 6034.637921724667, 6174.197354343952, 3364.4280472319765, 4023.2355852387955, 4024.1750441159493, 4032.475778148822, 4035.2131334389514, 3871.5160604924386, 3999.280129576704, 4037.7577345359373, 4060.939085913714, 4102.528209255914, 4269.167512335127, 4585.977070114628, 4709.246520556763, 4732.692374995614, 4748.406449193851, 5370.409254981949, 5524.4199359067525, 5894.7915677286055, 5908.350081491032, 5938.940610593839, 1206.7526157137765, 1293.5447621425897, 1319.4524272426836, 1333.1068184316532, 1336.2850874782139, 820.2125959079232, 897.5736525150631, 912.2291663544295, 916.1662886773005, 923.2244914272044, 4282.443282373334, 5411.323584551931, 5439.3200849893765, 5439.945600544023, 5467.234587157801, 5504.605496608988, 5709.457601527848, 5937.198478205387, 5947.37552556984, 5963.940360596425, 5130.538251557303, 5219.791208351699, 5413.783448662089, 5469.835904922858, 5470.617056805985, 2895.7828162887868, 3123.7969531980348, 3179.920501987469, 3190.3619276144864, 3190.8564114614896, 6227.532935029891, 6252.624842509464, 6278.591891527128, 6297.716602752887, 6356.410897275681, 5164.431912489623, 5633.3944825724475, 5855.795047173328, 6253.437190652863, 6310.9368906311265, 5390.649607775482, 6352.744775604779, 6368.490520758328, 6373.298937116913, 6391.520635952322, 5740.856478588069, 6098.176746139392, 6111.327753946974, 6134.693265336626, 6187.051078910129, 4838.0, 5431.375391829832, 6079.540910181436, 6149.169862068564, 6174.536909731698, 5053.545180933586, 6188.031644471004, 6392.169018027626, 6411.96794016027, 6419.775307864203, 3481.2863363010015, 3891.8248678810087, 4020.819063142107, 4046.4537287465814, 4048.805602347256, 5874.0, 5877.324107727666, 5989.101634754822, 6039.701464185221, 6194.225721784777, 4713.740744259098, 4923.793670550738, 5094.974525127351, 5722.885542289047, 5926.851828704144, 5922.851928701817, 5956.910646340395, 5966.582339236212, 5969.164316995537, 5972.3859572002175, 4800.279958006187, 5100.668456550312, 5491.395946445968, 5735.311762588516, 5781.398370733103, 5897.292324921037, 5903.144044113494, 5943.910841337297, 5947.0, 5980.372060933713, 4784.497627749036, 4808.567228949411, 5768.653880767168, 5802.564807639359, 5825.70871456434], "value": 4208.05410821235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.8979537762403, 755.9773206803798, 782.7651704488653, 803.1286054630725, 814.7026335387584, 14900.701985960275, 15381.769273460906, 15403.152826594533, 15510.302036408375, 15594.06435613864, 13840.723185536282, 13901.0, 13913.0, 13917.443302267922, 13934.233617151052, 818.5211651184064, 827.7020272701823, 856.824351008045, 861.4745005546612, 868.8870446841902, 833.1668331668332, 841.7558907916728, 842.3934766967774, 843.0431460292551, 843.9535825529593, 891.4205766251923, 892.2950868813662, 893.2898345815092, 897.6185121323444, 897.7935074932736, 875.5184648443394, 889.9110088991114, 891.0821853490914, 891.79488717595, 896.6010125494158, 624.6533174088379, 638.2819328255713, 658.2528829778188, 658.6311665467354, 660.085781193051, 15141.318640661086, 15186.0, 15266.542003739905, 15310.157941313224, 15327.770083448757, 13865.653358666013, 13888.0, 13998.230097344642, 14098.0, 14221.644458888508, 11356.0, 11623.07015438763, 11723.531058757639, 11851.40742962857, 11880.762384752343, 3705.40713485841, 3778.5087938568086, 3806.8667596634264, 3877.5734669186368, 3882.107115363454, 90580.0, 115044.0, 115702.42148789202, 119545.0, 121143.0, 8583.828323433496, 10304.332617060587, 10458.895411045944, 10866.728331791768, 11090.500927458123, 20759.58480830405, 20794.792052079287, 21033.474163145736, 21071.20894723935, 21086.945652717302, 6545.738170473128, 6748.190217173872, 6884.552504087218, 7984.121746607869, 8020.5588692621295, 4370.868873933787, 4457.64338852891, 4482.7758612069265, 4513.413256276663, 4545.340925565774, 3402.4896265560365, 3498.772579782306, 3518.2787528557096, 3522.471629255581, 3522.735794815399, 545.4027839515724, 557.3200695151908, 563.7942151114813, 591.5947575910515, 641.7721708793312, 561.6770357044716, 577.2322810661893, 591.5829340315067, 608.8843119807223, 634.8825467288474, 8412.0, 8571.057183709787, 8581.227689507974, 8590.303973813963, 8827.823443531093, 542.1271752478507, 550.7521615273143, 559.3679142568952, 606.4026933470528, 613.1967123068794, 3892.8637497687446, 4071.0229544909007, 4176.477940257468, 4416.359627854007, 4526.072155208174, 88040.0, 114723.0, 134802.0, 137221.0, 141073.29463352618, 115562.0, 116656.0, 117029.0, 126884.36557817152, 127418.36290818486, 91142.08857911469, 108737.45631271793, 111876.0, 111982.0, 113151.86848131577, 9100.59047342858, 9437.103475169848, 9512.904870951203, 9517.666881659386, 9531.857022144812, 59779.70110149596, 65221.0, 65829.67085164544, 67453.0, 67858.0, 61243.693781530805, 65360.34639653733, 71170.28829711844, 88285.0, 93904.0, 12271.07966902468, 12431.067669924973, 12491.812622810847, 12834.614961551168, 13025.739485210432, 14003.299835008413, 14649.633759156106, 14753.041052331564, 15376.692466150838, 15483.5354939352, 13158.60524184276, 13263.0, 13351.532696355582, 13763.587092386844, 13824.792628110788, 12676.936615316865, 12685.619431417072, 13081.738365232452, 13108.885744711424, 13555.932220338835, 12853.228806271654, 13245.337733113498, 13263.602091937257, 13591.592252232449, 13826.792598110835, 11055.83416248773, 11073.390963497084, 11166.1067114629, 11306.717332066764, 11666.949974502335, 10993.725156871142, 11076.538903642915, 11181.440927953407, 11194.552217911192, 11240.494177762184], "value": 7583.791879999586, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 173.0, 140.0, 121.0, 117.0, 120.0, 120.0, 119.0, 119.0, 118.0], "value": 130.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 119.0, 179.0, 125.0, 113.0, 112.0, 119.0, 138.0, 123.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 200.0, 236.0, 256.0, 221.0, 202.0, 197.0, 196.0, 192.0, 199.0], "value": 209.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 61.0, 86.0, 64.0, 62.0, 61.0, 60.0, 79.0, 60.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 90.0, 101.0, 104.0, 74.0, 70.0, 91.0, 70.0, 71.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 86.0, 89.0, 106.0, 116.0, 86.0, 125.0, 86.0, 124.0, 134.0], "value": 106.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 102.0, 101.0, 100.0, 102.0, 102.0, 128.0, 125.0, 174.0, 158.0], "value": 119.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 125.0, 92.0, 123.0, 115.0, 101.0, 147.0, 98.0, 134.0, 104.0], "value": 117.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 56.0, 58.0, 58.0, 59.0, 61.0, 60.0, 60.0, 60.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 69.0, 76.0, 75.0, 69.0, 70.0, 94.0, 107.0, 111.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 76.0, 73.0, 99.0, 108.0, 71.0, 92.0, 104.0, 106.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 150.0, 134.0, 149.0, 158.0, 159.0, 161.0, 201.0, 158.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 164.0, 164.0, 169.0, 168.0, 165.0, 166.0, 165.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 81.0, 87.0, 91.0, 74.0, 69.0, 66.0, 67.0, 65.0, 68.0], "value": 73.5, "unit": "score"}]}]} 03:47:10 INFO - Return code: 0 03:47:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:10 ERROR - # TBPL SUCCESS # 03:47:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:47:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:47:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:47:10 INFO - 2016-11-09 03:47:10.978 screenresolution[1969:19196] starting screenresolution argv=screenresolution get 03:47:10 INFO - 2016-11-09 03:47:10.982 screenresolution[1969:19196] Display 0: 1600x1200x32@60 03:47:10 INFO - 2016-11-09 03:47:10.988 screenresolution[1970:19199] starting screenresolution argv=screenresolution list 03:47:10 INFO - Available Modes on Display 0 03:47:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:47:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:47:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:47:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:47:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:47:11 INFO - Intel Iris: 03:47:11 INFO - Chipset Model: Intel Iris 03:47:11 INFO - Type: GPU 03:47:11 INFO - Bus: Built-In 03:47:11 INFO - VRAM (Dynamic, Max): 1536 MB 03:47:11 INFO - Vendor: Intel (0x8086) 03:47:11 INFO - Device ID: 0x0a2e 03:47:11 INFO - Revision ID: 0x0009 03:47:11 INFO - Displays: 03:47:11 INFO - Display: 03:47:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:47:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:47:11 INFO - Display Serial Number: 1600x1200 60 03:47:11 INFO - Main Display: Yes 03:47:11 INFO - Mirror: Off 03:47:11 INFO - Online: Yes 03:47:11 INFO - Rotation: Supported 03:47:11 INFO - Return code: 0 03:47:11 INFO - Running post-action listener: _resource_record_post_action 03:47:11 INFO - [mozharness: 2016-11-09 11:47:11.224301Z] Finished run-tests step (success) 03:47:11 INFO - Running post-run listener: _resource_record_post_run 03:47:11 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1712128; Write bytes: 668740608; Read time: 13; Write time: 1967 03:47:11 INFO - TinderboxPrint: CPU usage
54.2% 03:47:11 INFO - TinderboxPrint: I/O read bytes / time
1,712,128 / 13 03:47:11 INFO - TinderboxPrint: I/O write bytes / time
668,740,608 / 1,967 03:47:11 INFO - TinderboxPrint: CPU idle
2,211.3 (45.8%) 03:47:11 INFO - TinderboxPrint: CPU system
973.9 (20.2%) 03:47:11 INFO - TinderboxPrint: CPU user
1,644.5 (34.0%) 03:47:11 INFO - TinderboxPrint: Swap in / out
365,465,600 / 0 03:47:11 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356352512; Write bytes: 356091904; Read time: 27647; Write time: 729 03:47:11 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 876544; Write bytes: 298560512; Read time: 10; Write time: 1183 03:47:11 INFO - Running post-run listener: _upload_blobber_files 03:47:11 INFO - Blob upload gear active. 03:47:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:11 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:11 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:11 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:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:47:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:13 INFO - (blobuploader) - INFO - Done attempting. 03:47:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:47:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.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/resource-usage.json ... 03:47:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:16 INFO - (blobuploader) - INFO - Done attempting. 03:47:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:16 INFO - Return code: 0 03:47:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:16 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/c7cc0e92bd50331cfe235c8fe0631d5a83286d65c44ba903b1e9c1999ab38d065afe9c2b9683ae6a8f903159d1c74a32154fd24fa484c7cc038bcd3af5f3741e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ee9b58ef796964f06b3669c6d04359448380fa07e4c4fd3346115d10629e9df5417ec13c3cb91145e92cdc2b8c0b28b5bbc5a99f5f12fa27851873fdcbf3b49"} 03:47:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:16 INFO - Contents: 03:47:16 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/c7cc0e92bd50331cfe235c8fe0631d5a83286d65c44ba903b1e9c1999ab38d065afe9c2b9683ae6a8f903159d1c74a32154fd24fa484c7cc038bcd3af5f3741e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ee9b58ef796964f06b3669c6d04359448380fa07e4c4fd3346115d10629e9df5417ec13c3cb91145e92cdc2b8c0b28b5bbc5a99f5f12fa27851873fdcbf3b49"} 03:47:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:16 INFO - Copying logs to upload dir... 03:47:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.720994 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-11-09 03:47:16.641110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:16.644743) ========= 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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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/c7cc0e92bd50331cfe235c8fe0631d5a83286d65c44ba903b1e9c1999ab38d065afe9c2b9683ae6a8f903159d1c74a32154fd24fa484c7cc038bcd3af5f3741e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ee9b58ef796964f06b3669c6d04359448380fa07e4c4fd3346115d10629e9df5417ec13c3cb91145e92cdc2b8c0b28b5bbc5a99f5f12fa27851873fdcbf3b49"} 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.011935 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/c7cc0e92bd50331cfe235c8fe0631d5a83286d65c44ba903b1e9c1999ab38d065afe9c2b9683ae6a8f903159d1c74a32154fd24fa484c7cc038bcd3af5f3741e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ee9b58ef796964f06b3669c6d04359448380fa07e4c4fd3346115d10629e9df5417ec13c3cb91145e92cdc2b8c0b28b5bbc5a99f5f12fa27851873fdcbf3b49"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:16.677853) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:16.678142) ========= 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.Ubtj6IMOjZ/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.PfUp6kV1pA/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:16.725784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 03:47:16.726060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 03:47:16.726370) ========= ========= Total master_lag: 0.20 =========