builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0066 starttime: 1478663198.7 results: success (0) buildid: 20161108173621 builduid: 083c302c289d4fffa60edb78cf695dbd revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:38.702866) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:38.703293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:38.703582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:38.728060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:38.728323) ========= 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.IAnvpvqKST/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.wS5ydMkKPi/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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-08 19:46:38-- 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% 9.64M=0.001s 2016-11-08 19:46:38 (9.64 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:38.844559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:38.844873) ========= 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.IAnvpvqKST/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.wS5ydMkKPi/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.026049 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:38.893291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 19:46:38.893611) ========= 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.IAnvpvqKST/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.wS5ydMkKPi/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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-08 19:46:38,974 truncating revision to first 12 chars 2016-11-08 19:46:38,974 Setting DEBUG logging. 2016-11-08 19:46:38,974 attempt 1/10 2016-11-08 19:46:38,974 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-08 19:46:39,993 unpacking tar archive at: mozilla-aurora-ae3b6bfb8104/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283005 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 19:46:40.198432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:40.198754) ========= script_repo_revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:40.199148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:40.199422) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:40.218460) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-11-08 19:46:40.218727) ========= /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.IAnvpvqKST/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.wS5ydMkKPi/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:46:40 INFO - MultiFileLogger online at 20161108 19:46:40 in /builds/slave/test 19:46:40 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 19:46:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:46:40 INFO - {'append_to_log': False, 19:46:40 INFO - 'base_work_dir': '/builds/slave/test', 19:46:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:46:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:46:40 INFO - 'branch': 'Mozilla-Aurora', 19:46:40 INFO - 'buildbot_json_path': 'buildprops.json', 19:46:40 INFO - 'config_files': ('talos/mac_config.py',), 19:46:40 INFO - 'default_actions': ('clobber', 19:46:40 INFO - 'read-buildbot-config', 19:46:40 INFO - 'download-and-extract', 19:46:40 INFO - 'populate-webroot', 19:46:40 INFO - 'create-virtualenv', 19:46:40 INFO - 'install', 19:46:40 INFO - 'run-tests'), 19:46:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:46:40 INFO - 'download_minidump_stackwalk': True, 19:46:40 INFO - 'download_symbols': 'ondemand', 19:46:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:46:40 INFO - 'tooltool.py': '/tools/tooltool.py', 19:46:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:46:40 INFO - '/tools/misc-python/virtualenv.py')}, 19:46:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:46:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:46:40 INFO - 'installer_path': 'installer.exe', 19:46:40 INFO - 'log_level': 'info', 19:46:40 INFO - 'log_name': 'talos', 19:46:40 INFO - 'log_to_console': True, 19:46:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:46:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:46:40 INFO - 'opt_config_files': (), 19:46:40 INFO - 'pip_index': False, 19:46:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:46:40 INFO - 'cmd': ('bash', 19:46:40 INFO - '-c', 19:46:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:46:40 INFO - 'enabled': True, 19:46:40 INFO - 'halt_on_failure': False, 19:46:40 INFO - 'name': 'check_screen_resolution'},), 19:46:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:46:40 INFO - 'cmd': ('bash', 19:46:40 INFO - '-c', 19:46:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:46:40 INFO - 'enabled': True, 19:46:40 INFO - 'halt_on_failure': False, 19:46:40 INFO - 'name': 'check_screen_resolution'},), 19:46:40 INFO - 'run_cmd_checks_enabled': True, 19:46:40 INFO - 'sps_profile': False, 19:46:40 INFO - 'sps_profile_interval': 0, 19:46:40 INFO - 'suite': 'dromaeojs-e10s', 19:46:40 INFO - 'system_bits': '32', 19:46:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:46:40 INFO - 'title': 't-yosemite-r7-0066', 19:46:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:46:40 INFO - 'use_talos_json': True, 19:46:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:46:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:46:40 INFO - 'work_dir': 'build'} 19:46:40 INFO - [mozharness: 2016-11-09 03:46:40.433474Z] Running clobber step. 19:46:40 INFO - Running pre-action listener: _resource_record_pre_action 19:46:40 INFO - Running main action method: clobber 19:46:40 INFO - rmtree: /builds/slave/test/build 19:46:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:46:42 INFO - Running post-action listener: _resource_record_post_action 19:46:42 INFO - [mozharness: 2016-11-09 03:46:42.977657Z] Finished clobber step (success) 19:46:42 INFO - [mozharness: 2016-11-09 03:46:42.977892Z] Running read-buildbot-config step. 19:46:42 INFO - Running pre-action listener: _resource_record_pre_action 19:46:42 INFO - Running main action method: read_buildbot_config 19:46:42 INFO - Using buildbot properties: 19:46:42 INFO - { 19:46:42 INFO - "project": "", 19:46:42 INFO - "product": "firefox", 19:46:42 INFO - "script_repo_revision": "production", 19:46:42 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:46:42 INFO - "repository": "", 19:46:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:46:42 INFO - "buildid": "20161108173621", 19:46:42 INFO - "pgo_build": "False", 19:46:42 INFO - "basedir": "/builds/slave/test", 19:46:42 INFO - "buildnumber": 444, 19:46:42 INFO - "slavename": "t-yosemite-r7-0066", 19:46:42 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:46:42 INFO - "platform": "yosemite_r7", 19:46:42 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:46:42 INFO - "branch": "mozilla-aurora", 19:46:42 INFO - "repo_path": "releases/mozilla-aurora", 19:46:42 INFO - "revision": "ae3b6bfb810476141647ad681b796ed118062412", 19:46:42 INFO - "stage_platform": "macosx64", 19:46:42 INFO - "builduid": "083c302c289d4fffa60edb78cf695dbd", 19:46:42 INFO - "slavebuilddir": "test" 19:46:42 INFO - } 19:46:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 19:46:42 INFO - Running post-action listener: _resource_record_post_action 19:46:42 INFO - [mozharness: 2016-11-09 03:46:42.983731Z] Finished read-buildbot-config step (success) 19:46:42 INFO - [mozharness: 2016-11-09 03:46:42.983927Z] Running download-and-extract step. 19:46:42 INFO - Running pre-action listener: _resource_record_pre_action 19:46:42 INFO - Running main action method: download_and_extract 19:46:42 INFO - mkdir: /builds/slave/test/build/tests 19:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:42 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 19:46:42 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 19:46:42 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 19:46:43 INFO - Downloaded 1199 bytes. 19:46:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:46:43 INFO - Using the following test package requirements: 19:46:43 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:46:43 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:43 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 19:46:43 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:43 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 19:46:43 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:43 INFO - u'jsshell-mac.zip'], 19:46:43 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:43 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 19:46:43 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:46:43 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:43 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 19:46:43 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:43 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 19:46:43 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:43 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 19:46:43 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:43 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 19:46:43 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:46:43 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 19:46:43 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 19:46:43 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:46:44 INFO - Expected file size: 16423395 19:46:51 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 19:46:51 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 19:46:51 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 19:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:46:52 INFO - Expected file size: 16423395 19:46:58 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 19:46:58 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 19:46:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 19:46:59 INFO - Expected file size: 14414089 19:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:00 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:47:00 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 19:47:00 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 19:47:03 INFO - Downloaded 115464056 bytes. 19:47:03 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 19:47:03 INFO - mkdir: /builds/slave/test/properties 19:47:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:47:03 INFO - Writing to file /builds/slave/test/properties/build_url 19:47:03 INFO - Contents: 19:47:03 INFO - build_url:https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:47:03 INFO - Running post-action listener: _resource_record_post_action 19:47:03 INFO - Running post-action listener: set_extra_try_arguments 19:47:03 INFO - [mozharness: 2016-11-09 03:47:03.731018Z] Finished download-and-extract step (success) 19:47:03 INFO - [mozharness: 2016-11-09 03:47:03.731143Z] Running populate-webroot step. 19:47:03 INFO - Running pre-action listener: _resource_record_pre_action 19:47:03 INFO - Running main action method: populate_webroot 19:47:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:47:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:47:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:47:03 INFO - '--tppagecycles', 19:47:03 INFO - '7'], 19:47:03 INFO - 'tests': ['tsvgm']}}, 19:47:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:47:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:47:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:47:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:47:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:03 INFO - 'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:03 INFO - 'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['damp', 'tps']}, 19:47:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:03 INFO - 'tests': ['damp', 'tps']}, 19:47:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['dromaeo_dom']}, 19:47:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:47:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['basic_compositor_video']}, 19:47:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:47:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['a11yr', 19:47:03 INFO - 'ts_paint', 19:47:03 INFO - 'tpaint', 19:47:03 INFO - 'sessionrestore', 19:47:03 INFO - 'sessionrestore_no_auto_restore', 19:47:03 INFO - 'tabpaint']}, 19:47:03 INFO - 'other-e10s': {'tests': ['a11yr', 19:47:03 INFO - 'ts_paint', 19:47:03 INFO - 'tpaint', 19:47:03 INFO - 'sessionrestore', 19:47:03 INFO - 'sessionrestore_no_auto_restore', 19:47:03 INFO - 'tabpaint']}, 19:47:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:47:03 INFO - 'ts_paint', 19:47:03 INFO - 'tpaint', 19:47:03 INFO - 'sessionrestore', 19:47:03 INFO - 'sessionrestore_no_auto_restore', 19:47:03 INFO - 'tabpaint']}, 19:47:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:47:03 INFO - 'ts_paint', 19:47:03 INFO - 'tpaint', 19:47:03 INFO - 'sessionrestore', 19:47:03 INFO - 'sessionrestore_no_auto_restore', 19:47:03 INFO - 'tabpaint']}, 19:47:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['a11yr', 19:47:03 INFO - 'ts_paint', 19:47:03 INFO - 'tpaint', 19:47:03 INFO - 'sessionrestore', 19:47:03 INFO - 'sessionrestore_no_auto_restore', 19:47:03 INFO - 'tabpaint']}, 19:47:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['a11yr', 19:47:03 INFO - 'ts_paint', 19:47:03 INFO - 'tpaint', 19:47:03 INFO - 'sessionrestore', 19:47:03 INFO - 'sessionrestore_no_auto_restore', 19:47:03 INFO - 'tabpaint']}, 19:47:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['tsvgx', 19:47:03 INFO - 'tsvgr_opacity', 19:47:03 INFO - 'tart', 19:47:03 INFO - 'tscrollx', 19:47:03 INFO - 'cart']}, 19:47:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:47:03 INFO - 'tsvgr_opacity', 19:47:03 INFO - 'tart', 19:47:03 INFO - 'tscrollx', 19:47:03 INFO - 'cart']}, 19:47:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:03 INFO - 'talos_options': ['--disable-e10s'], 19:47:03 INFO - 'tests': ['tp5o']}, 19:47:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:03 INFO - 'tests': ['tp5o']}, 19:47:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:03 INFO - 'talos_options': ['--disable-e10s', 19:47:03 INFO - '--xperf_path', 19:47:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:03 INFO - 'tests': ['tp5n']}, 19:47:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:03 INFO - 'talos_options': ['--xperf_path', 19:47:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:03 INFO - 'tests': ['tp5n']}}, 19:47:03 INFO - 'talos.zip': {'path': '', 19:47:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:47:03 INFO - Running post-action listener: _resource_record_post_action 19:47:03 INFO - [mozharness: 2016-11-09 03:47:03.750187Z] Finished populate-webroot step (success) 19:47:03 INFO - [mozharness: 2016-11-09 03:47:03.750299Z] Running create-virtualenv step. 19:47:03 INFO - Running pre-action listener: _resource_record_pre_action 19:47:03 INFO - Running main action method: create_virtualenv 19:47:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:47:03 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 19:47:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:47:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:47:03 INFO - Using real prefix '/tools/python27' 19:47:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:47:04 INFO - Installing distribute.............................................................................................................................................................................................done. 19:47:07 INFO - Installing pip.................done. 19:47:07 INFO - Return code: 0 19:47:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:47:07 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')]} 19:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:07 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')]} 19:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:07 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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:07 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 19:47:07 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 19:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:07 INFO - 'HOME': '/Users/cltbld', 19:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:07 INFO - 'LOGNAME': 'cltbld', 19:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:07 INFO - 'MOZ_NO_REMOTE': '1', 19:47:07 INFO - 'NO_EM_RESTART': '1', 19:47:07 INFO - 'PAGER': '/bin/cat', 19:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:07 INFO - 'PWD': '/builds/slave/test', 19:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:07 INFO - 'SHELL': '/bin/bash', 19:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:07 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:07 INFO - 'USER': 'cltbld', 19:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:07 INFO - 'XPC_FLAGS': '0x0', 19:47:07 INFO - 'XPC_SERVICE_NAME': '0', 19:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:07 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 19:47:07 INFO - Cleaning up... 19:47:07 INFO - Return code: 0 19:47:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:47:07 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')]} 19:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:07 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')]} 19:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:07 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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:07 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 19:47:07 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 19:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:07 INFO - 'HOME': '/Users/cltbld', 19:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:07 INFO - 'LOGNAME': 'cltbld', 19:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:07 INFO - 'MOZ_NO_REMOTE': '1', 19:47:07 INFO - 'NO_EM_RESTART': '1', 19:47:07 INFO - 'PAGER': '/bin/cat', 19:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:07 INFO - 'PWD': '/builds/slave/test', 19:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:07 INFO - 'SHELL': '/bin/bash', 19:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:07 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:07 INFO - 'USER': 'cltbld', 19:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:07 INFO - 'XPC_FLAGS': '0x0', 19:47:07 INFO - 'XPC_SERVICE_NAME': '0', 19:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:07 INFO - Downloading/unpacking psutil>=3.1.1 19:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:47:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:11 INFO - Installing collected packages: psutil 19:47:11 INFO - Running setup.py install for psutil 19:47:11 INFO - building 'psutil._psutil_osx' extension 19:47:11 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 19:47:11 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 19:47:11 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 19:47:11 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 19:47:11 INFO - building 'psutil._psutil_posix' extension 19:47:11 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 19:47:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:47:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:47:11 INFO - ^ 19:47:12 INFO - 1 warning generated. 19:47:12 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 19:47:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:12 INFO - Successfully installed psutil 19:47:12 INFO - Cleaning up... 19:47:12 INFO - Return code: 0 19:47:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:12 INFO - 'HOME': '/Users/cltbld', 19:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:12 INFO - 'LOGNAME': 'cltbld', 19:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:12 INFO - 'MOZ_NO_REMOTE': '1', 19:47:12 INFO - 'NO_EM_RESTART': '1', 19:47:12 INFO - 'PAGER': '/bin/cat', 19:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:12 INFO - 'PWD': '/builds/slave/test', 19:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:12 INFO - 'SHELL': '/bin/bash', 19:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:12 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:12 INFO - 'USER': 'cltbld', 19:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:12 INFO - 'XPC_FLAGS': '0x0', 19:47:12 INFO - 'XPC_SERVICE_NAME': '0', 19:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:47:15 INFO - Installing collected packages: mozsystemmonitor 19:47:15 INFO - Running setup.py install for mozsystemmonitor 19:47:15 INFO - Successfully installed mozsystemmonitor 19:47:15 INFO - Cleaning up... 19:47:15 INFO - Return code: 0 19:47:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:15 INFO - 'HOME': '/Users/cltbld', 19:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:15 INFO - 'LOGNAME': 'cltbld', 19:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:15 INFO - 'MOZ_NO_REMOTE': '1', 19:47:15 INFO - 'NO_EM_RESTART': '1', 19:47:15 INFO - 'PAGER': '/bin/cat', 19:47:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:15 INFO - 'PWD': '/builds/slave/test', 19:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:15 INFO - 'SHELL': '/bin/bash', 19:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:15 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:15 INFO - 'USER': 'cltbld', 19:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:15 INFO - 'XPC_FLAGS': '0x0', 19:47:15 INFO - 'XPC_SERVICE_NAME': '0', 19:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:47:15 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 19:47:15 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 19:47:15 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 19:47:15 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 19:47:15 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 19:47:15 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 19:47:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:47:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:47:18 INFO - warning: no files found matching '*.txt' 19:47:18 INFO - no previously-included directories found matching 'build' 19:47:18 INFO - no previously-included directories found matching 'dist' 19:47:18 INFO - no previously-included directories found matching '.git*' 19:47:18 INFO - Installing collected packages: jsonschema, functools32 19:47:18 INFO - Running setup.py install for functools32 19:47:18 INFO - warning: no files found matching '*.txt' 19:47:18 INFO - no previously-included directories found matching 'build' 19:47:18 INFO - no previously-included directories found matching 'dist' 19:47:18 INFO - no previously-included directories found matching '.git*' 19:47:18 INFO - Successfully installed jsonschema functools32 19:47:18 INFO - Cleaning up... 19:47:18 INFO - Return code: 0 19:47:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:47:18 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')]} 19:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:18 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')]} 19:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:18 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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:18 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 19:47:18 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 19:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:18 INFO - 'HOME': '/Users/cltbld', 19:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:18 INFO - 'LOGNAME': 'cltbld', 19:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:18 INFO - 'MOZ_NO_REMOTE': '1', 19:47:18 INFO - 'NO_EM_RESTART': '1', 19:47:18 INFO - 'PAGER': '/bin/cat', 19:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:18 INFO - 'PWD': '/builds/slave/test', 19:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:18 INFO - 'SHELL': '/bin/bash', 19:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:18 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:18 INFO - 'USER': 'cltbld', 19:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:18 INFO - 'XPC_FLAGS': '0x0', 19:47:18 INFO - 'XPC_SERVICE_NAME': '0', 19:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:47:19 INFO - Cleaning up... 19:47:19 INFO - Return code: 0 19:47:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:19 INFO - 'HOME': '/Users/cltbld', 19:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:19 INFO - 'LOGNAME': 'cltbld', 19:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:19 INFO - 'MOZ_NO_REMOTE': '1', 19:47:19 INFO - 'NO_EM_RESTART': '1', 19:47:19 INFO - 'PAGER': '/bin/cat', 19:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:19 INFO - 'PWD': '/builds/slave/test', 19:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:19 INFO - 'SHELL': '/bin/bash', 19:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:19 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:19 INFO - 'USER': 'cltbld', 19:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:19 INFO - 'XPC_FLAGS': '0x0', 19:47:19 INFO - 'XPC_SERVICE_NAME': '0', 19:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:21 INFO - Downloading blobuploader-1.2.4.tar.gz 19:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:47:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:47:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:47:22 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 19:47:22 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 19:47:22 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 19:47:22 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 19:47:22 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 19:47:22 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 19:47:23 INFO - Downloading docopt-0.6.1.tar.gz 19:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:47:23 INFO - Installing collected packages: blobuploader, requests, docopt 19:47:23 INFO - Running setup.py install for blobuploader 19:47:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:47:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:47:23 INFO - Running setup.py install for requests 19:47:23 INFO - Running setup.py install for docopt 19:47:23 INFO - Successfully installed blobuploader requests docopt 19:47:23 INFO - Cleaning up... 19:47:24 INFO - Return code: 0 19:47:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:24 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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:24 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 19:47:24 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 19:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:24 INFO - 'HOME': '/Users/cltbld', 19:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:24 INFO - 'LOGNAME': 'cltbld', 19:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:24 INFO - 'MOZ_NO_REMOTE': '1', 19:47:24 INFO - 'NO_EM_RESTART': '1', 19:47:24 INFO - 'PAGER': '/bin/cat', 19:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:24 INFO - 'PWD': '/builds/slave/test', 19:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:24 INFO - 'SHELL': '/bin/bash', 19:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:24 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:24 INFO - 'USER': 'cltbld', 19:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:24 INFO - 'XPC_FLAGS': '0x0', 19:47:24 INFO - 'XPC_SERVICE_NAME': '0', 19:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:47:24 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-BAbDpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:47:24 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-mjxEL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:47:24 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-6A8xok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:47:24 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-1OkvxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:47:24 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-9GMk55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:47:24 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-Sa26pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:47:24 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-uw7Q5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:47:24 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-_6IQVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-m23x0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-H_w0QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-ueaA8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-gpKX5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-qi0cCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-732mAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-GHNLlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-aeGY5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:47:25 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-oWisyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:47:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:47:26 INFO - Running setup.py install for manifestparser 19:47:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:47:26 INFO - Running setup.py install for mozcrash 19:47:26 INFO - Running setup.py install for mozdebug 19:47:26 INFO - Running setup.py install for mozdevice 19:47:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:47:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:47:26 INFO - Running setup.py install for mozfile 19:47:26 INFO - Running setup.py install for mozhttpd 19:47:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:47:26 INFO - Running setup.py install for mozinfo 19:47:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Running setup.py install for mozInstall 19:47:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Running setup.py install for mozleak 19:47:27 INFO - Running setup.py install for mozlog 19:47:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Running setup.py install for moznetwork 19:47:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Running setup.py install for mozprocess 19:47:27 INFO - Running setup.py install for mozprofile 19:47:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:47:27 INFO - Running setup.py install for mozrunner 19:47:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:47:28 INFO - Running setup.py install for mozscreenshot 19:47:28 INFO - Running setup.py install for moztest 19:47:28 INFO - Running setup.py install for mozversion 19:47:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:47:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:47:28 INFO - Cleaning up... 19:47:28 INFO - Return code: 0 19:47:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:28 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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:28 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 19:47:28 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 19:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:28 INFO - 'HOME': '/Users/cltbld', 19:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:28 INFO - 'LOGNAME': 'cltbld', 19:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:28 INFO - 'MOZ_NO_REMOTE': '1', 19:47:28 INFO - 'NO_EM_RESTART': '1', 19:47:28 INFO - 'PAGER': '/bin/cat', 19:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:28 INFO - 'PWD': '/builds/slave/test', 19:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:28 INFO - 'SHELL': '/bin/bash', 19:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:28 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:28 INFO - 'USER': 'cltbld', 19:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:28 INFO - 'XPC_FLAGS': '0x0', 19:47:28 INFO - 'XPC_SERVICE_NAME': '0', 19:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:47:28 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-8Luzei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:47:28 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)) 19:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:47:28 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-762N4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-i5svhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-_M3Pls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-TQ85Z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-7x6xYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-fBicFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-q6C8hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-pXTP9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-NUZxwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:47:29 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)) 19:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:47:29 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-4l6QkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:47:30 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)) 19:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:47:30 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-6B5gb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:47:30 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)) 19:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:47:30 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-LKKJDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:47:30 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)) 19:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:47:30 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-79FXSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:47:30 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)) 19:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:30 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-xKAMvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:30 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)) 19:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:47:30 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-4x_ziF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:47:30 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)) 19:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:47:30 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-H2Yyeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:47:30 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)) 19:47:30 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)) 19:47:30 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)) 19:47:30 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)) 19:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:30 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)) 19:47:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 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 19:47:33 INFO - Downloading blessings-1.6.tar.gz 19:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:47:33 INFO - Installing collected packages: blessings 19:47:33 INFO - Running setup.py install for blessings 19:47:33 INFO - Successfully installed blessings 19:47:33 INFO - Cleaning up... 19:47:33 INFO - Return code: 0 19:47:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:47:33 INFO - Reading from file tmpfile_stdout 19:47:33 INFO - Current package versions: 19:47:33 INFO - blessings == 1.6 19:47:33 INFO - blobuploader == 1.2.4 19:47:33 INFO - docopt == 0.6.1 19:47:33 INFO - functools32 == 3.2.3-2 19:47:33 INFO - jsonschema == 2.5.1 19:47:33 INFO - manifestparser == 1.1 19:47:33 INFO - mozInstall == 1.12 19:47:33 INFO - mozcrash == 0.17 19:47:33 INFO - mozdebug == 0.1 19:47:33 INFO - mozdevice == 0.48 19:47:33 INFO - mozfile == 1.2 19:47:33 INFO - mozhttpd == 0.7 19:47:33 INFO - mozinfo == 0.9 19:47:33 INFO - mozleak == 0.1 19:47:33 INFO - mozlog == 3.4 19:47:33 INFO - moznetwork == 0.27 19:47:33 INFO - mozprocess == 0.23 19:47:33 INFO - mozprofile == 0.28 19:47:33 INFO - mozrunner == 6.12 19:47:33 INFO - mozscreenshot == 0.1 19:47:33 INFO - mozsystemmonitor == 0.3 19:47:33 INFO - moztest == 0.7 19:47:33 INFO - mozversion == 1.4 19:47:33 INFO - psutil == 3.1.1 19:47:33 INFO - requests == 1.2.3 19:47:33 INFO - wsgiref == 0.1.2 19:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:47:33 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')]} 19:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:33 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')]} 19:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:33 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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:33 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 19:47:33 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 19:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:33 INFO - 'HOME': '/Users/cltbld', 19:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:33 INFO - 'LOGNAME': 'cltbld', 19:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:33 INFO - 'MOZ_NO_REMOTE': '1', 19:47:33 INFO - 'NO_EM_RESTART': '1', 19:47:33 INFO - 'PAGER': '/bin/cat', 19:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:33 INFO - 'PWD': '/builds/slave/test', 19:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:33 INFO - 'SHELL': '/bin/bash', 19:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:33 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:33 INFO - 'USER': 'cltbld', 19:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:33 INFO - 'XPC_FLAGS': '0x0', 19:47:33 INFO - 'XPC_SERVICE_NAME': '0', 19:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 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)) 19:47:34 INFO - Cleaning up... 19:47:34 INFO - Return code: 0 19:47:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:34 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 0x100a61490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9704961e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, '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.IAnvpvqKST/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.wS5ydMkKPi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 19:47:34 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 19:47:34 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 19:47:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:47:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:34 INFO - 'HOME': '/Users/cltbld', 19:47:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:34 INFO - 'LOGNAME': 'cltbld', 19:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:34 INFO - 'MOZ_NO_REMOTE': '1', 19:47:34 INFO - 'NO_EM_RESTART': '1', 19:47:34 INFO - 'PAGER': '/bin/cat', 19:47:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:34 INFO - 'PWD': '/builds/slave/test', 19:47:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:34 INFO - 'SHELL': '/bin/bash', 19:47:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:47:34 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:47:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:34 INFO - 'USER': 'cltbld', 19:47:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:34 INFO - 'XPC_FLAGS': '0x0', 19:47:34 INFO - 'XPC_SERVICE_NAME': '0', 19:47:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:47:34 INFO - Cleaning up... 19:47:34 INFO - Return code: 0 19:47:34 INFO - Running post-action listener: _resource_record_post_action 19:47:34 INFO - Running post-action listener: _start_resource_monitoring 19:47:34 INFO - Starting resource monitoring. 19:47:34 INFO - [mozharness: 2016-11-09 03:47:34.400915Z] Finished create-virtualenv step (success) 19:47:34 INFO - [mozharness: 2016-11-09 03:47:34.401870Z] Running install step. 19:47:34 INFO - Running pre-action listener: _resource_record_pre_action 19:47:34 INFO - Running main action method: install 19:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:47:34 INFO - Reading from file tmpfile_stdout 19:47:34 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:47:34 INFO - Reading from file tmpfile_stdout 19:47:34 INFO - Output received: 19:47:34 INFO - Usage: mozinstall [options] installer 19:47:34 INFO - Options: 19:47:34 INFO - -h, --help show this help message and exit 19:47:34 INFO - -d DEST, --destination=DEST 19:47:34 INFO - Directory to install application into. [default: 19:47:34 INFO - "/builds/slave/test"] 19:47:34 INFO - --app=APP Application being installed. [default: firefox] 19:47:34 INFO - mkdir: /builds/slave/test/build/application 19:47:34 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'] 19:47:34 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 19:48:06 INFO - Reading from file tmpfile_stdout 19:48:06 INFO - Output received: 19:48:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:48:06 INFO - Running post-action listener: _resource_record_post_action 19:48:06 INFO - [mozharness: 2016-11-09 03:48:06.484018Z] Finished install step (success) 19:48:06 INFO - [mozharness: 2016-11-09 03:48:06.484171Z] Running run-tests step. 19:48:06 INFO - Running pre-action listener: _resource_record_pre_action 19:48:06 INFO - Running main action method: run_tests 19:48:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:48:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:48:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:48:06 INFO - 2016-11-08 19:48:06.498 screenresolution[1639:7533] starting screenresolution argv=screenresolution get 19:48:06 INFO - 2016-11-08 19:48:06.501 screenresolution[1639:7533] Display 0: 1600x1200x32@60 19:48:06 INFO - 2016-11-08 19:48:06.507 screenresolution[1640:7536] starting screenresolution argv=screenresolution list 19:48:06 INFO - Available Modes on Display 0 19:48:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:48:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:48:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:48:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:48:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:48:06 INFO - Intel Iris: 19:48:06 INFO - Chipset Model: Intel Iris 19:48:06 INFO - Type: GPU 19:48:06 INFO - Bus: Built-In 19:48:06 INFO - VRAM (Dynamic, Max): 1536 MB 19:48:06 INFO - Vendor: Intel (0x8086) 19:48:06 INFO - Device ID: 0x0a2e 19:48:06 INFO - Revision ID: 0x0009 19:48:06 INFO - Displays: 19:48:06 INFO - Display: 19:48:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:48:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:48:06 INFO - Display Serial Number: 1600x1200 60 19:48:06 INFO - Main Display: Yes 19:48:06 INFO - Mirror: Off 19:48:06 INFO - Online: Yes 19:48:06 INFO - Rotation: Supported 19:48:06 INFO - Return code: 0 19:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:48:06 INFO - Python 2.7.3 19:48:06 INFO - Return code: 0 19:48:06 INFO - grabbing minidump binary from tooltool 19:48:06 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')]} 19:48:06 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 0x100875d30>, '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 0x1006dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10086db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:48:06 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 19:48:06 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 19:48:06 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 19:48:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:48:06 INFO - Return code: 0 19:48:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:48:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:48:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:48:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:48:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:48:06 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-0066', '--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 19:48:06 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-0066 --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 19:48:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IAnvpvqKST/Render', 19:48:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:06 INFO - 'HOME': '/Users/cltbld', 19:48:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:06 INFO - 'LOGNAME': 'cltbld', 19:48:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:48:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:06 INFO - 'MOZ_NO_REMOTE': '1', 19:48:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:48:06 INFO - 'NO_EM_RESTART': '1', 19:48:06 INFO - 'PAGER': '/bin/cat', 19:48:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:06 INFO - 'PWD': '/builds/slave/test', 19:48:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:48:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:06 INFO - 'SHELL': '/bin/bash', 19:48:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS5ydMkKPi/Listeners', 19:48:06 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 19:48:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:06 INFO - 'USER': 'cltbld', 19:48:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:06 INFO - 'XPC_FLAGS': '0x0', 19:48:06 INFO - 'XPC_SERVICE_NAME': '0', 19:48:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:06 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-0066', '--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 19:48:07 INFO - mozversion application_buildid: 20161108173621 19:48:07 INFO - mozversion application_changeset: ae3b6bfb810476141647ad681b796ed118062412 19:48:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:48:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:48:07 INFO - mozversion application_name: Firefox 19:48:07 INFO - mozversion application_remotingname: firefox-dev 19:48:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:48:07 INFO - mozversion application_vendor: Mozilla 19:48:07 INFO - mozversion application_version: 51.0a2 19:48:07 INFO - mozversion platform_buildid: 20161108173621 19:48:07 INFO - mozversion platform_changeset: ae3b6bfb810476141647ad681b796ed118062412 19:48:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:48:07 INFO - mozversion platform_version: 51.0a2 19:48:07 INFO - using testdate: 1478663287 19:48:07 INFO - actual date: 1478663287 19:48:07 INFO - starting webserver on 'localhost:49272' 19:48:07 INFO - SUITE-START | Running 2 tests 19:48:07 INFO - TEST-START | dromaeo_css 19:48:07 INFO - operating with platform_type : mac_ 19:48:07 INFO - Initialising browser for dromaeo_css test... 19:48:07 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpd8s6rZ/profile http://localhost:49272/getInfo.html) 19:48:09 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 19:48:09 INFO - PROCESS | 1650 | colorDepth:24 19:48:09 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 19:48:09 INFO - PROCESS | 1650 | __metrics 19:48:09 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 19:48:10 INFO - TEST-INFO | 1650: exit 0 19:48:10 INFO - Browser initialized. 19:48:10 INFO - Running cycle 1/1 for dromaeo_css test... 19:48:10 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpd8s6rZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:48:22 INFO - PROCESS | 1653 | RSS: Main: 225804288 19:48:22 INFO - PROCESS | 1653 | 19:49:12 INFO - PROCESS | 1653 | 1478663352027 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] 19:51:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 19:51:26 INFO - PROCESS | 1653 | RSS: Main: 237506560 19:51:26 INFO - PROCESS | 1653 | 19:54:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 19:54:29 INFO - PROCESS | 1653 | RSS: Main: 249233408 19:54:29 INFO - PROCESS | 1653 | 19:57:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 19:57:31 INFO - PROCESS | 1653 | RSS: Main: 253358080 19:57:31 INFO - PROCESS | 1653 | 20:00:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 20:00:34 INFO - PROCESS | 1653 | RSS: Main: 253943808 20:00:34 INFO - PROCESS | 1653 | 20:03:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 20:03:37 INFO - PROCESS | 1653 | RSS: Main: 257978368 20:03:37 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 20:06:40 INFO - PROCESS | 1653 | RSS: Main: 260550656 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | __start_tp_report 20:06:40 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 20:06:40 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 20:06:40 INFO - PROCESS | 1653 | |i|pagename|runs| 20:06:40 INFO - PROCESS | 1653 | |0;dojo.html;3117.922051948701;3365.158710322419;3383.407903616865;3396.1000334911237;3400.8979730608085;5632.887342253158;5714.171445140458;5720.399358067395;5724.398938111491;5729;5711.7715291388295;5749.022666146755;5803.390643982384;5813.854653633651;5825.679587622679;5236.109861323565;5300.946990530084;5304.6286759926825;5339.279197308352;5340.973295133538;5307.124324486455;5334.546563542103;5342.813001544947;5347.331583552056;5371.543418809406;5139.4346621871755;5149.201873709581;5319.867003324928;5332.866678333034;5339.145736682131;4331.610155086026;5235.136202526579;5240.3187585614005;5350.625456218067;5368.328958880101;5215.791368345262;5272.31459910213;5299.867503312409;5305.65513241638;5324.627276090675;5757.481826635623;5779.9422005779825;5906.586538942276;5906.9704651476895;5929.258842644669;5480.451954804527;6008.36912124225;6113.567524283673;6130.27584246411;6183.258009038944;6233.563650544464;6256.217972753406;6276.278228003793;6287.151234583364;6296.842578935518;5914.822555323347;5936.614942757976;5946.405359464062;5954.702264886825;5975.701214939236;6153.507719382439;6155.045967874987;6195.101710251988;6227.439530442282;6317.936820631735;6215.9378406216265;6252.531060170414;6261.499080073583;6262.843428914313;6297.968510157511;6300.558960872695;6302.621842689453;6306.148669929501;6307.306196318401;6320.209973753281;5712.686082201117;5802.912956305574;6169.105479705418;6178.320384757763;6237.251529816361;5633.352164501053;6127.617148554337;6232.376762323732;6245.0632405139595;6317.526185536103;4995.225740010304;4996.725180115056;4998.975005124951;5003.099442100457;5045.344105266292;3549.2369140634373;4405.273129933589;4485.573870482299;4507.6168525675685;4525.981654127795;5778.711064446845;5872.060470324727;5941.732622032019;5997.220361352996;6031.366706495843;6223.533235007302;6246.312905580383;6276.309605943343;6294.779682711083;6340.746370145235;5816.447437493432;5863.355030946593;5909.054551271776;5944.048952167633;6007.879842403127;5412.485813847678;5458.4814442627885;5507.366652834895;5521.089020311684;5523.834284971457;6150.969245153746;6333.936660633335;6340.558884829282;6363.236411630634;6368.426841584094;6166;6175.475084617858;6175.783847565313;6212.658303793335;6225.3774622537385;6174.351693072163;6274.623522588659;6309.400606942333;6311.179546658905;6318.6840657965995;6129.8784197560135;6162.876742465036;6166.876662466815;6257.405546473078;6272.18461599989;6202.844928876814;6244.406781355764;6278.058291256348;6289.433950944437;6293.433590976834;5997.850053748692;6204.286507051746;6205.968970155121;6209.565330426827;6214.316425193316;5221.556167725786;6052.364501727256;6067.605605635619;6113.354685976905;6135.509159267337;5956.642601443928;6108.205933228652;6127.111568822406;6128.448439640454;6135.93706321624;5149.330587023663;6196.1635179252025;6201.131841542097;6224.035274532454;6231;5878.882422351444;5899.734511946886;5952.821415357546;6057.818265452043;6091.147239386578 20:06:40 INFO - PROCESS | 1653 | |1;ext.html;478.2324369387136;509.94645562215965;519.5687579309173;526.702413136578;533.810497273468;40606.390904136424;42604.57395426045;42612.360814587766;42655.36016959748;42755.14489710212;43630;43812.3428148578;43907.560924390746;44019.779901100526;44025.11949761003;9841.45871977041;9986.900130998669;9992.150667193297;10011.399316041025;10020.59917603295;9864.950675246613;9957.402555846636;9969.152622027137;9980.251481138906;10031.247656425761;9940.850887236662;9983.351082179672;9993.100620944113;10009.099181073701;10010;9970.252231082697;9995.300328976975;10001.399916005063;10001.59993600255;10025.09774120329;9986.500674966223;10032.297739158263;10049.095581397709;10069;10091.495425228783;40896.79551602223;40943.795281023406;41096.178076438606;41311.7934410329;41399.586004140176;3371.342588195303;3711.66595006448;3714.294284086015;3767.660910518039;4040.6161414665853;25904.51723399702;27738.02916897899;28453.861845526153;31247.687523124707;31357.0118859073;2951.8819247230085;3085.197848559368;3109.160526657812;3120.9219769505717;3289.3092450585405;487056;498502;499937;500134;501489.99999999633;59595;59861.401385985584;59967.70016149891;60093;60124.09813852796;51087.74456127696;62873.685631572465;62934;63082;63087;16869.072201028815;17088.487345379657;17109.315627375014;17127.14364281781;17158;13344.933275333562;13352;13379.197248165141;13393.598192054254;13423.530176443777;15150.939434239497;16104.355825766837;16211.51365459038;16214.270357833926;16248;2992.4314380268115;6971.81479148546;7140.464465165133;7329.963350183321;7364.189939106694;919.5540163020929;988.560090759605;1026.6047571684805;1035.9015893490107;1107.6067995861515;26044.218673439827;26199;28735.56896646552;29285;29639.851800740857;970.9223262139153;975.6975337645353;1059;1092.126298960828;1146.8853114688463;15686.450974215848;15780.289886955115;15887.443939462064;15930.203489825462;15999.680006399807;692845;700031.4998424975;706044;714293;715801;58306.416935830945;58914.11628825571;58920.41079589235;58926;58955.410445895846;1376.2636989210923;1389.534505940501;1393.4078016842802;1393.4983405973842;1397.7623803953556;29713.702862971957;30221.395572088873;30354.392912142077;30369.937052203066;30693.23266918345;50861.74569127131;50991.74504127455;51222;51247.74376128095;51510;629255;632594;633101.8344908246;633627;635541;26530;26579.069732559266;26893.731062689123;26979.325516862235;27027.459450811268;46814.76592617015;47007;47165.05669886514;47719.76140119416;47856.76071619619;38116.42825357677;39900.60099398969;39992.80003599964;41031;41511;39260.411093834184;39431.408528871514;39491.21017579575;40521;40930;38244.852654420414;38445.038874028374;38563.614363856;39065.80467097646;39459.81620551388;26649.866750666122;31274.687253128086;35312.47031294584;35524.822375887954;35756.64243357637;26060.34849128787;26270.21189364322;26318.86840565785;26449.867750661124;26951.460970780867 20:06:40 INFO - PROCESS | 1653 | |2;jquery.html;378.57599488572805;379.33237501996496;384.71915501683753;387.35698740091453;409.29601086131845;19779.208831646734;21238.51330406872;21377.786222137773;21457;21651.350459486202;20099.497512562193;20668.48328791781;20718.792812071875;20845.687314690254;21087.47281317964;5654.660720356771;5964.7912323068595;6102.48128909041;6199.845003874917;6207.441330280274;4188.769617671027;4429.13631841791;6047.5766696331275;6144.754209831602;6515.3484651534945;6716.496262780287;6844.4182244509275;6855.1088358513325;6857.554258973176;6872.931270687304;6588.8023359299295;6798.674258519591;6833.282505336918;6847.520673552854;6861.416779573742;5806.1581070744505;5841.532677385799;5851.76592936282;5865.560082993792;5914.674692891889;26263;26426.603600945808;26542;26589.20232393012;26724.599131013052;2290.459234096663;2400.84394514356;2465.864377459239;2467.9506409871883;2750.40866213765;13183;15578.454754083667;15764.896457247882;15826.525204243891;16247.756283655755;1561.9687606247812;1708.5728567858037;1714.8885322454125;1827.6892928202237;1835.4034938644993;89639;112843;113923.43038284838;115479.4226028873;115552;10444.425556594308;10528.842067368996;10681.145508359312;11096.833547496793;11342.035926946302;13579.185248885098;13608.115472494255;13612.319384030958;13613.319334033258;13617.455301787817;8560.828783424296;8765.816614756926;8779.780505487413;8830.779230519289;8930.776730581658;8972.820543589092;8999.55002249898;9015.909840901639;9036.909630903607;9159.816803664022;6584.111144995364;6590.373914478117;6602.7689030883685;6620.503462240351;6649.534532582769;1549.8527639874194;1678.966420671604;1682.6382327799581;1847.5196448923377;1961.8038196180553;880.8942926848819;896.1665650944553;900.2797761790541;928.3779867488798;1077.5851297250458;15613.297401616954;20822;20832.687509687366;20904;21048.473788155417;947.2942657720042;954.1079091049891;957.9856302155473;958.7986522830283;978.9902100979042;11009.724756880982;11015.449227538591;11104.056155226895;11177.720556985978;11179.273347232403;559999;609379;615818;624265;627841;75819;117981;127567.36216319045;134797.3260133693;137174;842.4439869685978;965.6378857928277;989.8663680403198;990.9256805739599;1007.6473234367912;13959.720805583629;14525.346359414063;17349.210766967375;18254.45236642903;18664.253429863198;38670.646527371406;48729.5127048725;49033;50612;50908.727281818254;68296.65851670908;68730.9690354655;71124;71288.64355678188;73413.63293183714;6999.265077166824;7211.350978411968;7374.225706300761;7407.2592740725495;7408.333250007525;11062;12978.156419832681;13035.217886926815;13127.540536081191;13319.467221311039;7660.157382688011;9582.137607615348;10876.510557024794;11415.885841141482;11542.19204655666;10422;11029.779404412027;11108.277961932448;11165.330080195214;11197.384143872165;11316.37759923212;11464.082873370277;11514.88485115138;11692.479977602858;11724.120690948042;8003.639836207268;8179.83640327202;8224.958875205586;8257.38069644767;8284.83430331402;9622.615095396106;10887.891121088687;11185.72035699114;11208.607698730506;11358.432078396212 20:06:40 INFO - PROCESS | 1653 | |3;mootools.html;1495.5139579636618;1499.310317254063;1692.9915350423246;1728.343229572762;1746.8645380502664;8087.636056377462;8332.750017499484;8541.273991710705;9043.502607356593;9067.682631107904;8561.48631082134;8860.645574177026;8895.33285003624;8975.506347150904;8985.640574377034;2409.072507084772;2436.317831007321;2437.8293519453646;2446.0338166424253;2446.779789818916;2407.6508906208587;2415.2029830156007;2431.6474111253856;2433.3308340206495;2440.5973014452593;2087.7912208779076;2419.758024197584;2420.576399130154;2435.6224785158242;2439.48770758141;2012.6578481658153;2095.287602215254;2406.68713067301;2416.2026531244646;2420.4432980414604;2208.7570367259586;2411.168146989286;2419.0928401849305;2421.225207933462;2427.6237183236626;7167.569945803217;7956.6871466208;8605.655773769042;8645.308375330022;8668.60991255395;5296.3909150447425;5426.050441172779;5439.184122381675;5449.536789372908;5476.658218736396;3675.72432067596;3691.963080369189;3711.1464363196346;3712.7401081924277;3736.645018723217;1067.1356201476829;1069.091272418446;1074.3285446595878;1089.487940667885;1093.4805967165612;11711.941440292829;11784;11820.23168494045;11846.17076804624;11856;4723.929141062887;4754.808661738747;4766.833160839424;4868.878278043077;4921.3356196912955;9936.254780891317;10043.799124017478;10060.748481288027;10062.396256224503;10074.74813129663;5437.564994800407;5442.727863606804;5445.482679145475;5451.618386712971;5454.127339625641;4447.199504089231;4569.634429245652;4729.337892695025;4843.515648435128;4972.552470277692;3957.149212919236;3966.1076257841755;4055.371417430303;4064.8170832312617;4081.9387709184384;1312.199558269474;1316.4339334086244;1317.433503593464;1328.1698938163647;1350.8514063453013;909.3816204980677;922.7847725676695;927.8840144981878;930.181440332503;952.6379975609224;5722.227499287626;5801.6519008859605;5832.825015249465;6008.459238668541;6096.756129754849;446.7475876129976;454.4887002122612;461.43704680289994;462.01360096194196;467.2920525404016;3964.6431821136234;3967.682585393162;3994.420808982681;4020.155767288902;4052.5542190359038;10601.363918164934;10904.672859814218;10983.890161098447;10987.890121098686;11027.393493357942;10967.616133435291;10972.451377431256;10978.670639880816;10991.61529346469;11100.389478578594;8220.753377398687;8224.876626850602;8274.627641756015;8426.747197584082;8449.408541402167;5659.660420374791;5763.6541807491685;5823.068309070529;5840.474357307863;5865.794697185578;10009.399436033862;10035.899641003789;10151.593936242763;10314.845277320695;10394.168466522811;9996.750081248027;10242.6415075472;10292.742681433025;10315.587376504856;10470.581176752845;6174.475169610633;7034.402075823612;7253.347198752138;7619.847603048019;7747.2640099190485;8310.542920139209;8565.357598180037;8568.14318568163;8569.82860342802;8580.584203606584;6470.676466176578;6844.007618895332;7500.474966752275;7663.386929045774;7749.612519374122;6799.626020568916;7454.217307182667;7474.289942455458;7481.850362992601;7520.210377910241;5943.91084133747;6986.126734158231;7040.929590704028;7047.682854271673;7048;4999.350084488993;5035.748212589429;5037.0681423936685;5067.315912351933;5071.594272458268;4814.470408255019;4824.589909857701;4850.102730994778;4938.802447902043;4965.006998600222 20:06:40 INFO - PROCESS | 1653 | |4;prototype.html;296.16776857031743;303.17838657238883;315.95260710893365;319.24020830423586;320.2234581140733;4711.78796954137;4796.136695394827;4998.775055122519;5423;5545.445455454453;5488.463230295523;5522.723863806814;5537.556995440365;5556.638818476807;5568.9443105568935;3422.4524076147823;3962.9603703963026;4208.705390622666;4217.848897062505;4242.639375653073;3336.816475093869;4179.770112643803;4245.405643209938;4245.7240279381895;4272.9359059614135;3624.601293857687;4145.274576949037;4184.4978602567735;4212.525616034379;4229.281022226213;4207.242696314662;4218.936715949263;4222;4223.472065991751;4227.32362821947;3337.8331083445732;3454.654534546525;3642.8542858285637;3664.285464334456;3691.8338674759702;4113.2980317714;4903.534164254425;5282.464417079823;5326.627136100475;5334.653247538898;4010.2555388405844;4062.512498500199;4822.565969062766;4847.6911233966985;4853.830115945961;5095.949040509585;5883.294004719418;5919.437653422918;5931.991561434566;5934.317553481319;3960.564337922855;3984.86052988144;3995.380715989026;4002.3990403838407;4030.0126469014986;6106.603070800384;6135.32511423743;6163.784267550659;6164.506839452878;6173.660448675366;3198.2484116232667;3664.230511592542;4036.6972477064337;4061.289274376972;4065.9796701016307;3268.6077670679197;3810.904727381838;3882.456456096149;4076.6331030207425;4112.979435102805;4255.5318914919335;4257.57424257578;4781.354517140211;4810.735409552438;4876.219804831281;5297.602679799031;5571.164325351148;5740.454656807597;5944.970275148683;5968.1942937703725;1221.2550344289975;1280.9167404118703;1323.907776084734;1412.6256542016374;1422.7865820126856;766.6856588798565;839.6137776622822;850.6342272822621;888.8089060851947;891.9965039330752;4418.387288639623;4640.303954406866;4710.858674239778;4714.717116972924;4733.905321893543;4155.815592556107;4683.454460028182;4933.55597996182;5093.9690883924;5099.506837816034;4262.65898728101;4402.569165021381;4586.844183233875;4687.820163623931;4699.814586217425;2379.7382287948312;2449.755024497536;2572.524083044643;2607.8565678887844;2679.678438587382;4878.585320247818;4904.60763138948;5121.443234090979;5196.740162991835;5324.361076670824;4782.593479554207;4834.6882385565295;4845.200541910545;4914.70511769295;5021.84934451967;4928.4475390251955;5009.148444764399;5202.60980426462;5217.321748172713;5273.288106105627;4402.3176407656865;5081;5125.641205115606;5159.484051594811;5163.967206558628;4398.957284199215;4515.277555591089;4524;4834.468208497133;5052.873678158076;5034.219695947134;5203.747657713929;5270.420253772006;5310.911263190959;5339.813106541253;2889.465448891962;3580.391333473264;3588.3899737045285;3589.9282014359046;3596.4605309202784;4720.032393359422;4878.9512104878495;4960.5772017307945;5154.61340399479;5760.740766665426;5098.311727916832;5138.332016837787;5830.300363956183;5850.12248162779;5920.881582368243;5844.3571207168025;5848.537865533616;5857.297124345106;5896.64620122794;5927.947107239861;5071.492850714899;5505.862353441196;5690.260266165372;5747.9137812932;5755.740991655469;5136.357955255593;5614.848955964099;5647.181158731879;5802.47777700009;5955.213435969278;4616.907661846677;5695.829125126253;5805.912911306418;5819.621724587888;5829.387914268941 20:06:40 INFO - PROCESS | 1653 | |5;yui.html;772.1853444615928;781.7068599275271;793.674593416699;817.4073796497544;824.241697638173;15033.323500442479;15545.067295962222;15613.843861561381;15631.374745010215;15682.764758528618;13032.152910060862;14035.438582456714;14064.015518913655;14083.507077252298;14103.71792564148;840.9873851892211;846.6190214403543;880.6125304865839;889.9777505562348;893.2228960804077;864.5461132905212;883.9381243312971;884.8230353929208;887.0863011098546;887.1660638999319;909.5225006871412;910.0944560162648;911.9589618467152;917.0874979395478;917.6512925088457;895.5790778334173;902.3683421604903;906.1663269791808;906.9410488318272;907.3149771922157;648.52657559981;665.0722242471774;678.1895634716516;678.5148618737577;683.5864302097259;15163.696726065416;15233.771493427608;15248.08511489303;15249;15261.465848695354;14062.296885155803;14109.717805643932;14248;14262.357811249813;14370.425182992667;11633.650990470214;11725.120615953752;11828.231164974335;11924.940375298154;11933.641990740205;3710.5361829771277;3814.5422549293985;3818;3926.9410958835356;3932.46911666927;127101;129751.35124324412;130069;131261;131394;10366.274360794823;10446.791064178673;10967.122630189566;10973.50619222137;10990.670279891616;22123.115075396803;22127.557448850934;22158.667619985714;22183.778162218496;22210;7541.170471248159;7753.728619498291;7850.175731548219;8165.346772258205;8168.9183108169345;3974.5627980922077;4444.066745983315;4521.660875434355;4546.795394207269;4563.995920897397;3598.2803439312243;3725.701943844486;3778.471014058034;3783.1677031053123;3791.7914514701956;542.1894268069261;605.35832018061;651.1437459740426;687.8039758668856;698.8252936765808;497.8954419571858;670.9698063587052;694.6110178300169;698.6297262450909;698.9336013078749;7687.384969515411;9139.040400757825;9371.344005919656;9372.43765374066;9505.287103467268;650.0833824307704;655.9111874288658;669.8311446525844;688.7066069986931;696.1437431958618;4569.680122391467;4673.088747694167;4684.110019096361;4690.53094690535;4737.881552961204;99150.01699965961;128097;155791;159936;162948.1852590753;118798.24807007796;134347;136525;136623.31688341495;142948.2852585751;112023.43988280007;114439;114460.42769786097;116293.41853290849;116443;8992.550372481219;9018.278537717099;9026.548672566476;9057.864132038156;9069.727908162766;60274.698626506586;64028;64170.35829641644;64836.67581662061;65735.34264657293;88872;99126;102522.48738756258;104084;105678;11300.94349528247;11631.360275184947;11666.533338666697;11709.297442153498;11846.170768046153;12947.870521294666;13017;13017.934910325388;13140.540081097115;13343.199408035161;12014.75970480568;12015.219010764273;12086.818697719365;12136.33250171249;12485.31330776816;11941.52233910634;11947.342896140795;12109.818352724893;12188;12737.426815793497;11815;11948.522059117538;11977.461014254206;11984;12146.271223726604;9545.93977309407;9774.087141381166;9853.950730246303;10087.69736907894;10310.43292618913;9395.530223488935;10535.841962370418;10544.789104218025;10586.153107751208;10703.678889633324 20:06:40 INFO - PROCESS | 1653 | __end_tp_report 20:06:40 INFO - PROCESS | 1653 | __start_cc_report 20:06:40 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,370 20:06:40 INFO - PROCESS | 1653 | __end_cc_report 20:06:40 INFO - PROCESS | 1653 | __startTimestamp1478664400293__endTimestamp 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | ------- Summary: start ------- 20:06:40 INFO - PROCESS | 1653 | Number of tests: 6 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5768.39 Median:5997.22 stddev:654.44 (10.9%) stddev-sans-first:622.54 20:06:40 INFO - PROCESS | 1653 | Values: 3117.9 3365.2 3383.4 3396.1 3400.9 5632.9 5714.2 5720.4 5724.4 5729.0 5711.8 5749.0 5803.4 5813.9 5825.7 5236.1 5300.9 5304.6 5339.3 5341.0 5307.1 5334.5 5342.8 5347.3 5371.5 5139.4 5149.2 5319.9 5332.9 5339.1 4331.6 5235.1 5240.3 5350.6 5368.3 5215.8 5272.3 5299.9 5305.7 5324.6 5757.5 5779.9 5906.6 5907.0 5929.3 5480.5 6008.4 6113.6 6130.3 6183.3 6233.6 6256.2 6276.3 6287.2 6296.8 5914.8 5936.6 5946.4 5954.7 5975.7 6153.5 6155.0 6195.1 6227.4 6317.9 6215.9 6252.5 6261.5 6262.8 6298.0 6300.6 6302.6 6306.1 6307.3 6320.2 5712.7 5802.9 6169.1 6178.3 6237.3 5633.4 6127.6 6232.4 6245.1 6317.5 4995.2 4996.7 4999.0 5003.1 5045.3 3549.2 4405.3 4485.6 4507.6 4526.0 5778.7 5872.1 5941.7 5997.2 6031.4 6223.5 6246.3 6276.3 6294.8 6340.7 5816.4 5863.4 5909.1 5944.0 6007.9 5412.5 5458.5 5507.4 5521.1 5523.8 6151.0 6333.9 6340.6 6363.2 6368.4 6166.0 6175.5 6175.8 6212.7 6225.4 6174.4 6274.6 6309.4 6311.2 6318.7 6129.9 6162.9 6166.9 6257.4 6272.2 6202.8 6244.4 6278.1 6289.4 6293.4 5997.9 6204.3 6206.0 6209.6 6214.3 5221.6 6052.4 6067.6 6113.4 6135.5 5956.6 6108.2 6127.1 6128.4 6135.9 5149.3 6196.2 6201.1 6224.0 6231.0 5878.9 5899.7 5952.8 6057.8 6091.1 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:73962.39 Median:39475.51 stddev:165581.78 (419.5%) stddev-sans-first:165954.36 20:06:40 INFO - PROCESS | 1653 | Values: 478.2 509.9 519.6 526.7 533.8 40606.4 42604.6 42612.4 42655.4 42755.1 43630.0 43812.3 43907.6 44019.8 44025.1 9841.5 9986.9 9992.2 10011.4 10020.6 9865.0 9957.4 9969.2 9980.3 10031.2 9940.9 9983.4 9993.1 10009.1 10010.0 9970.3 9995.3 10001.4 10001.6 10025.1 9986.5 10032.3 10049.1 10069.0 10091.5 40896.8 40943.8 41096.2 41311.8 41399.6 3371.3 3711.7 3714.3 3767.7 4040.6 25904.5 27738.0 28453.9 31247.7 31357.0 2951.9 3085.2 3109.2 3120.9 3289.3 487056.0 498502.0 499937.0 500134.0 501490.0 59595.0 59861.4 59967.7 60093.0 60124.1 51087.7 62873.7 62934.0 63082.0 63087.0 16869.1 17088.5 17109.3 17127.1 17158.0 13344.9 13352.0 13379.2 13393.6 13423.5 15150.9 16104.4 16211.5 16214.3 16248.0 2992.4 6971.8 7140.5 7330.0 7364.2 919.6 988.6 1026.6 1035.9 1107.6 26044.2 26199.0 28735.6 29285.0 29639.9 970.9 975.7 1059.0 1092.1 1146.9 15686.5 15780.3 15887.4 15930.2 15999.7 692845.0 700031.5 706044.0 714293.0 715801.0 58306.4 58914.1 58920.4 58926.0 58955.4 1376.3 1389.5 1393.4 1393.5 1397.8 29713.7 30221.4 30354.4 30369.9 30693.2 50861.7 50991.7 51222.0 51247.7 51510.0 629255.0 632594.0 633101.8 633627.0 635541.0 26530.0 26579.1 26893.7 26979.3 27027.5 46814.8 47007.0 47165.1 47719.8 47856.8 38116.4 39900.6 39992.8 41031.0 41511.0 39260.4 39431.4 39491.2 40521.0 40930.0 38244.9 38445.0 38563.6 39065.8 39459.8 26649.9 31274.7 35312.5 35524.8 35756.6 26060.3 26270.2 26318.9 26449.9 26951.5 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:34601.44 Median:14737.50 stddev:100909.22 (684.7%) stddev-sans-first:101159.58 20:06:40 INFO - PROCESS | 1653 | Values: 378.6 379.3 384.7 387.4 409.3 19779.2 21238.5 21377.8 21457.0 21651.4 20099.5 20668.5 20718.8 20845.7 21087.5 5654.7 5964.8 6102.5 6199.8 6207.4 4188.8 4429.1 6047.6 6144.8 6515.3 6716.5 6844.4 6855.1 6857.6 6872.9 6588.8 6798.7 6833.3 6847.5 6861.4 5806.2 5841.5 5851.8 5865.6 5914.7 26263.0 26426.6 26542.0 26589.2 26724.6 2290.5 2400.8 2465.9 2468.0 2750.4 13183.0 15578.5 15764.9 15826.5 16247.8 1562.0 1708.6 1714.9 1827.7 1835.4 89639.0 112843.0 113923.4 115479.4 115552.0 10444.4 10528.8 10681.1 11096.8 11342.0 13579.2 13608.1 13612.3 13613.3 13617.5 8560.8 8765.8 8779.8 8830.8 8930.8 8972.8 8999.6 9015.9 9036.9 9159.8 6584.1 6590.4 6602.8 6620.5 6649.5 1549.9 1679.0 1682.6 1847.5 1961.8 880.9 896.2 900.3 928.4 1077.6 15613.3 20822.0 20832.7 20904.0 21048.5 947.3 954.1 958.0 958.8 979.0 11009.7 11015.4 11104.1 11177.7 11179.3 559999.0 609379.0 615818.0 624265.0 627841.0 75819.0 117981.0 127567.4 134797.3 137174.0 842.4 965.6 989.9 990.9 1007.6 13959.7 14525.3 17349.2 18254.5 18664.3 38670.6 48729.5 49033.0 50612.0 50908.7 68296.7 68731.0 71124.0 71288.6 73413.6 6999.3 7211.4 7374.2 7407.3 7408.3 11062.0 12978.2 13035.2 13127.5 13319.5 7660.2 9582.1 10876.5 11415.9 11542.2 10422.0 11029.8 11108.3 11165.3 11197.4 11316.4 11464.1 11514.9 11692.5 11724.1 8003.6 8179.8 8225.0 8257.4 8284.8 9622.6 10887.9 11185.7 11208.6 11358.4 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5730.16 Median:4726.63 stddev:3245.45 (68.7%) stddev-sans-first:3238.95 20:06:40 INFO - PROCESS | 1653 | Values: 1495.5 1499.3 1693.0 1728.3 1746.9 8087.6 8332.8 8541.3 9043.5 9067.7 8561.5 8860.6 8895.3 8975.5 8985.6 2409.1 2436.3 2437.8 2446.0 2446.8 2407.7 2415.2 2431.6 2433.3 2440.6 2087.8 2419.8 2420.6 2435.6 2439.5 2012.7 2095.3 2406.7 2416.2 2420.4 2208.8 2411.2 2419.1 2421.2 2427.6 7167.6 7956.7 8605.7 8645.3 8668.6 5296.4 5426.1 5439.2 5449.5 5476.7 3675.7 3692.0 3711.1 3712.7 3736.6 1067.1 1069.1 1074.3 1089.5 1093.5 11711.9 11784.0 11820.2 11846.2 11856.0 4723.9 4754.8 4766.8 4868.9 4921.3 9936.3 10043.8 10060.7 10062.4 10074.7 5437.6 5442.7 5445.5 5451.6 5454.1 4447.2 4569.6 4729.3 4843.5 4972.6 3957.1 3966.1 4055.4 4064.8 4081.9 1312.2 1316.4 1317.4 1328.2 1350.9 909.4 922.8 927.9 930.2 952.6 5722.2 5801.7 5832.8 6008.5 6096.8 446.7 454.5 461.4 462.0 467.3 3964.6 3967.7 3994.4 4020.2 4052.6 10601.4 10904.7 10983.9 10987.9 11027.4 10967.6 10972.5 10978.7 10991.6 11100.4 8220.8 8224.9 8274.6 8426.7 8449.4 5659.7 5763.7 5823.1 5840.5 5865.8 10009.4 10035.9 10151.6 10314.8 10394.2 9996.8 10242.6 10292.7 10315.6 10470.6 6174.5 7034.4 7253.3 7619.8 7747.3 8310.5 8565.4 8568.1 8569.8 8580.6 6470.7 6844.0 7500.5 7663.4 7749.6 6799.6 7454.2 7474.3 7481.9 7520.2 5943.9 6986.1 7040.9 7047.7 7048.0 4999.4 5035.7 5037.1 5067.3 5071.6 4814.5 4824.6 4850.1 4938.8 4965.0 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4433.11 Median:4839.94 stddev:1367.18 (28.2%) stddev-sans-first:1335.29 20:06:40 INFO - PROCESS | 1653 | Values: 296.2 303.2 316.0 319.2 320.2 4711.8 4796.1 4998.8 5423.0 5545.4 5488.5 5522.7 5537.6 5556.6 5568.9 3422.5 3963.0 4208.7 4217.8 4242.6 3336.8 4179.8 4245.4 4245.7 4272.9 3624.6 4145.3 4184.5 4212.5 4229.3 4207.2 4218.9 4222.0 4223.5 4227.3 3337.8 3454.7 3642.9 3664.3 3691.8 4113.3 4903.5 5282.5 5326.6 5334.7 4010.3 4062.5 4822.6 4847.7 4853.8 5095.9 5883.3 5919.4 5932.0 5934.3 3960.6 3984.9 3995.4 4002.4 4030.0 6106.6 6135.3 6163.8 6164.5 6173.7 3198.2 3664.2 4036.7 4061.3 4066.0 3268.6 3810.9 3882.5 4076.6 4113.0 4255.5 4257.6 4781.4 4810.7 4876.2 5297.6 5571.2 5740.5 5945.0 5968.2 1221.3 1280.9 1323.9 1412.6 1422.8 766.7 839.6 850.6 888.8 892.0 4418.4 4640.3 4710.9 4714.7 4733.9 4155.8 4683.5 4933.6 5094.0 5099.5 4262.7 4402.6 4586.8 4687.8 4699.8 2379.7 2449.8 2572.5 2607.9 2679.7 4878.6 4904.6 5121.4 5196.7 5324.4 4782.6 4834.7 4845.2 4914.7 5021.8 4928.4 5009.1 5202.6 5217.3 5273.3 4402.3 5081.0 5125.6 5159.5 5164.0 4399.0 4515.3 4524.0 4834.5 5052.9 5034.2 5203.7 5270.4 5310.9 5339.8 2889.5 3580.4 3588.4 3589.9 3596.5 4720.0 4879.0 4960.6 5154.6 5760.7 5098.3 5138.3 5830.3 5850.1 5920.9 5844.4 5848.5 5857.3 5896.6 5927.9 5071.5 5505.9 5690.3 5747.9 5755.7 5136.4 5614.8 5647.2 5802.5 5955.2 4616.9 5695.8 5805.9 5819.6 5829.4 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25499.15 Median:3752.09 stddev:41661.11 (1110.3%) stddev-sans-first:41736.61 20:06:40 INFO - PROCESS | 1653 | Values: 772.2 781.7 793.7 817.4 824.2 15033.3 15545.1 15613.8 15631.4 15682.8 13032.2 14035.4 14064.0 14083.5 14103.7 841.0 846.6 880.6 890.0 893.2 864.5 883.9 884.8 887.1 887.2 909.5 910.1 912.0 917.1 917.7 895.6 902.4 906.2 906.9 907.3 648.5 665.1 678.2 678.5 683.6 15163.7 15233.8 15248.1 15249.0 15261.5 14062.3 14109.7 14248.0 14262.4 14370.4 11633.7 11725.1 11828.2 11924.9 11933.6 3710.5 3814.5 3818.0 3926.9 3932.5 127101.0 129751.4 130069.0 131261.0 131394.0 10366.3 10446.8 10967.1 10973.5 10990.7 22123.1 22127.6 22158.7 22183.8 22210.0 7541.2 7753.7 7850.2 8165.3 8168.9 3974.6 4444.1 4521.7 4546.8 4564.0 3598.3 3725.7 3778.5 3783.2 3791.8 542.2 605.4 651.1 687.8 698.8 497.9 671.0 694.6 698.6 698.9 7687.4 9139.0 9371.3 9372.4 9505.3 650.1 655.9 669.8 688.7 696.1 4569.7 4673.1 4684.1 4690.5 4737.9 99150.0 128097.0 155791.0 159936.0 162948.2 118798.2 134347.0 136525.0 136623.3 142948.3 112023.4 114439.0 114460.4 116293.4 116443.0 8992.6 9018.3 9026.5 9057.9 9069.7 60274.7 64028.0 64170.4 64836.7 65735.3 88872.0 99126.0 102522.5 104084.0 105678.0 11300.9 11631.4 11666.5 11709.3 11846.2 12947.9 13017.0 13017.9 13140.5 13343.2 12014.8 12015.2 12086.8 12136.3 12485.3 11941.5 11947.3 12109.8 12188.0 12737.4 11815.0 11948.5 11977.5 11984.0 12146.3 9545.9 9774.1 9854.0 10087.7 10310.4 9395.5 10535.8 10544.8 10586.2 10703.7 20:06:40 INFO - PROCESS | 1653 | -------- Summary: end -------- 20:06:40 INFO - PROCESS | 1653 | 20:06:40 INFO - TEST-INFO | 1653: exit 0 20:06:40 INFO - TEST-OK | dromaeo_css | took 1113872ms 20:06:40 INFO - TEST-START | kraken 20:06:40 INFO - operating with platform_type : mac_ 20:06:40 INFO - Initialising browser for kraken test... 20:06:40 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpSYFcs3/profile http://localhost:49272/getInfo.html) 20:06:43 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 20:06:43 INFO - PROCESS | 1665 | colorDepth:24 20:06:43 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 20:06:43 INFO - PROCESS | 1665 | __metrics 20:06:43 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 20:06:44 INFO - TEST-INFO | 1665: exit 0 20:06:44 INFO - Browser initialized. 20:06:44 INFO - Running cycle 1/1 for kraken test... 20:06:44 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpSYFcs3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:56 INFO - PROCESS | 1667 | RSS: Main: 225910784 20:06:56 INFO - PROCESS | 1667 | 20:06:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:59 INFO - PROCESS | 1667 | RSS: Main: 238305280 20:06:59 INFO - PROCESS | 1667 | 20:07:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 20:07:03 INFO - PROCESS | 1667 | RSS: Main: 245633024 20:07:03 INFO - PROCESS | 1667 | 20:07:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 20:07:07 INFO - PROCESS | 1667 | RSS: Main: 249683968 20:07:07 INFO - PROCESS | 1667 | 20:07:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 20:07:09 INFO - PROCESS | 1667 | RSS: Main: 250077184 20:07:09 INFO - PROCESS | 1667 | 20:07:11 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:07:12 INFO - PROCESS | 1667 | RSS: Main: 250048512 20:07:12 INFO - PROCESS | 1667 | 20:07:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 20:07:15 INFO - PROCESS | 1667 | RSS: Main: 251101184 20:07:15 INFO - PROCESS | 1667 | 20:07:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 20:07:19 INFO - PROCESS | 1667 | RSS: Main: 252190720 20:07:19 INFO - PROCESS | 1667 | 20:07:22 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 20:07:22 INFO - PROCESS | 1667 | RSS: Main: 252805120 20:07:22 INFO - PROCESS | 1667 | 20:07:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:07:24 INFO - PROCESS | 1667 | RSS: Main: 251621376 20:07:24 INFO - PROCESS | 1667 | 20:07:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:07:27 INFO - PROCESS | 1667 | RSS: Main: 251703296 20:07:27 INFO - PROCESS | 1667 | 20:07:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:07:30 INFO - PROCESS | 1667 | RSS: Main: 251752448 20:07:30 INFO - PROCESS | 1667 | 20:07:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:07:33 INFO - PROCESS | 1667 | RSS: Main: 251936768 20:07:33 INFO - PROCESS | 1667 | 20:07:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:07:37 INFO - PROCESS | 1667 | RSS: Main: 252141568 20:07:37 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 20:07:39 INFO - PROCESS | 1667 | RSS: Main: 253784064 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | __start_tp_report 20:07:39 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 20:07:39 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 20:07:39 INFO - PROCESS | 1667 | |i|pagename|runs| 20:07:39 INFO - PROCESS | 1667 | |0;ai-astar;106;117;114;117;121;117;128;172;117;118 20:07:39 INFO - PROCESS | 1667 | |1;audio-beat-detection;139;110;108;142;108;109;119;145;173;110 20:07:39 INFO - PROCESS | 1667 | |2;audio-dft;194;198;264;280;197;194;200;231;193;198 20:07:39 INFO - PROCESS | 1667 | |3;audio-fft;80;60;58;87;63;61;59;59;78;60 20:07:39 INFO - PROCESS | 1667 | |4;audio-oscillator;90;74;88;74;70;68;86;71;72;87 20:07:39 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;135;86;93;87;113;85;89;84;88;87 20:07:39 INFO - PROCESS | 1667 | |6;imaging-darkroom;95;96;95;107;154;125;95;94;96;96 20:07:39 INFO - PROCESS | 1667 | |7;imaging-desaturate;141;96;92;83;132;141;95;94;93;91 20:07:39 INFO - PROCESS | 1667 | |8;json-parse-financial;56;54;54;56;59;61;59;60;58;60 20:07:39 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;64;74;73;81;74;71;67;71;71;70 20:07:39 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;84;85;75;107;104;105;82;85;86;77 20:07:39 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;147;161;135;140;169;151;143;140;194;165 20:07:39 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;168;177;167;168;164;166;167;164;211;223 20:07:39 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;66;69;72;77;89;65;63;85;88;91 20:07:39 INFO - PROCESS | 1667 | __end_tp_report 20:07:39 INFO - PROCESS | 1667 | __start_cc_report 20:07:39 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,936 20:07:39 INFO - PROCESS | 1667 | __end_cc_report 20:07:39 INFO - PROCESS | 1667 | __startTimestamp1478664459549__endTimestamp 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | ------- Summary: start ------- 20:07:39 INFO - PROCESS | 1667 | Number of tests: 14 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:122.70 Median:117.50 stddev:18.16 (15.5%) stddev-sans-first:18.23 20:07:39 INFO - PROCESS | 1667 | Values: 106.0 117.0 114.0 117.0 121.0 117.0 128.0 172.0 117.0 118.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:129.00 stddev:22.34 (17.3%) stddev-sans-first:23.22 20:07:39 INFO - PROCESS | 1667 | Values: 139.0 110.0 108.0 142.0 108.0 109.0 119.0 145.0 173.0 110.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:214.90 Median:199.00 stddev:32.27 (16.2%) stddev-sans-first:33.33 20:07:39 INFO - PROCESS | 1667 | Values: 194.0 198.0 264.0 280.0 197.0 194.0 200.0 231.0 193.0 198.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:66.50 Median:62.00 stddev:10.78 (17.4%) stddev-sans-first:10.27 20:07:39 INFO - PROCESS | 1667 | Values: 80.0 60.0 58.0 87.0 63.0 61.0 59.0 59.0 78.0 60.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:80.00 stddev:8.63 (10.8%) stddev-sans-first:7.98 20:07:39 INFO - PROCESS | 1667 | Values: 90.0 74.0 88.0 74.0 70.0 68.0 86.0 71.0 72.0 87.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:87.00 stddev:16.47 (18.9%) stddev-sans-first:8.93 20:07:39 INFO - PROCESS | 1667 | Values: 135.0 86.0 93.0 87.0 113.0 85.0 89.0 84.0 88.0 87.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:95.00 stddev:19.63 (20.7%) stddev-sans-first:20.46 20:07:39 INFO - PROCESS | 1667 | Values: 95.0 96.0 95.0 107.0 154.0 125.0 95.0 94.0 96.0 96.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:105.80 Median:92.50 stddev:22.63 (24.5%) stddev-sans-first:20.10 20:07:39 INFO - PROCESS | 1667 | Values: 141.0 96.0 92.0 83.0 132.0 141.0 95.0 94.0 93.0 91.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:59.00 stddev:2.54 (4.3%) stddev-sans-first:2.62 20:07:39 INFO - PROCESS | 1667 | Values: 56.0 54.0 54.0 56.0 59.0 61.0 59.0 60.0 58.0 60.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.00 stddev:4.53 (6.3%) stddev-sans-first:3.88 20:07:39 INFO - PROCESS | 1667 | Values: 64.0 74.0 73.0 81.0 74.0 71.0 67.0 71.0 71.0 70.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:83.00 stddev:11.83 (14.3%) stddev-sans-first:12.41 20:07:39 INFO - PROCESS | 1667 | Values: 84.0 85.0 75.0 107.0 104.0 105.0 82.0 85.0 86.0 77.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:156.00 stddev:18.03 (11.6%) stddev-sans-first:18.91 20:07:39 INFO - PROCESS | 1667 | Values: 147.0 161.0 135.0 140.0 169.0 151.0 143.0 140.0 194.0 165.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:168.00 stddev:21.32 (12.7%) stddev-sans-first:22.33 20:07:39 INFO - PROCESS | 1667 | Values: 168.0 177.0 167.0 168.0 164.0 166.0 167.0 164.0 211.0 223.0 20:07:39 INFO - PROCESS | 1667 | 20:07:39 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:81.00 stddev:10.92 (13.5%) stddev-sans-first:10.90 20:07:39 INFO - PROCESS | 1667 | Values: 66.0 69.0 72.0 77.0 89.0 65.0 63.0 85.0 88.0 91.0 20:07:39 INFO - PROCESS | 1667 | -------- Summary: end -------- 20:07:39 INFO - PROCESS | 1667 | 20:07:40 INFO - TEST-INFO | 1667: exit 0 20:07:40 INFO - TEST-OK | kraken | took 59465ms 20:07:40 INFO - SUITE-END | took 1173s 20:07:40 INFO - Completed test suite (00:19:33) 20:07:40 INFO - javascript benchmark 20:07:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7354.272235111488, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.922051948701, 3365.158710322419, 3383.407903616865, 3396.1000334911237, 3400.8979730608085, 5632.887342253158, 5714.171445140458, 5720.399358067395, 5724.398938111491, 5729.0, 5711.7715291388295, 5749.022666146755, 5803.390643982384, 5813.854653633651, 5825.679587622679, 5236.109861323565, 5300.946990530084, 5304.6286759926825, 5339.279197308352, 5340.973295133538, 5307.124324486455, 5334.546563542103, 5342.813001544947, 5347.331583552056, 5371.543418809406, 5139.4346621871755, 5149.201873709581, 5319.867003324928, 5332.866678333034, 5339.145736682131, 4331.610155086026, 5235.136202526579, 5240.3187585614005, 5350.625456218067, 5368.328958880101, 5215.791368345262, 5272.31459910213, 5299.867503312409, 5305.65513241638, 5324.627276090675, 5757.481826635623, 5779.9422005779825, 5906.586538942276, 5906.9704651476895, 5929.258842644669, 5480.451954804527, 6008.36912124225, 6113.567524283673, 6130.27584246411, 6183.258009038944, 6233.563650544464, 6256.217972753406, 6276.278228003793, 6287.151234583364, 6296.842578935518, 5914.822555323347, 5936.614942757976, 5946.405359464062, 5954.702264886825, 5975.701214939236, 6153.507719382439, 6155.045967874987, 6195.101710251988, 6227.439530442282, 6317.936820631735, 6215.9378406216265, 6252.531060170414, 6261.499080073583, 6262.843428914313, 6297.968510157511, 6300.558960872695, 6302.621842689453, 6306.148669929501, 6307.306196318401, 6320.209973753281, 5712.686082201117, 5802.912956305574, 6169.105479705418, 6178.320384757763, 6237.251529816361, 5633.352164501053, 6127.617148554337, 6232.376762323732, 6245.0632405139595, 6317.526185536103, 4995.225740010304, 4996.725180115056, 4998.975005124951, 5003.099442100457, 5045.344105266292, 3549.2369140634373, 4405.273129933589, 4485.573870482299, 4507.6168525675685, 4525.981654127795, 5778.711064446845, 5872.060470324727, 5941.732622032019, 5997.220361352996, 6031.366706495843, 6223.533235007302, 6246.312905580383, 6276.309605943343, 6294.779682711083, 6340.746370145235, 5816.447437493432, 5863.355030946593, 5909.054551271776, 5944.048952167633, 6007.879842403127, 5412.485813847678, 5458.4814442627885, 5507.366652834895, 5521.089020311684, 5523.834284971457, 6150.969245153746, 6333.936660633335, 6340.558884829282, 6363.236411630634, 6368.426841584094, 6166.0, 6175.475084617858, 6175.783847565313, 6212.658303793335, 6225.3774622537385, 6174.351693072163, 6274.623522588659, 6309.400606942333, 6311.179546658905, 6318.6840657965995, 6129.8784197560135, 6162.876742465036, 6166.876662466815, 6257.405546473078, 6272.18461599989, 6202.844928876814, 6244.406781355764, 6278.058291256348, 6289.433950944437, 6293.433590976834, 5997.850053748692, 6204.286507051746, 6205.968970155121, 6209.565330426827, 6214.316425193316, 5221.556167725786, 6052.364501727256, 6067.605605635619, 6113.354685976905, 6135.509159267337, 5956.642601443928, 6108.205933228652, 6127.111568822406, 6128.448439640454, 6135.93706321624, 5149.330587023663, 6196.1635179252025, 6201.131841542097, 6224.035274532454, 6231.0, 5878.882422351444, 5899.734511946886, 5952.821415357546, 6057.818265452043, 6091.147239386578], "value": 5726.201471063555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.2324369387136, 509.94645562215965, 519.5687579309173, 526.702413136578, 533.810497273468, 40606.390904136424, 42604.57395426045, 42612.360814587766, 42655.36016959748, 42755.14489710212, 43630.0, 43812.3428148578, 43907.560924390746, 44019.779901100526, 44025.11949761003, 9841.45871977041, 9986.900130998669, 9992.150667193297, 10011.399316041025, 10020.59917603295, 9864.950675246613, 9957.402555846636, 9969.152622027137, 9980.251481138906, 10031.247656425761, 9940.850887236662, 9983.351082179672, 9993.100620944113, 10009.099181073701, 10010.0, 9970.252231082697, 9995.300328976975, 10001.399916005063, 10001.59993600255, 10025.09774120329, 9986.500674966223, 10032.297739158263, 10049.095581397709, 10069.0, 10091.495425228783, 40896.79551602223, 40943.795281023406, 41096.178076438606, 41311.7934410329, 41399.586004140176, 3371.342588195303, 3711.66595006448, 3714.294284086015, 3767.660910518039, 4040.6161414665853, 25904.51723399702, 27738.02916897899, 28453.861845526153, 31247.687523124707, 31357.0118859073, 2951.8819247230085, 3085.197848559368, 3109.160526657812, 3120.9219769505717, 3289.3092450585405, 487056.0, 498502.0, 499937.0, 500134.0, 501489.99999999633, 59595.0, 59861.401385985584, 59967.70016149891, 60093.0, 60124.09813852796, 51087.74456127696, 62873.685631572465, 62934.0, 63082.0, 63087.0, 16869.072201028815, 17088.487345379657, 17109.315627375014, 17127.14364281781, 17158.0, 13344.933275333562, 13352.0, 13379.197248165141, 13393.598192054254, 13423.530176443777, 15150.939434239497, 16104.355825766837, 16211.51365459038, 16214.270357833926, 16248.0, 2992.4314380268115, 6971.81479148546, 7140.464465165133, 7329.963350183321, 7364.189939106694, 919.5540163020929, 988.560090759605, 1026.6047571684805, 1035.9015893490107, 1107.6067995861515, 26044.218673439827, 26199.0, 28735.56896646552, 29285.0, 29639.851800740857, 970.9223262139153, 975.6975337645353, 1059.0, 1092.126298960828, 1146.8853114688463, 15686.450974215848, 15780.289886955115, 15887.443939462064, 15930.203489825462, 15999.680006399807, 692845.0, 700031.4998424975, 706044.0, 714293.0, 715801.0, 58306.416935830945, 58914.11628825571, 58920.41079589235, 58926.0, 58955.410445895846, 1376.2636989210923, 1389.534505940501, 1393.4078016842802, 1393.4983405973842, 1397.7623803953556, 29713.702862971957, 30221.395572088873, 30354.392912142077, 30369.937052203066, 30693.23266918345, 50861.74569127131, 50991.74504127455, 51222.0, 51247.74376128095, 51510.0, 629255.0, 632594.0, 633101.8344908246, 633627.0, 635541.0, 26530.0, 26579.069732559266, 26893.731062689123, 26979.325516862235, 27027.459450811268, 46814.76592617015, 47007.0, 47165.05669886514, 47719.76140119416, 47856.76071619619, 38116.42825357677, 39900.60099398969, 39992.80003599964, 41031.0, 41511.0, 39260.411093834184, 39431.408528871514, 39491.21017579575, 40521.0, 40930.0, 38244.852654420414, 38445.038874028374, 38563.614363856, 39065.80467097646, 39459.81620551388, 26649.866750666122, 31274.687253128086, 35312.47031294584, 35524.822375887954, 35756.64243357637, 26060.34849128787, 26270.21189364322, 26318.86840565785, 26449.867750661124, 26951.460970780867], "value": 20213.637533685403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.57599488572805, 379.33237501996496, 384.71915501683753, 387.35698740091453, 409.29601086131845, 19779.208831646734, 21238.51330406872, 21377.786222137773, 21457.0, 21651.350459486202, 20099.497512562193, 20668.48328791781, 20718.792812071875, 20845.687314690254, 21087.47281317964, 5654.660720356771, 5964.7912323068595, 6102.48128909041, 6199.845003874917, 6207.441330280274, 4188.769617671027, 4429.13631841791, 6047.5766696331275, 6144.754209831602, 6515.3484651534945, 6716.496262780287, 6844.4182244509275, 6855.1088358513325, 6857.554258973176, 6872.931270687304, 6588.8023359299295, 6798.674258519591, 6833.282505336918, 6847.520673552854, 6861.416779573742, 5806.1581070744505, 5841.532677385799, 5851.76592936282, 5865.560082993792, 5914.674692891889, 26263.0, 26426.603600945808, 26542.0, 26589.20232393012, 26724.599131013052, 2290.459234096663, 2400.84394514356, 2465.864377459239, 2467.9506409871883, 2750.40866213765, 13183.0, 15578.454754083667, 15764.896457247882, 15826.525204243891, 16247.756283655755, 1561.9687606247812, 1708.5728567858037, 1714.8885322454125, 1827.6892928202237, 1835.4034938644993, 89639.0, 112843.0, 113923.43038284838, 115479.4226028873, 115552.0, 10444.425556594308, 10528.842067368996, 10681.145508359312, 11096.833547496793, 11342.035926946302, 13579.185248885098, 13608.115472494255, 13612.319384030958, 13613.319334033258, 13617.455301787817, 8560.828783424296, 8765.816614756926, 8779.780505487413, 8830.779230519289, 8930.776730581658, 8972.820543589092, 8999.55002249898, 9015.909840901639, 9036.909630903607, 9159.816803664022, 6584.111144995364, 6590.373914478117, 6602.7689030883685, 6620.503462240351, 6649.534532582769, 1549.8527639874194, 1678.966420671604, 1682.6382327799581, 1847.5196448923377, 1961.8038196180553, 880.8942926848819, 896.1665650944553, 900.2797761790541, 928.3779867488798, 1077.5851297250458, 15613.297401616954, 20822.0, 20832.687509687366, 20904.0, 21048.473788155417, 947.2942657720042, 954.1079091049891, 957.9856302155473, 958.7986522830283, 978.9902100979042, 11009.724756880982, 11015.449227538591, 11104.056155226895, 11177.720556985978, 11179.273347232403, 559999.0, 609379.0, 615818.0, 624265.0, 627841.0, 75819.0, 117981.0, 127567.36216319045, 134797.3260133693, 137174.0, 842.4439869685978, 965.6378857928277, 989.8663680403198, 990.9256805739599, 1007.6473234367912, 13959.720805583629, 14525.346359414063, 17349.210766967375, 18254.45236642903, 18664.253429863198, 38670.646527371406, 48729.5127048725, 49033.0, 50612.0, 50908.727281818254, 68296.65851670908, 68730.9690354655, 71124.0, 71288.64355678188, 73413.63293183714, 6999.265077166824, 7211.350978411968, 7374.225706300761, 7407.2592740725495, 7408.333250007525, 11062.0, 12978.156419832681, 13035.217886926815, 13127.540536081191, 13319.467221311039, 7660.157382688011, 9582.137607615348, 10876.510557024794, 11415.885841141482, 11542.19204655666, 10422.0, 11029.779404412027, 11108.277961932448, 11165.330080195214, 11197.384143872165, 11316.37759923212, 11464.082873370277, 11514.88485115138, 11692.479977602858, 11724.120690948042, 8003.639836207268, 8179.83640327202, 8224.958875205586, 8257.38069644767, 8284.83430331402, 9622.615095396106, 10887.891121088687, 11185.72035699114, 11208.607698730506, 11358.432078396212], "value": 9684.85660131482, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.5139579636618, 1499.310317254063, 1692.9915350423246, 1728.343229572762, 1746.8645380502664, 8087.636056377462, 8332.750017499484, 8541.273991710705, 9043.502607356593, 9067.682631107904, 8561.48631082134, 8860.645574177026, 8895.33285003624, 8975.506347150904, 8985.640574377034, 2409.072507084772, 2436.317831007321, 2437.8293519453646, 2446.0338166424253, 2446.779789818916, 2407.6508906208587, 2415.2029830156007, 2431.6474111253856, 2433.3308340206495, 2440.5973014452593, 2087.7912208779076, 2419.758024197584, 2420.576399130154, 2435.6224785158242, 2439.48770758141, 2012.6578481658153, 2095.287602215254, 2406.68713067301, 2416.2026531244646, 2420.4432980414604, 2208.7570367259586, 2411.168146989286, 2419.0928401849305, 2421.225207933462, 2427.6237183236626, 7167.569945803217, 7956.6871466208, 8605.655773769042, 8645.308375330022, 8668.60991255395, 5296.3909150447425, 5426.050441172779, 5439.184122381675, 5449.536789372908, 5476.658218736396, 3675.72432067596, 3691.963080369189, 3711.1464363196346, 3712.7401081924277, 3736.645018723217, 1067.1356201476829, 1069.091272418446, 1074.3285446595878, 1089.487940667885, 1093.4805967165612, 11711.941440292829, 11784.0, 11820.23168494045, 11846.17076804624, 11856.0, 4723.929141062887, 4754.808661738747, 4766.833160839424, 4868.878278043077, 4921.3356196912955, 9936.254780891317, 10043.799124017478, 10060.748481288027, 10062.396256224503, 10074.74813129663, 5437.564994800407, 5442.727863606804, 5445.482679145475, 5451.618386712971, 5454.127339625641, 4447.199504089231, 4569.634429245652, 4729.337892695025, 4843.515648435128, 4972.552470277692, 3957.149212919236, 3966.1076257841755, 4055.371417430303, 4064.8170832312617, 4081.9387709184384, 1312.199558269474, 1316.4339334086244, 1317.433503593464, 1328.1698938163647, 1350.8514063453013, 909.3816204980677, 922.7847725676695, 927.8840144981878, 930.181440332503, 952.6379975609224, 5722.227499287626, 5801.6519008859605, 5832.825015249465, 6008.459238668541, 6096.756129754849, 446.7475876129976, 454.4887002122612, 461.43704680289994, 462.01360096194196, 467.2920525404016, 3964.6431821136234, 3967.682585393162, 3994.420808982681, 4020.155767288902, 4052.5542190359038, 10601.363918164934, 10904.672859814218, 10983.890161098447, 10987.890121098686, 11027.393493357942, 10967.616133435291, 10972.451377431256, 10978.670639880816, 10991.61529346469, 11100.389478578594, 8220.753377398687, 8224.876626850602, 8274.627641756015, 8426.747197584082, 8449.408541402167, 5659.660420374791, 5763.6541807491685, 5823.068309070529, 5840.474357307863, 5865.794697185578, 10009.399436033862, 10035.899641003789, 10151.593936242763, 10314.845277320695, 10394.168466522811, 9996.750081248027, 10242.6415075472, 10292.742681433025, 10315.587376504856, 10470.581176752845, 6174.475169610633, 7034.402075823612, 7253.347198752138, 7619.847603048019, 7747.2640099190485, 8310.542920139209, 8565.357598180037, 8568.14318568163, 8569.82860342802, 8580.584203606584, 6470.676466176578, 6844.007618895332, 7500.474966752275, 7663.386929045774, 7749.612519374122, 6799.626020568916, 7454.217307182667, 7474.289942455458, 7481.850362992601, 7520.210377910241, 5943.91084133747, 6986.126734158231, 7040.929590704028, 7047.682854271673, 7048.0, 4999.350084488993, 5035.748212589429, 5037.0681423936685, 5067.315912351933, 5071.594272458268, 4814.470408255019, 4824.589909857701, 4850.102730994778, 4938.802447902043, 4965.006998600222], "value": 4534.051764331448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.16776857031743, 303.17838657238883, 315.95260710893365, 319.24020830423586, 320.2234581140733, 4711.78796954137, 4796.136695394827, 4998.775055122519, 5423.0, 5545.445455454453, 5488.463230295523, 5522.723863806814, 5537.556995440365, 5556.638818476807, 5568.9443105568935, 3422.4524076147823, 3962.9603703963026, 4208.705390622666, 4217.848897062505, 4242.639375653073, 3336.816475093869, 4179.770112643803, 4245.405643209938, 4245.7240279381895, 4272.9359059614135, 3624.601293857687, 4145.274576949037, 4184.4978602567735, 4212.525616034379, 4229.281022226213, 4207.242696314662, 4218.936715949263, 4222.0, 4223.472065991751, 4227.32362821947, 3337.8331083445732, 3454.654534546525, 3642.8542858285637, 3664.285464334456, 3691.8338674759702, 4113.2980317714, 4903.534164254425, 5282.464417079823, 5326.627136100475, 5334.653247538898, 4010.2555388405844, 4062.512498500199, 4822.565969062766, 4847.6911233966985, 4853.830115945961, 5095.949040509585, 5883.294004719418, 5919.437653422918, 5931.991561434566, 5934.317553481319, 3960.564337922855, 3984.86052988144, 3995.380715989026, 4002.3990403838407, 4030.0126469014986, 6106.603070800384, 6135.32511423743, 6163.784267550659, 6164.506839452878, 6173.660448675366, 3198.2484116232667, 3664.230511592542, 4036.6972477064337, 4061.289274376972, 4065.9796701016307, 3268.6077670679197, 3810.904727381838, 3882.456456096149, 4076.6331030207425, 4112.979435102805, 4255.5318914919335, 4257.57424257578, 4781.354517140211, 4810.735409552438, 4876.219804831281, 5297.602679799031, 5571.164325351148, 5740.454656807597, 5944.970275148683, 5968.1942937703725, 1221.2550344289975, 1280.9167404118703, 1323.907776084734, 1412.6256542016374, 1422.7865820126856, 766.6856588798565, 839.6137776622822, 850.6342272822621, 888.8089060851947, 891.9965039330752, 4418.387288639623, 4640.303954406866, 4710.858674239778, 4714.717116972924, 4733.905321893543, 4155.815592556107, 4683.454460028182, 4933.55597996182, 5093.9690883924, 5099.506837816034, 4262.65898728101, 4402.569165021381, 4586.844183233875, 4687.820163623931, 4699.814586217425, 2379.7382287948312, 2449.755024497536, 2572.524083044643, 2607.8565678887844, 2679.678438587382, 4878.585320247818, 4904.60763138948, 5121.443234090979, 5196.740162991835, 5324.361076670824, 4782.593479554207, 4834.6882385565295, 4845.200541910545, 4914.70511769295, 5021.84934451967, 4928.4475390251955, 5009.148444764399, 5202.60980426462, 5217.321748172713, 5273.288106105627, 4402.3176407656865, 5081.0, 5125.641205115606, 5159.484051594811, 5163.967206558628, 4398.957284199215, 4515.277555591089, 4524.0, 4834.468208497133, 5052.873678158076, 5034.219695947134, 5203.747657713929, 5270.420253772006, 5310.911263190959, 5339.813106541253, 2889.465448891962, 3580.391333473264, 3588.3899737045285, 3589.9282014359046, 3596.4605309202784, 4720.032393359422, 4878.9512104878495, 4960.5772017307945, 5154.61340399479, 5760.740766665426, 5098.311727916832, 5138.332016837787, 5830.300363956183, 5850.12248162779, 5920.881582368243, 5844.3571207168025, 5848.537865533616, 5857.297124345106, 5896.64620122794, 5927.947107239861, 5071.492850714899, 5505.862353441196, 5690.260266165372, 5747.9137812932, 5755.740991655469, 5136.357955255593, 5614.848955964099, 5647.181158731879, 5802.47777700009, 5955.213435969278, 4616.907661846677, 5695.829125126253, 5805.912911306418, 5819.621724587888, 5829.387914268941], "value": 4001.0751776143934, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.1853444615928, 781.7068599275271, 793.674593416699, 817.4073796497544, 824.241697638173, 15033.323500442479, 15545.067295962222, 15613.843861561381, 15631.374745010215, 15682.764758528618, 13032.152910060862, 14035.438582456714, 14064.015518913655, 14083.507077252298, 14103.71792564148, 840.9873851892211, 846.6190214403543, 880.6125304865839, 889.9777505562348, 893.2228960804077, 864.5461132905212, 883.9381243312971, 884.8230353929208, 887.0863011098546, 887.1660638999319, 909.5225006871412, 910.0944560162648, 911.9589618467152, 917.0874979395478, 917.6512925088457, 895.5790778334173, 902.3683421604903, 906.1663269791808, 906.9410488318272, 907.3149771922157, 648.52657559981, 665.0722242471774, 678.1895634716516, 678.5148618737577, 683.5864302097259, 15163.696726065416, 15233.771493427608, 15248.08511489303, 15249.0, 15261.465848695354, 14062.296885155803, 14109.717805643932, 14248.0, 14262.357811249813, 14370.425182992667, 11633.650990470214, 11725.120615953752, 11828.231164974335, 11924.940375298154, 11933.641990740205, 3710.5361829771277, 3814.5422549293985, 3818.0, 3926.9410958835356, 3932.46911666927, 127101.0, 129751.35124324412, 130069.0, 131261.0, 131394.0, 10366.274360794823, 10446.791064178673, 10967.122630189566, 10973.50619222137, 10990.670279891616, 22123.115075396803, 22127.557448850934, 22158.667619985714, 22183.778162218496, 22210.0, 7541.170471248159, 7753.728619498291, 7850.175731548219, 8165.346772258205, 8168.9183108169345, 3974.5627980922077, 4444.066745983315, 4521.660875434355, 4546.795394207269, 4563.995920897397, 3598.2803439312243, 3725.701943844486, 3778.471014058034, 3783.1677031053123, 3791.7914514701956, 542.1894268069261, 605.35832018061, 651.1437459740426, 687.8039758668856, 698.8252936765808, 497.8954419571858, 670.9698063587052, 694.6110178300169, 698.6297262450909, 698.9336013078749, 7687.384969515411, 9139.040400757825, 9371.344005919656, 9372.43765374066, 9505.287103467268, 650.0833824307704, 655.9111874288658, 669.8311446525844, 688.7066069986931, 696.1437431958618, 4569.680122391467, 4673.088747694167, 4684.110019096361, 4690.53094690535, 4737.881552961204, 99150.01699965961, 128097.0, 155791.0, 159936.0, 162948.1852590753, 118798.24807007796, 134347.0, 136525.0, 136623.31688341495, 142948.2852585751, 112023.43988280007, 114439.0, 114460.42769786097, 116293.41853290849, 116443.0, 8992.550372481219, 9018.278537717099, 9026.548672566476, 9057.864132038156, 9069.727908162766, 60274.698626506586, 64028.0, 64170.35829641644, 64836.67581662061, 65735.34264657293, 88872.0, 99126.0, 102522.48738756258, 104084.0, 105678.0, 11300.94349528247, 11631.360275184947, 11666.533338666697, 11709.297442153498, 11846.170768046153, 12947.870521294666, 13017.0, 13017.934910325388, 13140.540081097115, 13343.199408035161, 12014.75970480568, 12015.219010764273, 12086.818697719365, 12136.33250171249, 12485.31330776816, 11941.52233910634, 11947.342896140795, 12109.818352724893, 12188.0, 12737.426815793497, 11815.0, 11948.522059117538, 11977.461014254206, 11984.0, 12146.271223726604, 9545.93977309407, 9774.087141381166, 9853.950730246303, 10087.69736907894, 10310.43292618913, 9395.530223488935, 10535.841962370418, 10544.789104218025, 10586.153107751208, 10703.678889633324], "value": 7778.981493927972, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 114.0, 117.0, 121.0, 117.0, 128.0, 172.0, 117.0, 118.0], "value": 122.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 110.0, 108.0, 142.0, 108.0, 109.0, 119.0, 145.0, 173.0, 110.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 198.0, 264.0, 280.0, 197.0, 194.0, 200.0, 231.0, 193.0, 198.0], "value": 214.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 87.0, 63.0, 61.0, 59.0, 59.0, 78.0, 60.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 74.0, 88.0, 74.0, 70.0, 68.0, 86.0, 71.0, 72.0, 87.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 86.0, 93.0, 87.0, 113.0, 85.0, 89.0, 84.0, 88.0, 87.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 107.0, 154.0, 125.0, 95.0, 94.0, 96.0, 96.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 96.0, 92.0, 83.0, 132.0, 141.0, 95.0, 94.0, 93.0, 91.0], "value": 105.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 56.0, 59.0, 61.0, 59.0, 60.0, 58.0, 60.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 73.0, 81.0, 74.0, 71.0, 67.0, 71.0, 71.0, 70.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 75.0, 107.0, 104.0, 105.0, 82.0, 85.0, 86.0, 77.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 161.0, 135.0, 140.0, 169.0, 151.0, 143.0, 140.0, 194.0, 165.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 177.0, 167.0, 168.0, 164.0, 166.0, 167.0, 164.0, 211.0, 223.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 72.0, 77.0, 89.0, 65.0, 63.0, 85.0, 88.0, 91.0], "value": 76.5, "unit": "score"}]}]} 20:07:40 INFO - Return code: 0 20:07:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:07:40 ERROR - # TBPL SUCCESS # 20:07:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:07:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:07:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:07:40 INFO - 2016-11-08 20:07:40.877 screenresolution[1672:10538] starting screenresolution argv=screenresolution get 20:07:40 INFO - 2016-11-08 20:07:40.880 screenresolution[1672:10538] Display 0: 1600x1200x32@60 20:07:40 INFO - 2016-11-08 20:07:40.886 screenresolution[1673:10541] starting screenresolution argv=screenresolution list 20:07:40 INFO - Available Modes on Display 0 20:07:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:07:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:07:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:07:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:07:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:07:41 INFO - Intel Iris: 20:07:41 INFO - Chipset Model: Intel Iris 20:07:41 INFO - Type: GPU 20:07:41 INFO - Bus: Built-In 20:07:41 INFO - VRAM (Dynamic, Max): 1536 MB 20:07:41 INFO - Vendor: Intel (0x8086) 20:07:41 INFO - Device ID: 0x0a2e 20:07:41 INFO - Revision ID: 0x0009 20:07:41 INFO - Displays: 20:07:41 INFO - Display: 20:07:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:07:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:07:41 INFO - Display Serial Number: 1600x1200 60 20:07:41 INFO - Main Display: Yes 20:07:41 INFO - Mirror: Off 20:07:41 INFO - Online: Yes 20:07:41 INFO - Rotation: Supported 20:07:41 INFO - Return code: 0 20:07:41 INFO - Running post-action listener: _resource_record_post_action 20:07:41 INFO - [mozharness: 2016-11-09 04:07:41.122956Z] Finished run-tests step (success) 20:07:41 INFO - Running post-run listener: _resource_record_post_run 20:07:41 INFO - Total resource usage - Wall time: 1206s; CPU: 55.0%; Read bytes: 36754432; Write bytes: 665825280; Read time: 385; Write time: 1944 20:07:41 INFO - TinderboxPrint: CPU usage
54.5% 20:07:41 INFO - TinderboxPrint: I/O read bytes / time
36,754,432 / 385 20:07:41 INFO - TinderboxPrint: I/O write bytes / time
665,825,280 / 1,944 20:07:41 INFO - TinderboxPrint: CPU idle
2,194.7 (45.5%) 20:07:41 INFO - TinderboxPrint: CPU system
972.2 (20.1%) 20:07:41 INFO - TinderboxPrint: CPU user
1,658.9 (34.4%) 20:07:41 INFO - TinderboxPrint: Swap in / out
400,429,056 / 0 20:07:41 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 364564992; Write bytes: 367306240; Read time: 27677; Write time: 745 20:07:41 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 34501632; Write bytes: 296966656; Read time: 358; Write time: 1195 20:07:41 INFO - Running post-run listener: _upload_blobber_files 20:07:41 INFO - Blob upload gear active. 20:07:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:07:41 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 20:07:41 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'] 20:07:41 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 20:07:41 INFO - (blobuploader) - INFO - Open directory for files ... 20:07:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:07:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:07:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:43 INFO - (blobuploader) - INFO - Done attempting. 20:07:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:07:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:44 INFO - (blobuploader) - INFO - Done attempting. 20:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:07:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:46 INFO - (blobuploader) - INFO - Done attempting. 20:07:46 INFO - (blobuploader) - INFO - Iteration through files over. 20:07:46 INFO - Return code: 0 20:07:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:07:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:07:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd9e88031e5add011a19eefda9a9397ef20c1d55d95a549cffdd243cf12c796c508333674938c61dab593936199ac7627ef32502729f43814ba6a99dc3aae0c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b107f91b2a9f5be6cf1b4a0f74c824126bd453f4e60545200589e5b9275ee784e2483a068a6b288e1725622b0e3cb1a292a8986e27abff2a707646e0ad885ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16accc1d8d8620b602a2fb421ca5b4a4ccb4441ae59a648d584b4d8dea386942694100d1f4a0692dec0f4a5d4297ceb29d67fc108af4a146a11e492a8287a0cc"} 20:07:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:07:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:07:46 INFO - Contents: 20:07:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd9e88031e5add011a19eefda9a9397ef20c1d55d95a549cffdd243cf12c796c508333674938c61dab593936199ac7627ef32502729f43814ba6a99dc3aae0c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b107f91b2a9f5be6cf1b4a0f74c824126bd453f4e60545200589e5b9275ee784e2483a068a6b288e1725622b0e3cb1a292a8986e27abff2a707646e0ad885ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16accc1d8d8620b602a2fb421ca5b4a4ccb4441ae59a648d584b4d8dea386942694100d1f4a0692dec0f4a5d4297ceb29d67fc108af4a146a11e492a8287a0cc"} 20:07:46 INFO - Running post-run listener: copy_logs_to_upload_dir 20:07:46 INFO - Copying logs to upload dir... 20:07:46 INFO - mkdir: /builds/slave/test/build/upload/logs 20:07:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.588029 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-11-08 20:07:46.845468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 20:07:46.849325) ========= 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.IAnvpvqKST/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.wS5ydMkKPi/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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/bd9e88031e5add011a19eefda9a9397ef20c1d55d95a549cffdd243cf12c796c508333674938c61dab593936199ac7627ef32502729f43814ba6a99dc3aae0c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b107f91b2a9f5be6cf1b4a0f74c824126bd453f4e60545200589e5b9275ee784e2483a068a6b288e1725622b0e3cb1a292a8986e27abff2a707646e0ad885ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16accc1d8d8620b602a2fb421ca5b4a4ccb4441ae59a648d584b4d8dea386942694100d1f4a0692dec0f4a5d4297ceb29d67fc108af4a146a11e492a8287a0cc"} 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.010950 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/bd9e88031e5add011a19eefda9a9397ef20c1d55d95a549cffdd243cf12c796c508333674938c61dab593936199ac7627ef32502729f43814ba6a99dc3aae0c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b107f91b2a9f5be6cf1b4a0f74c824126bd453f4e60545200589e5b9275ee784e2483a068a6b288e1725622b0e3cb1a292a8986e27abff2a707646e0ad885ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16accc1d8d8620b602a2fb421ca5b4a4ccb4441ae59a648d584b4d8dea386942694100d1f4a0692dec0f4a5d4297ceb29d67fc108af4a146a11e492a8287a0cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 20:07:46.882747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 20:07:46.883160) ========= 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.IAnvpvqKST/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.wS5ydMkKPi/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.005129 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 20:07:46.932884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 20:07:46.933200) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 20:07:46.933529) ========= ========= Total master_lag: 0.17 =========