builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1474728457.43 results: success (0) buildid: 20160924055025 builduid: a3b6dfc082eb471a9f7e5aa1dc3c1ddc revision: d9c70cda4277f12c6a74be1388da4f88baf591c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:37.432240) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:37.432715) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:37.433017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:37.464320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:37.464710) ========= 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.L89g8VT5Cu/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.sIec2LnjIK/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-24 07:47:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.45M=0.001s 2016-09-24 07:47:37 (8.45 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.453045 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:37.944632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:37.944977) ========= 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.L89g8VT5Cu/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.sIec2LnjIK/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.021218 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:37.993834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-24 07:47:37.994211) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9c70cda4277f12c6a74be1388da4f88baf591c3 --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 d9c70cda4277f12c6a74be1388da4f88baf591c3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L89g8VT5Cu/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.sIec2LnjIK/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-24 07:47:38,074 truncating revision to first 12 chars 2016-09-24 07:47:38,074 Setting DEBUG logging. 2016-09-24 07:47:38,074 attempt 1/10 2016-09-24 07:47:38,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9c70cda4277?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-24 07:47:39,225 unpacking tar archive at: mozilla-aurora-d9c70cda4277/testing/mozharness/ program finished with exit code 0 elapsedTime=1.447321 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-24 07:47:39.463448) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:39.463736) ========= script_repo_revision: d9c70cda4277f12c6a74be1388da4f88baf591c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:39.464118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:39.464386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-24 07:47:39.483020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-24 07:47:39.483323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L89g8VT5Cu/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.sIec2LnjIK/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:47:39 INFO - MultiFileLogger online at 20160924 07:47:39 in /builds/slave/test 07:47:39 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 07:47:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:47:39 INFO - {'append_to_log': False, 07:47:39 INFO - 'base_work_dir': '/builds/slave/test', 07:47:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:47:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:47:39 INFO - 'branch': 'Mozilla-Aurora', 07:47:39 INFO - 'buildbot_json_path': 'buildprops.json', 07:47:39 INFO - 'config_files': ('talos/mac_config.py',), 07:47:39 INFO - 'default_actions': ('clobber', 07:47:39 INFO - 'read-buildbot-config', 07:47:39 INFO - 'download-and-extract', 07:47:39 INFO - 'populate-webroot', 07:47:39 INFO - 'create-virtualenv', 07:47:39 INFO - 'install', 07:47:39 INFO - 'run-tests'), 07:47:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:47:39 INFO - 'download_minidump_stackwalk': True, 07:47:39 INFO - 'download_symbols': 'ondemand', 07:47:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:47:39 INFO - 'tooltool.py': '/tools/tooltool.py', 07:47:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:47:39 INFO - '/tools/misc-python/virtualenv.py')}, 07:47:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:47:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:47:39 INFO - 'installer_path': 'installer.exe', 07:47:39 INFO - 'log_level': 'info', 07:47:39 INFO - 'log_name': 'talos', 07:47:39 INFO - 'log_to_console': True, 07:47:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:47:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:47:39 INFO - 'opt_config_files': (), 07:47:39 INFO - 'pip_index': False, 07:47:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:47:39 INFO - 'cmd': ('bash', 07:47:39 INFO - '-c', 07:47:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:47:39 INFO - 'enabled': True, 07:47:39 INFO - 'halt_on_failure': False, 07:47:39 INFO - 'name': 'check_screen_resolution'},), 07:47:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:47:39 INFO - 'cmd': ('bash', 07:47:39 INFO - '-c', 07:47:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:47:39 INFO - 'enabled': True, 07:47:39 INFO - 'halt_on_failure': False, 07:47:39 INFO - 'name': 'check_screen_resolution'},), 07:47:39 INFO - 'run_cmd_checks_enabled': True, 07:47:39 INFO - 'sps_profile': False, 07:47:39 INFO - 'sps_profile_interval': 0, 07:47:39 INFO - 'suite': 'dromaeojs-e10s', 07:47:39 INFO - 'system_bits': '32', 07:47:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:47:39 INFO - 'title': 't-yosemite-r7-0312', 07:47:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:47:39 INFO - 'use_talos_json': True, 07:47:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:47:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:47:39 INFO - 'work_dir': 'build'} 07:47:39 INFO - [mozharness: 2016-09-24 14:47:39.687656Z] Running clobber step. 07:47:39 INFO - Running pre-action listener: _resource_record_pre_action 07:47:39 INFO - Running main action method: clobber 07:47:39 INFO - rmtree: /builds/slave/test/build 07:47:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:47:41 INFO - Running post-action listener: _resource_record_post_action 07:47:41 INFO - [mozharness: 2016-09-24 14:47:41.852449Z] Finished clobber step (success) 07:47:41 INFO - [mozharness: 2016-09-24 14:47:41.852701Z] Running read-buildbot-config step. 07:47:41 INFO - Running pre-action listener: _resource_record_pre_action 07:47:41 INFO - Running main action method: read_buildbot_config 07:47:41 INFO - Using buildbot properties: 07:47:41 INFO - { 07:47:41 INFO - "project": "", 07:47:41 INFO - "product": "firefox", 07:47:41 INFO - "script_repo_revision": "production", 07:47:41 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:47:41 INFO - "repository": "", 07:47:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:47:41 INFO - "buildid": "20160924055025", 07:47:41 INFO - "pgo_build": "False", 07:47:41 INFO - "basedir": "/builds/slave/test", 07:47:41 INFO - "buildnumber": 100, 07:47:41 INFO - "slavename": "t-yosemite-r7-0312", 07:47:41 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:47:41 INFO - "platform": "yosemite_r7", 07:47:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:47:41 INFO - "branch": "mozilla-aurora", 07:47:41 INFO - "repo_path": "releases/mozilla-aurora", 07:47:41 INFO - "revision": "d9c70cda4277f12c6a74be1388da4f88baf591c3", 07:47:41 INFO - "stage_platform": "macosx64", 07:47:41 INFO - "builduid": "a3b6dfc082eb471a9f7e5aa1dc3c1ddc", 07:47:41 INFO - "slavebuilddir": "test" 07:47:41 INFO - } 07:47:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:47:41 INFO - Running post-action listener: _resource_record_post_action 07:47:41 INFO - [mozharness: 2016-09-24 14:47:41.858457Z] Finished read-buildbot-config step (success) 07:47:41 INFO - [mozharness: 2016-09-24 14:47:41.858717Z] Running download-and-extract step. 07:47:41 INFO - Running pre-action listener: _resource_record_pre_action 07:47:41 INFO - Running main action method: download_and_extract 07:47:41 INFO - mkdir: /builds/slave/test/build/tests 07:47:41 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')]} 07:47:41 INFO - trying https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:47:41 INFO - Downloading https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/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 07:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/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 07:47:42 INFO - Downloaded 1199 bytes. 07:47:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:47:42 INFO - Using the following test package requirements: 07:47:42 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:47:42 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:47:42 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:47:42 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:47:42 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:47:42 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:47:42 INFO - u'jsshell-mac.zip'], 07:47:42 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:47:42 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:47:42 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:47:42 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:47:42 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:47:42 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:47:42 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:47:42 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:47:42 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:47:42 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:47:42 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:47:42 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:47:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:47:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:47:42 INFO - Fetch https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:47:43 INFO - Expected file size: 16430829 07:47:49 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 07:47:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:47:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:47:49 INFO - Fetch https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:47:50 INFO - Expected file size: 16430829 07:47:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:47:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:47:57 INFO - Fetch https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:47:57 INFO - Expected file size: 14414059 07:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:58 INFO - trying https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:47:58 INFO - Downloading https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:47:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/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 07:48:01 INFO - Downloaded 115256676 bytes. 07:48:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:48:01 INFO - mkdir: /builds/slave/test/properties 07:48:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:48:01 INFO - Writing to file /builds/slave/test/properties/build_url 07:48:01 INFO - Contents: 07:48:01 INFO - build_url:https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:48:01 INFO - Running post-action listener: _resource_record_post_action 07:48:01 INFO - Running post-action listener: set_extra_try_arguments 07:48:01 INFO - [mozharness: 2016-09-24 14:48:01.658579Z] Finished download-and-extract step (success) 07:48:01 INFO - [mozharness: 2016-09-24 14:48:01.658719Z] Running populate-webroot step. 07:48:01 INFO - Running pre-action listener: _resource_record_pre_action 07:48:01 INFO - Running main action method: populate_webroot 07:48:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:48:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:48:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:48:01 INFO - '--tppagecycles', 07:48:01 INFO - '7'], 07:48:01 INFO - 'tests': ['tsvgm']}}, 07:48:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:48:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:48:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:48:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:48:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:01 INFO - 'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:01 INFO - 'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['damp', 'tps']}, 07:48:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:01 INFO - 'tests': ['damp', 'tps']}, 07:48:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['dromaeo_dom']}, 07:48:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:48:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['basic_compositor_video']}, 07:48:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:48:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['a11yr', 07:48:01 INFO - 'ts_paint', 07:48:01 INFO - 'tpaint', 07:48:01 INFO - 'sessionrestore', 07:48:01 INFO - 'sessionrestore_no_auto_restore', 07:48:01 INFO - 'tabpaint']}, 07:48:01 INFO - 'other-e10s': {'tests': ['a11yr', 07:48:01 INFO - 'ts_paint', 07:48:01 INFO - 'tpaint', 07:48:01 INFO - 'sessionrestore', 07:48:01 INFO - 'sessionrestore_no_auto_restore', 07:48:01 INFO - 'tabpaint']}, 07:48:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:48:01 INFO - 'ts_paint', 07:48:01 INFO - 'tpaint', 07:48:01 INFO - 'sessionrestore', 07:48:01 INFO - 'sessionrestore_no_auto_restore', 07:48:01 INFO - 'tabpaint']}, 07:48:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:48:01 INFO - 'ts_paint', 07:48:01 INFO - 'tpaint', 07:48:01 INFO - 'sessionrestore', 07:48:01 INFO - 'sessionrestore_no_auto_restore', 07:48:01 INFO - 'tabpaint']}, 07:48:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['a11yr', 07:48:01 INFO - 'ts_paint', 07:48:01 INFO - 'tpaint', 07:48:01 INFO - 'sessionrestore', 07:48:01 INFO - 'sessionrestore_no_auto_restore', 07:48:01 INFO - 'tabpaint']}, 07:48:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['a11yr', 07:48:01 INFO - 'ts_paint', 07:48:01 INFO - 'tpaint', 07:48:01 INFO - 'sessionrestore', 07:48:01 INFO - 'sessionrestore_no_auto_restore', 07:48:01 INFO - 'tabpaint']}, 07:48:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['tsvgx', 07:48:01 INFO - 'tsvgr_opacity', 07:48:01 INFO - 'tart', 07:48:01 INFO - 'tscrollx', 07:48:01 INFO - 'cart']}, 07:48:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:48:01 INFO - 'tsvgr_opacity', 07:48:01 INFO - 'tart', 07:48:01 INFO - 'tscrollx', 07:48:01 INFO - 'cart']}, 07:48:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:01 INFO - 'talos_options': ['--disable-e10s'], 07:48:01 INFO - 'tests': ['tp5o']}, 07:48:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:01 INFO - 'tests': ['tp5o']}, 07:48:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:01 INFO - 'talos_options': ['--disable-e10s', 07:48:01 INFO - '--xperf_path', 07:48:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:01 INFO - 'tests': ['tp5n']}, 07:48:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:01 INFO - 'talos_options': ['--xperf_path', 07:48:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:01 INFO - 'tests': ['tp5n']}}, 07:48:01 INFO - 'talos.zip': {'path': '', 07:48:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:48:01 INFO - Running post-action listener: _resource_record_post_action 07:48:01 INFO - [mozharness: 2016-09-24 14:48:01.677274Z] Finished populate-webroot step (success) 07:48:01 INFO - [mozharness: 2016-09-24 14:48:01.677405Z] Running create-virtualenv step. 07:48:01 INFO - Running pre-action listener: _resource_record_pre_action 07:48:01 INFO - Running main action method: create_virtualenv 07:48:01 INFO - Creating virtualenv /builds/slave/test/build/venv 07:48:01 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 07:48:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:48:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:48:01 INFO - Using real prefix '/tools/python27' 07:48:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:48:02 INFO - Installing distribute.............................................................................................................................................................................................done. 07:48:05 INFO - Installing pip.................done. 07:48:05 INFO - Return code: 0 07:48:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:48:05 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')]} 07:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:05 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')]} 07:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:05 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:05 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 07:48:05 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 07:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:05 INFO - 'HOME': '/Users/cltbld', 07:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:05 INFO - 'LOGNAME': 'cltbld', 07:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:05 INFO - 'MOZ_NO_REMOTE': '1', 07:48:05 INFO - 'NO_EM_RESTART': '1', 07:48:05 INFO - 'PAGER': '/bin/cat', 07:48:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:05 INFO - 'PWD': '/builds/slave/test', 07:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:05 INFO - 'SHELL': '/bin/bash', 07:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:05 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:05 INFO - 'USER': 'cltbld', 07:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:05 INFO - 'XPC_FLAGS': '0x0', 07:48:05 INFO - 'XPC_SERVICE_NAME': '0', 07:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:05 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 07:48:05 INFO - Cleaning up... 07:48:05 INFO - Return code: 0 07:48:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:48:05 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')]} 07:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:05 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')]} 07:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:05 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:05 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 07:48:05 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 07:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:05 INFO - 'HOME': '/Users/cltbld', 07:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:05 INFO - 'LOGNAME': 'cltbld', 07:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:05 INFO - 'MOZ_NO_REMOTE': '1', 07:48:05 INFO - 'NO_EM_RESTART': '1', 07:48:05 INFO - 'PAGER': '/bin/cat', 07:48:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:05 INFO - 'PWD': '/builds/slave/test', 07:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:05 INFO - 'SHELL': '/bin/bash', 07:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:05 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:05 INFO - 'USER': 'cltbld', 07:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:05 INFO - 'XPC_FLAGS': '0x0', 07:48:05 INFO - 'XPC_SERVICE_NAME': '0', 07:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:06 INFO - Downloading/unpacking psutil>=3.1.1 07:48:06 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 07:48:06 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 07:48:06 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 07:48:06 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 07:48:06 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 07:48:06 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 07:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:48:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:09 INFO - Installing collected packages: psutil 07:48:09 INFO - Running setup.py install for psutil 07:48:09 INFO - building 'psutil._psutil_osx' extension 07:48:09 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 07:48:09 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 07:48:09 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 07:48:10 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 07:48:10 INFO - building 'psutil._psutil_posix' extension 07:48:10 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 07:48:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:48:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:48:10 INFO - ^ 07:48:10 INFO - 1 warning generated. 07:48:10 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 07:48:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:10 INFO - Successfully installed psutil 07:48:10 INFO - Cleaning up... 07:48:10 INFO - Return code: 0 07:48:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:10 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:10 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 07:48:10 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 07:48:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:10 INFO - 'HOME': '/Users/cltbld', 07:48:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:10 INFO - 'LOGNAME': 'cltbld', 07:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:10 INFO - 'MOZ_NO_REMOTE': '1', 07:48:10 INFO - 'NO_EM_RESTART': '1', 07:48:10 INFO - 'PAGER': '/bin/cat', 07:48:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:10 INFO - 'PWD': '/builds/slave/test', 07:48:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:10 INFO - 'SHELL': '/bin/bash', 07:48:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:10 INFO - 'USER': 'cltbld', 07:48:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:10 INFO - 'XPC_FLAGS': '0x0', 07:48:10 INFO - 'XPC_SERVICE_NAME': '0', 07:48:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:48:10 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 07:48:10 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 07:48:10 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 07:48:10 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 07:48:10 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 07:48:10 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 07:48:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:48:13 INFO - Installing collected packages: mozsystemmonitor 07:48:13 INFO - Running setup.py install for mozsystemmonitor 07:48:13 INFO - Successfully installed mozsystemmonitor 07:48:13 INFO - Cleaning up... 07:48:13 INFO - Return code: 0 07:48:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:48:13 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')]} 07:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:13 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')]} 07:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:13 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:13 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 07:48:13 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 07:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:13 INFO - 'HOME': '/Users/cltbld', 07:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:13 INFO - 'LOGNAME': 'cltbld', 07:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:13 INFO - 'MOZ_NO_REMOTE': '1', 07:48:13 INFO - 'NO_EM_RESTART': '1', 07:48:13 INFO - 'PAGER': '/bin/cat', 07:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:13 INFO - 'PWD': '/builds/slave/test', 07:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:13 INFO - 'SHELL': '/bin/bash', 07:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:13 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:13 INFO - 'USER': 'cltbld', 07:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:13 INFO - 'XPC_FLAGS': '0x0', 07:48:13 INFO - 'XPC_SERVICE_NAME': '0', 07:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:13 INFO - Downloading/unpacking jsonschema==2.5.1 07:48:13 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 07:48:13 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 07:48:13 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 07:48:13 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 07:48:13 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 07:48:13 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 07:48:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:48:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:16 INFO - Downloading functools32-3.2.3-2.tar.gz 07:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:48:16 INFO - warning: no files found matching '*.txt' 07:48:16 INFO - no previously-included directories found matching 'build' 07:48:16 INFO - no previously-included directories found matching 'dist' 07:48:16 INFO - no previously-included directories found matching '.git*' 07:48:16 INFO - Installing collected packages: jsonschema, functools32 07:48:16 INFO - Running setup.py install for functools32 07:48:16 INFO - warning: no files found matching '*.txt' 07:48:16 INFO - no previously-included directories found matching 'build' 07:48:16 INFO - no previously-included directories found matching 'dist' 07:48:16 INFO - no previously-included directories found matching '.git*' 07:48:16 INFO - Successfully installed jsonschema functools32 07:48:16 INFO - Cleaning up... 07:48:17 INFO - Return code: 0 07:48:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:48:17 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')]} 07:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:17 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')]} 07:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:17 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:17 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 07:48:17 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 07:48:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:17 INFO - 'HOME': '/Users/cltbld', 07:48:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:17 INFO - 'LOGNAME': 'cltbld', 07:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:17 INFO - 'MOZ_NO_REMOTE': '1', 07:48:17 INFO - 'NO_EM_RESTART': '1', 07:48:17 INFO - 'PAGER': '/bin/cat', 07:48:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:17 INFO - 'PWD': '/builds/slave/test', 07:48:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:17 INFO - 'SHELL': '/bin/bash', 07:48:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:17 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:17 INFO - 'USER': 'cltbld', 07:48:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:17 INFO - 'XPC_FLAGS': '0x0', 07:48:17 INFO - 'XPC_SERVICE_NAME': '0', 07:48:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:48:17 INFO - Cleaning up... 07:48:17 INFO - Return code: 0 07:48:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:48:17 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')]} 07:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:17 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')]} 07:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:17 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:17 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 07:48:17 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 07:48:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:17 INFO - 'HOME': '/Users/cltbld', 07:48:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:17 INFO - 'LOGNAME': 'cltbld', 07:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:17 INFO - 'MOZ_NO_REMOTE': '1', 07:48:17 INFO - 'NO_EM_RESTART': '1', 07:48:17 INFO - 'PAGER': '/bin/cat', 07:48:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:17 INFO - 'PWD': '/builds/slave/test', 07:48:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:17 INFO - 'SHELL': '/bin/bash', 07:48:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:17 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:17 INFO - 'USER': 'cltbld', 07:48:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:17 INFO - 'XPC_FLAGS': '0x0', 07:48:17 INFO - 'XPC_SERVICE_NAME': '0', 07:48:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:17 INFO - Downloading/unpacking blobuploader==1.2.4 07:48:17 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 07:48:17 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 07:48:17 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 07:48:17 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 07:48:17 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 07:48:17 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 07:48:20 INFO - Downloading blobuploader-1.2.4.tar.gz 07:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:48:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:48:20 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 07:48:20 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 07:48:20 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 07:48:20 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 07:48:20 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 07:48:20 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 07:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:48:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:48:20 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 07:48:20 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 07:48:20 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 07:48:20 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 07:48:20 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 07:48:20 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 07:48:21 INFO - Downloading docopt-0.6.1.tar.gz 07:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:48:21 INFO - Installing collected packages: blobuploader, requests, docopt 07:48:21 INFO - Running setup.py install for blobuploader 07:48:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:48:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:48:21 INFO - Running setup.py install for requests 07:48:21 INFO - Running setup.py install for docopt 07:48:22 INFO - Successfully installed blobuploader requests docopt 07:48:22 INFO - Cleaning up... 07:48:22 INFO - Return code: 0 07:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:22 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')]} 07:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:22 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')]} 07:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:22 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:22 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 07:48:22 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 07:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:22 INFO - 'HOME': '/Users/cltbld', 07:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:22 INFO - 'LOGNAME': 'cltbld', 07:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:22 INFO - 'MOZ_NO_REMOTE': '1', 07:48:22 INFO - 'NO_EM_RESTART': '1', 07:48:22 INFO - 'PAGER': '/bin/cat', 07:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:22 INFO - 'PWD': '/builds/slave/test', 07:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:22 INFO - 'SHELL': '/bin/bash', 07:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:22 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:22 INFO - 'USER': 'cltbld', 07:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:22 INFO - 'XPC_FLAGS': '0x0', 07:48:22 INFO - 'XPC_SERVICE_NAME': '0', 07:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-zR4z_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PEWiCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tLzK9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UVuf9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-o9UtkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-AtjKcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-4i9KxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Rqtz4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-YYMzYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-3Nv5NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-oOWsMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-0LkCtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-fYE1YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jFu3NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-lZHWZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-_YnnvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-wxi4Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:24 INFO - Running setup.py install for manifestparser 07:48:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:24 INFO - Running setup.py install for mozcrash 07:48:24 INFO - Running setup.py install for mozdebug 07:48:24 INFO - Running setup.py install for mozdevice 07:48:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:24 INFO - Running setup.py install for mozfile 07:48:24 INFO - Running setup.py install for mozhttpd 07:48:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:25 INFO - Running setup.py install for mozinfo 07:48:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:25 INFO - Running setup.py install for mozInstall 07:48:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:25 INFO - Running setup.py install for mozleak 07:48:25 INFO - Running setup.py install for mozlog 07:48:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:25 INFO - Running setup.py install for moznetwork 07:48:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:25 INFO - Running setup.py install for mozprocess 07:48:26 INFO - Running setup.py install for mozprofile 07:48:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:26 INFO - Running setup.py install for mozrunner 07:48:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:26 INFO - Running setup.py install for mozscreenshot 07:48:26 INFO - Running setup.py install for moztest 07:48:26 INFO - Running setup.py install for mozversion 07:48:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:26 INFO - Cleaning up... 07:48:26 INFO - Return code: 0 07:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:26 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')]} 07:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:26 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')]} 07:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:26 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:26 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 07:48:26 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 07:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:26 INFO - 'HOME': '/Users/cltbld', 07:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:26 INFO - 'LOGNAME': 'cltbld', 07:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:26 INFO - 'MOZ_NO_REMOTE': '1', 07:48:26 INFO - 'NO_EM_RESTART': '1', 07:48:26 INFO - 'PAGER': '/bin/cat', 07:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:26 INFO - 'PWD': '/builds/slave/test', 07:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:26 INFO - 'SHELL': '/bin/bash', 07:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:26 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:26 INFO - 'USER': 'cltbld', 07:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:26 INFO - 'XPC_FLAGS': '0x0', 07:48:26 INFO - 'XPC_SERVICE_NAME': '0', 07:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gRE0Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:27 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)) 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-k4aar2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:27 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)) 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-HmKVDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:27 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)) 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-kIWq7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:27 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)) 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ln9EtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:27 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)) 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PSTKkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:27 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)) 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-a1SQsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:27 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)) 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-TKUc3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:27 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)) 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ryf5ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:28 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)) 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:28 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-bItlOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:28 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)) 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:28 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-RjNO_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:28 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)) 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:28 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gidzxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:28 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)) 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:28 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-E_pcRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:28 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)) 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:28 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-zcZ5z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:28 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)) 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:28 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-3ZqbXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:28 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)) 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:28 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-eIoSF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:28 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)) 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:28 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-rjNFXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:28 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)) 07:48:28 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)) 07:48:28 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)) 07:48:28 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)) 07:48:28 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)) 07:48:28 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)) 07:48:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48:28 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 07:48:28 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 07:48:28 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 07:48:28 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 07:48:28 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 07:48:28 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 07:48:32 INFO - Downloading blessings-1.6.tar.gz 07:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:48:32 INFO - Installing collected packages: blessings 07:48:32 INFO - Running setup.py install for blessings 07:48:32 INFO - Successfully installed blessings 07:48:32 INFO - Cleaning up... 07:48:32 INFO - Return code: 0 07:48:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:32 INFO - Reading from file tmpfile_stdout 07:48:32 INFO - Current package versions: 07:48:32 INFO - blessings == 1.6 07:48:32 INFO - blobuploader == 1.2.4 07:48:32 INFO - docopt == 0.6.1 07:48:32 INFO - functools32 == 3.2.3-2 07:48:32 INFO - jsonschema == 2.5.1 07:48:32 INFO - manifestparser == 1.1 07:48:32 INFO - mozInstall == 1.12 07:48:32 INFO - mozcrash == 0.17 07:48:32 INFO - mozdebug == 0.1 07:48:32 INFO - mozdevice == 0.48 07:48:32 INFO - mozfile == 1.2 07:48:32 INFO - mozhttpd == 0.7 07:48:32 INFO - mozinfo == 0.9 07:48:32 INFO - mozleak == 0.1 07:48:32 INFO - mozlog == 3.4 07:48:32 INFO - moznetwork == 0.27 07:48:32 INFO - mozprocess == 0.23 07:48:32 INFO - mozprofile == 0.28 07:48:32 INFO - mozrunner == 6.12 07:48:32 INFO - mozscreenshot == 0.1 07:48:32 INFO - mozsystemmonitor == 0.3 07:48:32 INFO - moztest == 0.7 07:48:32 INFO - mozversion == 1.4 07:48:32 INFO - psutil == 3.1.1 07:48:32 INFO - requests == 1.2.3 07:48:32 INFO - wsgiref == 0.1.2 07:48:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:32 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')]} 07:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:32 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')]} 07:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:32 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:32 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 07:48:32 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 07:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:32 INFO - 'HOME': '/Users/cltbld', 07:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:32 INFO - 'LOGNAME': 'cltbld', 07:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:32 INFO - 'MOZ_NO_REMOTE': '1', 07:48:32 INFO - 'NO_EM_RESTART': '1', 07:48:32 INFO - 'PAGER': '/bin/cat', 07:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:32 INFO - 'PWD': '/builds/slave/test', 07:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:32 INFO - 'SHELL': '/bin/bash', 07:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:32 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:32 INFO - 'USER': 'cltbld', 07:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:32 INFO - 'XPC_FLAGS': '0x0', 07:48:32 INFO - 'XPC_SERVICE_NAME': '0', 07:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 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)) 07:48:33 INFO - Cleaning up... 07:48:33 INFO - Return code: 0 07:48:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:48: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')]} 07:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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')]} 07:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:33 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 0x103d2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ca4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb98589a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, '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.L89g8VT5Cu/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.sIec2LnjIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 07:48:33 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 07:48:33 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 07:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:33 INFO - 'HOME': '/Users/cltbld', 07:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:33 INFO - 'LOGNAME': 'cltbld', 07:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:33 INFO - 'MOZ_NO_REMOTE': '1', 07:48:33 INFO - 'NO_EM_RESTART': '1', 07:48:33 INFO - 'PAGER': '/bin/cat', 07:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:33 INFO - 'PWD': '/builds/slave/test', 07:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:33 INFO - 'SHELL': '/bin/bash', 07:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:48:33 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:33 INFO - 'USER': 'cltbld', 07:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:33 INFO - 'XPC_FLAGS': '0x0', 07:48:33 INFO - 'XPC_SERVICE_NAME': '0', 07:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:48:33 INFO - Cleaning up... 07:48:33 INFO - Return code: 0 07:48:33 INFO - Running post-action listener: _resource_record_post_action 07:48:33 INFO - Running post-action listener: _start_resource_monitoring 07:48:33 INFO - Starting resource monitoring. 07:48:33 INFO - [mozharness: 2016-09-24 14:48:33.533890Z] Finished create-virtualenv step (success) 07:48:33 INFO - [mozharness: 2016-09-24 14:48:33.534919Z] Running install step. 07:48:33 INFO - Running pre-action listener: _resource_record_pre_action 07:48:33 INFO - Running main action method: install 07:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:33 INFO - Reading from file tmpfile_stdout 07:48:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:48:33 INFO - Reading from file tmpfile_stdout 07:48:33 INFO - Output received: 07:48:33 INFO - Usage: mozinstall [options] installer 07:48:33 INFO - Options: 07:48:33 INFO - -h, --help show this help message and exit 07:48:33 INFO - -d DEST, --destination=DEST 07:48:33 INFO - Directory to install application into. [default: 07:48:33 INFO - "/builds/slave/test"] 07:48:33 INFO - --app=APP Application being installed. [default: firefox] 07:48:33 INFO - mkdir: /builds/slave/test/build/application 07:48:33 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'] 07:48:33 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 07:49:06 INFO - Reading from file tmpfile_stdout 07:49:06 INFO - Output received: 07:49:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:49:06 INFO - Running post-action listener: _resource_record_post_action 07:49:06 INFO - [mozharness: 2016-09-24 14:49:06.208028Z] Finished install step (success) 07:49:06 INFO - [mozharness: 2016-09-24 14:49:06.208188Z] Running run-tests step. 07:49:06 INFO - Running pre-action listener: _resource_record_pre_action 07:49:06 INFO - Running main action method: run_tests 07:49:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:49:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:49:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:49:06 INFO - 2016-09-24 07:49:06.222 screenresolution[1939:66130] starting screenresolution argv=screenresolution get 07:49:06 INFO - 2016-09-24 07:49:06.225 screenresolution[1939:66130] Display 0: 1600x1200x32@60 07:49:06 INFO - 2016-09-24 07:49:06.231 screenresolution[1940:66132] starting screenresolution argv=screenresolution list 07:49:06 INFO - Available Modes on Display 0 07:49:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:49:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:49:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:49:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:49:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:49:06 INFO - Intel Iris: 07:49:06 INFO - Chipset Model: Intel Iris 07:49:06 INFO - Type: GPU 07:49:06 INFO - Bus: Built-In 07:49:06 INFO - VRAM (Dynamic, Max): 1536 MB 07:49:06 INFO - Vendor: Intel (0x8086) 07:49:06 INFO - Device ID: 0x0a2e 07:49:06 INFO - Revision ID: 0x0009 07:49:06 INFO - Displays: 07:49:06 INFO - Display: 07:49:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:49:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:49:06 INFO - Display Serial Number: 1600x1200 60 07:49:06 INFO - Main Display: Yes 07:49:06 INFO - Mirror: Off 07:49:06 INFO - Online: Yes 07:49:06 INFO - Rotation: Supported 07:49:06 INFO - Return code: 0 07:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:49:06 INFO - Python 2.7.3 07:49:06 INFO - Return code: 0 07:49:06 INFO - grabbing minidump binary from tooltool 07:49: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')]} 07:49: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 0x103b42d30>, '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 0x1039a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b3ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:49: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 07:49: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 07:49: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 07:49:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:49:06 INFO - Return code: 0 07:49:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:49:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:49:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:49:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:49:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:49: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/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 07:49: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/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 07:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L89g8VT5Cu/Render', 07:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:06 INFO - 'HOME': '/Users/cltbld', 07:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:06 INFO - 'LOGNAME': 'cltbld', 07:49:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:49:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:06 INFO - 'MOZ_NO_REMOTE': '1', 07:49:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:49:06 INFO - 'NO_EM_RESTART': '1', 07:49:06 INFO - 'PAGER': '/bin/cat', 07:49:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:06 INFO - 'PWD': '/builds/slave/test', 07:49:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:06 INFO - 'SHELL': '/bin/bash', 07:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sIec2LnjIK/Listeners', 07:49:06 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 07:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:06 INFO - 'USER': 'cltbld', 07:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:06 INFO - 'XPC_FLAGS': '0x0', 07:49:06 INFO - 'XPC_SERVICE_NAME': '0', 07:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49: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/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 07:49:06 INFO - mozversion application_buildid: 20160924055025 07:49:06 INFO - mozversion application_changeset: d9c70cda4277f12c6a74be1388da4f88baf591c3 07:49:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:49:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:49:06 INFO - mozversion application_name: Firefox 07:49:06 INFO - mozversion application_remotingname: firefox-dev 07:49:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:49:06 INFO - mozversion application_vendor: Mozilla 07:49:06 INFO - mozversion application_version: 51.0a2 07:49:06 INFO - mozversion platform_buildid: 20160924055025 07:49:06 INFO - mozversion platform_changeset: d9c70cda4277f12c6a74be1388da4f88baf591c3 07:49:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:49:06 INFO - mozversion platform_version: 51.0a2 07:49:06 INFO - using testdate: 1474728546 07:49:06 INFO - actual date: 1474728546 07:49:06 INFO - starting webserver on 'localhost:53364' 07:49:06 INFO - SUITE-START | Running 2 tests 07:49:06 INFO - TEST-START | dromaeo_css 07:49:06 INFO - operating with platform_type : mac_ 07:49:06 INFO - Initialising browser for dromaeo_css test... 07:49:06 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpxlmbu_/profile http://localhost:53364/getInfo.html) 07:49:09 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 07:49:09 INFO - PROCESS | 1950 | colorDepth:24 07:49:09 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 07:49:09 INFO - PROCESS | 1950 | __metrics 07:49:09 ERROR - PROCESS | 1950 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 07:49:10 INFO - TEST-INFO | 1950: exit 0 07:49:10 INFO - Browser initialized. 07:49:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:49:10 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpxlmbu_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:22 INFO - PROCESS | 1953 | RSS: Main: 224468992 07:49:22 INFO - PROCESS | 1953 | 07:50:11 INFO - PROCESS | 1953 | 1474728611949 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] 07:52:23 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:53364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53364/tests/dromaeo/cssquery-ext.html) 07:52:25 INFO - PROCESS | 1953 | RSS: Main: 238022656 07:52:25 INFO - PROCESS | 1953 | 07:55:27 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:53364/tests/dromaeo/cssquery-ext.html (next: http://localhost:53364/tests/dromaeo/cssquery-jquery.html) 07:55:28 INFO - PROCESS | 1953 | RSS: Main: 248070144 07:55:28 INFO - PROCESS | 1953 | 07:58:30 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:53364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53364/tests/dromaeo/cssquery-mootools.html) 07:58:30 INFO - PROCESS | 1953 | RSS: Main: 250736640 07:58:30 INFO - PROCESS | 1953 | 08:01:32 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:53364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53364/tests/dromaeo/cssquery-prototype.html) 08:01:33 INFO - PROCESS | 1953 | RSS: Main: 252088320 08:01:33 INFO - PROCESS | 1953 | 08:04:36 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:53364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53364/tests/dromaeo/cssquery-yui.html) 08:04:36 INFO - PROCESS | 1953 | RSS: Main: 256516096 08:04:36 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:53364/tests/dromaeo/cssquery-yui.html (next: http://localhost:53364/tests/dromaeo/cssquery-dojo.html) 08:07:39 INFO - PROCESS | 1953 | RSS: Main: 258322432 08:07:39 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | __start_tp_report 08:07:39 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 08:07:39 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 08:07:39 INFO - PROCESS | 1953 | |i|pagename|runs| 08:07:39 INFO - PROCESS | 1953 | |0;dojo.html;3189.059227527879;3425.8972230833083;3459.723222142228;3464.584249890014;3467.861285548578;5779.07534794433;5857.472827445529;5864.384239654839;5875.88248235035;5892;5849.356570777221;5876.559258055652;5957.106434034886;5962.433568810956;5989.341172471036;5353.946460535403;5364.873376590921;5368.516833484986;5427.104527752936;5479.150731636602;4846.812530929927;5002.799888004493;5403.648762830423;5452.6455780374345;5456.508914197721;5280.2343660169445;5304.283921670563;5433.864153396157;5453.64551304166;5469.72651367432;4330.761808100553;5361.544268737162;5377.569794416438;5457.863553411157;5499.807506737285;5250.842474725764;5363.329583802025;5379.784808607651;5400.648957817729;5451.400345961941;5745.597808153431;5904.763809447617;5913.379095195029;6033.944059789563;6042.365551617105;6145.293291271516;6198.946179149555;6238.500919926395;6252.593581417239;6305.369463053704;6308.842278943017;6323.683815809237;6349.174607301067;6359.586626869285;6383.904241436382;5998.310194327621;6025.216721826222;6029.427204415573;6044.909326360152;6051.152838602599;6213.440790328892;6248.187735594343;6341.0805433212845;6355.110284560165;6371.585846920028;4758.286257061469;6240.375962403723;6247.312795592481;6255.24937007562;6264.310925798159;6268.09112678659;6294.464970477469;6306.180196574416;6310.211223597051;6412.7114279857515;5092.872678183001;6158.938410615926;6204.255489341218;6252.531060170414;6298.8425289367215;5645.576581756302;6068.150458935753;6245.094461303085;6292.779752708725;6305.432511073934;5033.546980771748;5036.194208926554;5038.269450929594;5051.444341122474;5070.391553013662;4339.370791235317;4442.155990361821;4522.773861306921;4534.614557762628;4537.1833070047705;5212.983468223736;5978.730957106941;5987.311459182162;6093.4515893568905;6122.672617327995;6211.844703882349;6262.2172228471445;6270.435660790551;6280.9685951569945;6281.057841323838;5865.589408741433;5925.970370148121;5948.256467941507;5958.165856780054;6029.487493563096;5520.392756796749;5521.779128834802;5527.778888844401;5530.225768392428;5538.224648549206;6479;6482.67586620667;6496.870062598721;6503.707333169924;6522.119513865568;5123.231515272739;6167.969160154171;6169.56813023102;6171.814845554641;6253.749850006131;6480.837979050561;6496.155499784998;6511.413972742476;6518.771842985662;6532.869342613026;6271.310155882758;6272.435480806749;6279.591826531261;6289.937100628935;6298.118263443213;5209;6146.293176284785;6193.969030154821;6250;6260.060990851409;6116.761878222105;6234.781782637586;6239.812805615838;6263.6241825490615;6272.874542509033;5184;6178.1659475971965;6211.440970312694;6221.3156552778255;6228.657423841732;5438.945610544002;5774.509166720875;5908.793192238251;6078.209832721895;6124.785632502841;4771.021940502119;6112.321110680095;6126.548209435115;6144.8939190944275;6170.167027451236;6119.133664232452;6128.655903792168;6130.765048853685;6136.637394603021;6152.630842149485 08:07:39 INFO - PROCESS | 1953 | |1;ext.html;442.40275627902355;496.71687138331146;521.2494008627576;526.8208809004938;527.4145698274914;38810.44758209672;40612;40728.796356018254;40779.9805004875;40833.59166408335;41983.79008104955;42275.36586951191;42538;42802;42872.57127428725;9599.664011759573;9629.374090684083;9679.516024198798;9779.46212958287;9786.608535658565;9628.422294662343;9720.270979676518;9756.853647195298;9762.121409073183;9763.121319081316;9716.368436051669;9758.512074396287;9810.215182785396;9827.017298270188;9861.457619830906;9708.563114659857;9715.61137554497;9736.513174341255;9747.512624368754;9801.754956126082;9652;9725.319227654067;9725.513724313827;9731.12419882214;9733.415995040321;39027.60972390268;39751.8012409939;39958.801235962965;40055;40158.397624035664;3210.727088197506;3267.4451497000064;3337.0656216259486;3360.9495857562156;3452.4130897747445;28484.00305989301;29525.814039866287;30876.53685194724;30999.22501937447;31090.68909310923;3079.7690173237097;3179.9205019874457;3197.456432406473;3201.3117179806454;3222.146131275214;513393;513846;517959.41020295036;518056;518593;60201;61376.07935880966;61542.69228653828;61803.6909815448;61975.6901215491;29507;31618;35374.11564710851;35805.8209708955;36160.457593136125;16399.42602008924;16869.987800731997;16910.661786764194;16955.321787128625;17012.57468563271;10848.78302433947;12884.96920246378;13038.087333886537;13060.085793994329;13078;15551.377944882304;16898.817082804333;18674.066296685112;19072.904635476734;19175.808241917402;7327.230640782747;7839.568823714636;7915.525068495908;7971.202879712098;7974.481658692166;850.3792231670915;941.1247539787926;942.5475771629656;969.6024629901707;1029.763154474475;24036.87981560081;28828.135155945354;30180;30290.394192116033;30943.8452807739;981.0728861226215;1021.22897212604;1034.5654824973528;1040.0483557544762;1054.414799786126;13470.39383227757;14331.641708957151;15773.684526309638;15786.36854525829;16051.197440127948;667537;676386;683378;686383.5680821564;688520.1147988556;56865.71567142138;57161.71419142878;57576;57665;57684.134737978966;1194.8864857838664;1370;1382.3364784903101;1397.3921344215298;1399.6290982889338;26074.86962565175;26133;29526.704732952396;30286.394272114874;30367.392652147275;48279.27581086357;48601;48780.5121948776;48823.535293939814;48841.755791220814;619172;620110.8994454999;622212;626648.7335126773;627751;25653.4346565342;26151.346216344744;26537;26665.466690666464;26700.332491687863;46270;46734.76632616815;47293.527064728914;47328.52671473241;47757;37119.515219392;38206.808965954995;39192.804035979636;41684.58315416807;41744.47722708404;37910.62089379071;38680.8395748128;38843.417348739225;39055.804720976215;39299.2140157201;36508.63491365052;37260.6273937268;37546.8122659385;37654.68208612686;38008.619913801616;29579.26051848721;33533.496997545546;34310;34632.65367346294;35148.82425587958;25596.23211303664;25668.229953101436;25835.741642583333;25855.577943212553;26032.609510856975 08:07:39 INFO - PROCESS | 1953 | |2;jquery.html;318.6733598061988;378.0529772918838;385.4411103899346;389.5208893061536;402.1073217457244;18651.90674046631;19741.802581974192;20337.49156271094;21101.47246318841;21257.468563285925;9291.628334866597;11847.22993005454;18437.90781046096;18803.93156752756;20699.586008279824;5304.151335786265;5429.185622156669;5519.9448005520035;5527.39198688146;5537.197106419567;4615.399998000255;5255.500727430888;5291.259223708684;5409.29679141711;5414.512693857552;5261.736913154346;5270.9736451317685;5272.446393128705;5392.352917649868;5417.160340147283;4705.576498115169;5369.62412631116;5930;6006;6124.877502449971;5708.828735137911;5720.084786434192;5879.559033072536;5908.852278693067;5912.793052243193;10776.353418794897;12152;13421.530246441327;13431.66420839477;13515.729685406237;2204.228520017981;2496.5631014572377;2662.6671666041743;2967.3323502212047;2968.688287729779;9842.311038227326;9859.556319965619;10161.949190254076;10242.487875606264;10404.635837745642;1818.3726614318039;1860.5999710062267;1884.387574038443;1903.7525121734225;1944.222311075567;92118;107396;108567;117010;119505;20796;21361.67957480639;21791.782082178976;22096.790320967775;22119.44701382446;35381.82309088438;35837;36014.8199259002;36028.819855900554;36052.73815416448;9380.8592871107;10390.896091039143;11109.388983605817;11413.315201087962;11517.905798949087;7639.618019099134;9362.25101991839;9391.953040234892;9539.52302384878;9591.705119808876;9604.079184163194;9784.608615655294;9944.552495137736;9973.202143828476;9975.453804660145;3352.2122301259183;3809.961900381016;3829.851044686583;3910.413437984268;3917.2557214129224;803.2008151888791;899.9010108888017;955.5556666150273;990.0643891522442;1020.5203554329453;20384.184632614528;21220.995050020043;21794.237201697866;21935;21967;930.1117432851611;941.8916824565125;948.151404492975;971.2036130373167;1011.1809434358194;11119.444027798578;11383.487743051583;11558.884411155781;11594.88405115938;11611.941940290413;620167;623964;628634;632914;636609;75734.62132689302;102078;129628.3518582401;131845.34077329552;144295;962.3504134709043;968.864358989742;999.0159692702682;1011.726833754882;1012.099231683802;19189.424317270503;19620.411387658394;19816.504587385432;19834.50413739668;19856;34667.41123736673;36139.58320845639;46302;56845.43154568567;56913;67117.3288267111;81139.78290325768;83038;83250;84387.5780621093;7626.771196864103;7738.187490313436;8012.839743204987;8116;8180.345572354078;9450.858237126311;12426.37868106573;12483.438245278803;12645.430955606837;12762.361881905681;10677.679669609925;10875.836862447228;11111.777764444505;11359.54561817518;11448.313101213955;9590.616375345187;10671.839922401015;10740.516676749721;10898.237123401603;10929.016388525071;10490.160787137163;10942.890571094187;10981.505832237728;11083.390413527333;11126.777464450828;7900.419916016935;7913.525188488709;7997.080335761462;8217.712380066669;8288.171182881904;10774.73063173427;10779.760327562431;10859;10889.891101088888;11052.226344155832 08:07:39 INFO - PROCESS | 1953 | |3;mootools.html;1379.7792353223483;1485.1534625263598;1661.5264649574874;1807.611363556835;1817.0914542728635;8184.304334131591;8475.364347673934;8686.91313086869;9277.953610231947;9294.209992150667;7780.8832867507035;8008.599570021504;8021.799455013627;9000.144986226298;9013.774655633613;2015.7379540659767;2189.474526113729;2369.57825304817;2438.317271164068;2454.4109413740753;2005.3983804858558;2433.85396876188;2440.9511809763794;2460.5570997220493;2471.789897858684;2447.596146635803;2449.8530088194675;2450.4853980664084;2458.9262322130367;2464.3223113643803;2139.529303553216;2428.3807629054477;2433.452473193535;2449.865257410842;2452.411421258903;2425.866577338246;2441.6215486599604;2444.5966415541416;2446.1805295226122;2451;9031.683891063847;9091.909080909238;9159.038300978435;9173.220276276525;9186;5347.973260133675;5396.514313711785;5417.943501017303;5522.751476183541;5524.806631767909;3654.9086272843124;3670.210904655512;3695.2609478104487;3712.127650002274;3724.1434470072036;1079.6653037558383;1093.7648405592756;1099.5601759296264;1101.7851518953807;1102.5755084292525;12077.577284795078;12147.210431321935;12183.573574924834;12199.268043917393;12238.632841014873;4836.056968891033;4854.150523658345;4885.5847252983185;4960.958198778225;5021.924671129936;10124.69625911224;10238.33450825694;10288.845667314847;10301.433421161908;10308.587656493657;4541.500434952152;5385.7307134643115;5491.890162196733;5493.505584497414;5499.4225606310765;4386.122775444924;4517.909641807146;4838.903221935612;4959.950400495949;4985.326980857611;3556.8440256916606;4005.7796821174534;4027.194561087794;4123.793810309473;4134.214499245134;1136.86926003509;1312.2126723965544;1324.6357251755844;1326.9336533173303;1336.525533435636;870.2602787630464;871.4205053639386;911.3438324406417;914.5792935249726;933.0203286549232;5957.731902064417;6025.276966763929;6066.332703402622;6098.786542470993;6150.384961503813;952.7570469530364;960.8606752021058;964.7057647417465;976.2434113562047;986.1174249047206;4008.238434697398;4008.8596899108393;4078.490188726409;4091.6931230157857;4109.219248342805;9324.533773311307;9923.553440095213;10785.56857725698;10792.812790593029;11178.776424471465;10862.293950893167;10920.563177472972;11028;11099.5560177592;11127.109831213484;7999.680012799539;8212.794680132925;8417.032041315204;8431.494110353398;8481.957590212132;5274.446183150714;6007.738374941311;6083.6653984029535;6085.878282434238;6259.123722678738;10060.597576097167;10247.282690211614;10292.279540432099;10311.432871192157;10312.02035806597;9252.565852292906;10019.699409017741;10274.743131421475;10502.579896804042;10572.259941803999;7099.503034787515;7338.926610733824;7546.6981320748755;7563.697452101855;7773.844523109619;8539.060703322753;8722.694705685271;8742.737717868475;8753.12468753145;8775.868361974703;7487.8876816846705;7557.168711441627;7635.427342949412;7638.961805190938;7722.92277077222;6655.168103987002;6678.379619462198;7225.096862892138;7547.73582924595;7670.7315243966195;6383;6770.78125937336;7131.322524360177;7204.56772593646;7212.495125341386;4451.6661250407;5031.949680503149;5060.822871199491;5104.897902042013;5163.483651634957;4490;5131.281620573197;5189.896202076013;5259.605529585373;5298.523132918056 08:07:39 INFO - PROCESS | 1953 | |4;prototype.html;279.801341047856;300.7083129364516;311.1800405930373;312.4126641913203;317.2038184157765;5341.545968592674;5515.944840551593;5531.502164805167;5596.58025648076;5707.5148612368;5231.319928409311;5350.224217488462;5417.295751552293;5447.727613619313;5454.372747134071;3790.2419516096893;4182.6862985276075;4185.414042034103;4189.476315460567;4213.410122582841;3563.216092459668;3736.4395340698975;3749.1564398010364;3863.536375634928;4199.223143718422;3921.9215615687667;3950.2889479893606;4050.453188819516;4164.354525048622;4200.3069493533685;3421.469672200813;3460.3425349183826;4171.520275168364;4176.874693759192;4199.622034016923;3524.1542029912894;3611.4221724524214;3629.5825980012373;3635.1820840310984;3639.089478024032;4364.759938203398;4596.49438561758;5113.897722045575;5385;5427.6200665953;4561.217657229087;4701.64737644678;4827.179379505493;4838.225883858566;4846.515348465161;5751.756814842215;5821.767129314822;5878.706064696791;5894.675792831393;5896.852578685524;3569.1434055826676;3665.6173487233245;3692.6861216796606;3932.5477570079233;3958.881233562969;5652.830415087554;5782.479576838105;6057.151998720183;6144.784932527385;6278.058291256302;4017.6183262590007;4020.2160578686876;4025.3358195897936;4045.6763458923215;4058.492688413948;3564.429691249388;3775.528058992626;3958.7822669752863;4022.597740225954;4039.343869013749;3953.2686453006286;4718.740469274223;4730.314104454835;4744.881377965578;4753.453352864396;5179.456157103526;5819.854503637358;5864.970675146597;5920.733566989496;5943.494802941798;1095.6603452929617;1123.662901129658;1280.6553119224777;1369.760291948925;1379.3861731529373;727.7089164334203;741.269849198539;818.3289702443939;834.3033566971646;839.8320335932716;4435.822567097344;4633.791479383436;4678.3216433616935;4689.859304220879;4715.877854965211;3937.9803100984313;4055.4322394864744;4152.5432202457705;5039.3952725672425;5076.974615126901;4008.959910400917;4117.8970525737095;4667.016517979845;4679.766011699401;4700.130475861976;2242.856143366862;2326.2904814031544;2371.5612611666897;2503.14641308908;2624.7375262473984;4556.810232837028;4744.810207591727;5134.5341894222;5257.764425360037;5263;4284.764337961442;4770.833020844254;4787.736674482867;5224.294720212799;5237.852480482984;4509.053098849213;4775.450823155312;4863.90272194547;6465.903011454832;6474.482041436768;5251.684898906078;5898.557608179318;6080.148779171008;6178.474829639351;6209.720562574786;5718.599698021098;5823.1847541343395;5889.558283128868;5889.617174883619;6105.755769769159;5513.696746678971;5523.834284971457;5789.855253618524;6326.367363263636;6363.331850155852;3580.928381432409;3984.8007599620482;4052.209819085368;4069.8372065117064;4089.9795501022304;4977.411745892044;5417.295751552273;5737.110747834093;5991.2510936132985;6182.629042257479;5684.436779885565;5765.3946335634155;5984.820455386345;5988.700564971821;6014.939850601613;4562.817487300471;5677.672154416835;5956.731947062306;5992.711567013113;6020.90968635462;4358.86923392286;5302.39022512416;5411.161270003156;5617.466340697627;5794.420557944172;5620.4098569649595;5652.321721393295;5825.533957283492;5838.416158384298;5904.468597826216;5240.633155679066;5804.01331773591;5828.475437210672;5831.825045248649;5889.52883769306 08:07:39 INFO - PROCESS | 1953 | |5;yui.html;679.1544527063807;698.0889938630087;702.4977141343938;708.4686485136148;749.8762704153814;15192.088474691527;15392.461263855766;15571.06573605583;15698.529044128665;15751.976121552105;11912.52349906005;13991.090579112377;14110.082844615119;14166.575002749909;14279.143251404897;675.8409328002475;698.9685464154126;822.7161629237903;822.7984143884756;825.0264687668549;611.4588589098657;673.8079647300495;799.3684988858795;820.3888103363003;834.1825011488745;873.2402809555696;887.6405055952317;891.6076926152505;892.8616064510011;893.1782759860944;854.2055888024136;873.8470767615673;886.5567216391804;887.1572006593698;887.8135591525787;646.4569761400446;654.8493846415304;656.1601150527333;658.6048370977423;660.4452260101538;14712.852871471256;14716.264186790617;14727.263636818223;14733.631659208499;14743.894207934341;14492.20292883891;14521.927390363086;14550.854491455057;14907.92546037263;14959.252037398195;11535.307881527135;11997.920187183196;12030.69923251917;12047.879521204852;12379.75240495194;3794;3799.5820459749407;3814.885553433374;3883.262180185756;3902.0635047588657;119085;121279;122339.99999999911;122357.38821305925;122630;10783.245172837826;10931.726706832393;11007.559697612005;11264.54941802335;11340.94329528347;22647;23445.531089378117;23470.17854375123;23472.413189670395;23528.882355588114;8040.718574849852;8149;8173.918260817434;8306.252437280673;8454.704085356983;4459.375687403766;4490.281554951257;4527.139843429738;4584.15193189261;4607.585317321457;3557.6442355764734;3630.945535816965;3727.962720372816;3801.7718936863876;3988.581198974124;712.8217945513621;730.5251586468731;733.6331834082958;741.0736579275905;744.1776836595592;622.707327556057;645.3997782062727;648.3548868875499;658.5949640970769;663.1014974709296;9212.493312867857;9602.711918642452;9651.841095425714;9746.853797193047;9794.902050979541;569.6838254768643;605.1739375752067;650.1320736816309;652.1847690387016;676.8680107379014;4559.563737422701;4737.8341758038305;4756.286557016406;4788.521147885183;4800.39162404096;119318.4034079824;135509;136694.48180350175;139672.20655586832;144609;66288.33711662918;78776;92122.53938730263;97356;106000;84559.57720211483;108025;111037;111072.44463777791;114337.42831285957;7013.824654383681;8980.281577473655;9015.188633023059;9125.133112354315;9178.403403778733;52355.73822130865;55446.44553554413;60891.21704902517;61446.69276653767;62201.68899155475;86747.56626216829;86794;91192.54403727938;93474.13051739063;95054;11360.261582997078;11737.237079589799;11752.94123529411;11884.702882428008;11928.58249961282;12400.937995309965;13072.542461013818;13428.93285533566;13441.663958400726;13465.932670336586;12265.202761820454;12496.87503124957;12902.225866448043;12939.611811645666;12944.288064156563;12512.37438128108;12530.812037819622;12575;13011.804822927854;13036.47854085826;12275.079369047537;12509.186902851285;12623.621291361274;12642.30467324306;12658.936705316415;10119.342242754197;10284.074433301039;10358.689239322832;10777.89222107769;11078.778424431628;10436.895631043591;10664;10665.200109991627;10665.36007839532;10690.25168238247 08:07:39 INFO - PROCESS | 1953 | __end_tp_report 08:07:39 INFO - PROCESS | 1953 | __start_cc_report 08:07:39 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,361 08:07:39 INFO - PROCESS | 1953 | __end_cc_report 08:07:39 INFO - PROCESS | 1953 | __startTimestamp1474729659744__endTimestamp 08:07:39 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | ------- Summary: start ------- 08:07:39 INFO - PROCESS | 1953 | Number of tests: 6 08:07:39 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5803.11 Median:6051.15 stddev:662.95 (11.0%) stddev-sans-first:632.48 08:07:39 INFO - PROCESS | 1953 | Values: 3189.1 3425.9 3459.7 3464.6 3467.9 5779.1 5857.5 5864.4 5875.9 5892.0 5849.4 5876.6 5957.1 5962.4 5989.3 5353.9 5364.9 5368.5 5427.1 5479.2 4846.8 5002.8 5403.6 5452.6 5456.5 5280.2 5304.3 5433.9 5453.6 5469.7 4330.8 5361.5 5377.6 5457.9 5499.8 5250.8 5363.3 5379.8 5400.6 5451.4 5745.6 5904.8 5913.4 6033.9 6042.4 6145.3 6198.9 6238.5 6252.6 6305.4 6308.8 6323.7 6349.2 6359.6 6383.9 5998.3 6025.2 6029.4 6044.9 6051.2 6213.4 6248.2 6341.1 6355.1 6371.6 4758.3 6240.4 6247.3 6255.2 6264.3 6268.1 6294.5 6306.2 6310.2 6412.7 5092.9 6158.9 6204.3 6252.5 6298.8 5645.6 6068.2 6245.1 6292.8 6305.4 5033.5 5036.2 5038.3 5051.4 5070.4 4339.4 4442.2 4522.8 4534.6 4537.2 5213.0 5978.7 5987.3 6093.5 6122.7 6211.8 6262.2 6270.4 6281.0 6281.1 5865.6 5926.0 5948.3 5958.2 6029.5 5520.4 5521.8 5527.8 5530.2 5538.2 6479.0 6482.7 6496.9 6503.7 6522.1 5123.2 6168.0 6169.6 6171.8 6253.7 6480.8 6496.2 6511.4 6518.8 6532.9 6271.3 6272.4 6279.6 6289.9 6298.1 5209.0 6146.3 6194.0 6250.0 6260.1 6116.8 6234.8 6239.8 6263.6 6272.9 5184.0 6178.2 6211.4 6221.3 6228.7 5438.9 5774.5 5908.8 6078.2 6124.8 4771.0 6112.3 6126.5 6144.9 6170.2 6119.1 6128.7 6130.8 6136.6 6152.6 08:07:39 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:72468.25 Median:39855.30 stddev:163574.35 (410.4%) stddev-sans-first:163943.82 08:07:39 INFO - PROCESS | 1953 | Values: 442.4 496.7 521.2 526.8 527.4 38810.4 40612.0 40728.8 40780.0 40833.6 41983.8 42275.4 42538.0 42802.0 42872.6 9599.7 9629.4 9679.5 9779.5 9786.6 9628.4 9720.3 9756.9 9762.1 9763.1 9716.4 9758.5 9810.2 9827.0 9861.5 9708.6 9715.6 9736.5 9747.5 9801.8 9652.0 9725.3 9725.5 9731.1 9733.4 39027.6 39751.8 39958.8 40055.0 40158.4 3210.7 3267.4 3337.1 3360.9 3452.4 28484.0 29525.8 30876.5 30999.2 31090.7 3079.8 3179.9 3197.5 3201.3 3222.1 513393.0 513846.0 517959.4 518056.0 518593.0 60201.0 61376.1 61542.7 61803.7 61975.7 29507.0 31618.0 35374.1 35805.8 36160.5 16399.4 16870.0 16910.7 16955.3 17012.6 10848.8 12885.0 13038.1 13060.1 13078.0 15551.4 16898.8 18674.1 19072.9 19175.8 7327.2 7839.6 7915.5 7971.2 7974.5 850.4 941.1 942.5 969.6 1029.8 24036.9 28828.1 30180.0 30290.4 30943.8 981.1 1021.2 1034.6 1040.0 1054.4 13470.4 14331.6 15773.7 15786.4 16051.2 667537.0 676386.0 683378.0 686383.6 688520.1 56865.7 57161.7 57576.0 57665.0 57684.1 1194.9 1370.0 1382.3 1397.4 1399.6 26074.9 26133.0 29526.7 30286.4 30367.4 48279.3 48601.0 48780.5 48823.5 48841.8 619172.0 620110.9 622212.0 626648.7 627751.0 25653.4 26151.3 26537.0 26665.5 26700.3 46270.0 46734.8 47293.5 47328.5 47757.0 37119.5 38206.8 39192.8 41684.6 41744.5 37910.6 38680.8 38843.4 39055.8 39299.2 36508.6 37260.6 37546.8 37654.7 38008.6 29579.3 33533.5 34310.0 34632.7 35148.8 25596.2 25668.2 25835.7 25855.6 26032.6 08:07:39 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:35807.16 Median:35925.91 stddev:104179.97 (290.0%) stddev-sans-first:104438.15 08:07:39 INFO - PROCESS | 1953 | Values: 318.7 378.1 385.4 389.5 402.1 18651.9 19741.8 20337.5 21101.5 21257.5 9291.6 11847.2 18437.9 18803.9 20699.6 5304.2 5429.2 5519.9 5527.4 5537.2 4615.4 5255.5 5291.3 5409.3 5414.5 5261.7 5271.0 5272.4 5392.4 5417.2 4705.6 5369.6 5930.0 6006.0 6124.9 5708.8 5720.1 5879.6 5908.9 5912.8 10776.4 12152.0 13421.5 13431.7 13515.7 2204.2 2496.6 2662.7 2967.3 2968.7 9842.3 9859.6 10161.9 10242.5 10404.6 1818.4 1860.6 1884.4 1903.8 1944.2 92118.0 107396.0 108567.0 117010.0 119505.0 20796.0 21361.7 21791.8 22096.8 22119.4 35381.8 35837.0 36014.8 36028.8 36052.7 9380.9 10390.9 11109.4 11413.3 11517.9 7639.6 9362.3 9392.0 9539.5 9591.7 9604.1 9784.6 9944.6 9973.2 9975.5 3352.2 3810.0 3829.9 3910.4 3917.3 803.2 899.9 955.6 990.1 1020.5 20384.2 21221.0 21794.2 21935.0 21967.0 930.1 941.9 948.2 971.2 1011.2 11119.4 11383.5 11558.9 11594.9 11611.9 620167.0 623964.0 628634.0 632914.0 636609.0 75734.6 102078.0 129628.4 131845.3 144295.0 962.4 968.9 999.0 1011.7 1012.1 19189.4 19620.4 19816.5 19834.5 19856.0 34667.4 36139.6 46302.0 56845.4 56913.0 67117.3 81139.8 83038.0 83250.0 84387.6 7626.8 7738.2 8012.8 8116.0 8180.3 9450.9 12426.4 12483.4 12645.4 12762.4 10677.7 10875.8 11111.8 11359.5 11448.3 9590.6 10671.8 10740.5 10898.2 10929.0 10490.2 10942.9 10981.5 11083.4 11126.8 7900.4 7913.5 7997.1 8217.7 8288.2 10774.7 10779.8 10859.0 10889.9 11052.2 08:07:39 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:5794.64 Median:4922.77 stddev:3257.16 (66.2%) stddev-sans-first:3249.39 08:07:39 INFO - PROCESS | 1953 | Values: 1379.8 1485.2 1661.5 1807.6 1817.1 8184.3 8475.4 8686.9 9278.0 9294.2 7780.9 8008.6 8021.8 9000.1 9013.8 2015.7 2189.5 2369.6 2438.3 2454.4 2005.4 2433.9 2441.0 2460.6 2471.8 2447.6 2449.9 2450.5 2458.9 2464.3 2139.5 2428.4 2433.5 2449.9 2452.4 2425.9 2441.6 2444.6 2446.2 2451.0 9031.7 9091.9 9159.0 9173.2 9186.0 5348.0 5396.5 5417.9 5522.8 5524.8 3654.9 3670.2 3695.3 3712.1 3724.1 1079.7 1093.8 1099.6 1101.8 1102.6 12077.6 12147.2 12183.6 12199.3 12238.6 4836.1 4854.2 4885.6 4961.0 5021.9 10124.7 10238.3 10288.8 10301.4 10308.6 4541.5 5385.7 5491.9 5493.5 5499.4 4386.1 4517.9 4838.9 4960.0 4985.3 3556.8 4005.8 4027.2 4123.8 4134.2 1136.9 1312.2 1324.6 1326.9 1336.5 870.3 871.4 911.3 914.6 933.0 5957.7 6025.3 6066.3 6098.8 6150.4 952.8 960.9 964.7 976.2 986.1 4008.2 4008.9 4078.5 4091.7 4109.2 9324.5 9923.6 10785.6 10792.8 11178.8 10862.3 10920.6 11028.0 11099.6 11127.1 7999.7 8212.8 8417.0 8431.5 8482.0 5274.4 6007.7 6083.7 6085.9 6259.1 10060.6 10247.3 10292.3 10311.4 10312.0 9252.6 10019.7 10274.7 10502.6 10572.3 7099.5 7338.9 7546.7 7563.7 7773.8 8539.1 8722.7 8742.7 8753.1 8775.9 7487.9 7557.2 7635.4 7639.0 7722.9 6655.2 6678.4 7225.1 7547.7 7670.7 6383.0 6770.8 7131.3 7204.6 7212.5 4451.7 5031.9 5060.8 5104.9 5163.5 4490.0 5131.3 5189.9 5259.6 5298.5 08:07:39 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:4532.10 Median:4807.46 stddev:1457.59 (30.3%) stddev-sans-first:1426.31 08:07:39 INFO - PROCESS | 1953 | Values: 279.8 300.7 311.2 312.4 317.2 5341.5 5515.9 5531.5 5596.6 5707.5 5231.3 5350.2 5417.3 5447.7 5454.4 3790.2 4182.7 4185.4 4189.5 4213.4 3563.2 3736.4 3749.2 3863.5 4199.2 3921.9 3950.3 4050.5 4164.4 4200.3 3421.5 3460.3 4171.5 4176.9 4199.6 3524.2 3611.4 3629.6 3635.2 3639.1 4364.8 4596.5 5113.9 5385.0 5427.6 4561.2 4701.6 4827.2 4838.2 4846.5 5751.8 5821.8 5878.7 5894.7 5896.9 3569.1 3665.6 3692.7 3932.5 3958.9 5652.8 5782.5 6057.2 6144.8 6278.1 4017.6 4020.2 4025.3 4045.7 4058.5 3564.4 3775.5 3958.8 4022.6 4039.3 3953.3 4718.7 4730.3 4744.9 4753.5 5179.5 5819.9 5865.0 5920.7 5943.5 1095.7 1123.7 1280.7 1369.8 1379.4 727.7 741.3 818.3 834.3 839.8 4435.8 4633.8 4678.3 4689.9 4715.9 3938.0 4055.4 4152.5 5039.4 5077.0 4009.0 4117.9 4667.0 4679.8 4700.1 2242.9 2326.3 2371.6 2503.1 2624.7 4556.8 4744.8 5134.5 5257.8 5263.0 4284.8 4770.8 4787.7 5224.3 5237.9 4509.1 4775.5 4863.9 6465.9 6474.5 5251.7 5898.6 6080.1 6178.5 6209.7 5718.6 5823.2 5889.6 5889.6 6105.8 5513.7 5523.8 5789.9 6326.4 6363.3 3580.9 3984.8 4052.2 4069.8 4090.0 4977.4 5417.3 5737.1 5991.3 6182.6 5684.4 5765.4 5984.8 5988.7 6014.9 4562.8 5677.7 5956.7 5992.7 6020.9 4358.9 5302.4 5411.2 5617.5 5794.4 5620.4 5652.3 5825.5 5838.4 5904.5 5240.6 5804.0 5828.5 5831.8 5889.5 08:07:39 INFO - PROCESS | 1953 | 08:07:39 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:23298.70 Median:3808.33 stddev:36428.40 (956.5%) stddev-sans-first:36491.00 08:07:39 INFO - PROCESS | 1953 | Values: 679.2 698.1 702.5 708.5 749.9 15192.1 15392.5 15571.1 15698.5 15752.0 11912.5 13991.1 14110.1 14166.6 14279.1 675.8 699.0 822.7 822.8 825.0 611.5 673.8 799.4 820.4 834.2 873.2 887.6 891.6 892.9 893.2 854.2 873.8 886.6 887.2 887.8 646.5 654.8 656.2 658.6 660.4 14712.9 14716.3 14727.3 14733.6 14743.9 14492.2 14521.9 14550.9 14907.9 14959.3 11535.3 11997.9 12030.7 12047.9 12379.8 3794.0 3799.6 3814.9 3883.3 3902.1 119085.0 121279.0 122340.0 122357.4 122630.0 10783.2 10931.7 11007.6 11264.5 11340.9 22647.0 23445.5 23470.2 23472.4 23528.9 8040.7 8149.0 8173.9 8306.3 8454.7 4459.4 4490.3 4527.1 4584.2 4607.6 3557.6 3630.9 3728.0 3801.8 3988.6 712.8 730.5 733.6 741.1 744.2 622.7 645.4 648.4 658.6 663.1 9212.5 9602.7 9651.8 9746.9 9794.9 569.7 605.2 650.1 652.2 676.9 4559.6 4737.8 4756.3 4788.5 4800.4 119318.4 135509.0 136694.5 139672.2 144609.0 66288.3 78776.0 92122.5 97356.0 106000.0 84559.6 108025.0 111037.0 111072.4 114337.4 7013.8 8980.3 9015.2 9125.1 9178.4 52355.7 55446.4 60891.2 61446.7 62201.7 86747.6 86794.0 91192.5 93474.1 95054.0 11360.3 11737.2 11752.9 11884.7 11928.6 12400.9 13072.5 13428.9 13441.7 13465.9 12265.2 12496.9 12902.2 12939.6 12944.3 12512.4 12530.8 12575.0 13011.8 13036.5 12275.1 12509.2 12623.6 12642.3 12658.9 10119.3 10284.1 10358.7 10777.9 11078.8 10436.9 10664.0 10665.2 10665.4 10690.3 08:07:39 INFO - PROCESS | 1953 | -------- Summary: end -------- 08:07:39 INFO - PROCESS | 1953 | 08:07:40 INFO - TEST-INFO | 1953: exit 0 08:07:40 INFO - TEST-OK | dromaeo_css | took 1113581ms 08:07:40 INFO - TEST-START | kraken 08:07:40 INFO - operating with platform_type : mac_ 08:07:40 INFO - Initialising browser for kraken test... 08:07:40 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpt67iap/profile http://localhost:53364/getInfo.html) 08:07:43 INFO - PROCESS | 1957 | __metrics Screen width/height:1600/1200 08:07:43 INFO - PROCESS | 1957 | colorDepth:24 08:07:43 INFO - PROCESS | 1957 | Browser inner width/height: 1024/689 08:07:43 INFO - PROCESS | 1957 | __metrics 08:07:43 ERROR - PROCESS | 1957 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 08:07:43 INFO - TEST-INFO | 1957: exit 0 08:07:43 INFO - Browser initialized. 08:07:43 INFO - Running cycle 1/1 for kraken test... 08:07:43 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpt67iap/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:55 INFO - PROCESS | 1959 | RSS: Main: 224661504 08:07:55 INFO - PROCESS | 1959 | 08:07:58 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53364/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:59 INFO - PROCESS | 1959 | RSS: Main: 237060096 08:07:59 INFO - PROCESS | 1959 | 08:08:02 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53364/tests/kraken/driver.html?testName=audio-dft) 08:08:02 INFO - PROCESS | 1959 | RSS: Main: 245395456 08:08:02 INFO - PROCESS | 1959 | 08:08:06 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53364/tests/kraken/driver.html?testName=audio-fft) 08:08:07 INFO - PROCESS | 1959 | RSS: Main: 248569856 08:08:07 INFO - PROCESS | 1959 | 08:08:09 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53364/tests/kraken/driver.html?testName=audio-oscillator) 08:08:09 INFO - PROCESS | 1959 | RSS: Main: 248586240 08:08:09 INFO - PROCESS | 1959 | 08:08:11 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:08:12 INFO - PROCESS | 1959 | RSS: Main: 248721408 08:08:12 INFO - PROCESS | 1959 | 08:08:15 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53364/tests/kraken/driver.html?testName=imaging-darkroom) 08:08:15 INFO - PROCESS | 1959 | RSS: Main: 249417728 08:08:15 INFO - PROCESS | 1959 | 08:08:18 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53364/tests/kraken/driver.html?testName=imaging-desaturate) 08:08:19 INFO - PROCESS | 1959 | RSS: Main: 250703872 08:08:19 INFO - PROCESS | 1959 | 08:08:22 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53364/tests/kraken/driver.html?testName=json-parse-financial) 08:08:23 INFO - PROCESS | 1959 | RSS: Main: 250998784 08:08:23 INFO - PROCESS | 1959 | 08:08:24 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:08:25 INFO - PROCESS | 1959 | RSS: Main: 250818560 08:08:25 INFO - PROCESS | 1959 | 08:08:27 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53364/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:08:28 INFO - PROCESS | 1959 | RSS: Main: 250695680 08:08:28 INFO - PROCESS | 1959 | 08:08:30 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:08:30 INFO - PROCESS | 1959 | RSS: Main: 250798080 08:08:30 INFO - PROCESS | 1959 | 08:08:33 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:08:34 INFO - PROCESS | 1959 | RSS: Main: 251080704 08:08:34 INFO - PROCESS | 1959 | 08:08:37 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:08:38 INFO - PROCESS | 1959 | RSS: Main: 251142144 08:08:38 INFO - PROCESS | 1959 | 08:08:39 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:53364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53364/tests/kraken/driver.html?testName=ai-astar) 08:08:40 INFO - PROCESS | 1959 | RSS: Main: 252510208 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | __start_tp_report 08:08:40 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 08:08:40 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 08:08:40 INFO - PROCESS | 1959 | |i|pagename|runs| 08:08:40 INFO - PROCESS | 1959 | |0;ai-astar;103;121;166;116;116;117;142;174;118;118 08:08:40 INFO - PROCESS | 1959 | |1;audio-beat-detection;143;113;145;146;112;118;114;137;126;144 08:08:40 INFO - PROCESS | 1959 | |2;audio-dft;210;199;195;204;197;195;196;248;279;194 08:08:40 INFO - PROCESS | 1959 | |3;audio-fft;87;60;50;84;84;88;50;71;102;86 08:08:40 INFO - PROCESS | 1959 | |4;audio-oscillator;83;70;87;65;73;80;125;100;70;87 08:08:40 INFO - PROCESS | 1959 | |5;imaging-gaussian-blur;100;133;89;90;89;87;93;85;87;85 08:08:40 INFO - PROCESS | 1959 | |6;imaging-darkroom;105;154;95;135;103;95;97;98;131;94 08:08:40 INFO - PROCESS | 1959 | |7;imaging-desaturate;82;96;139;150;149;90;116;89;152;149 08:08:40 INFO - PROCESS | 1959 | |8;json-parse-financial;55;56;56;55;59;60;59;58;59;61 08:08:40 INFO - PROCESS | 1959 | |9;json-stringify-tinderbox;73;66;72;81;67;93;103;102;102;85 08:08:40 INFO - PROCESS | 1959 | |10;stanford-crypto-aes;83;87;86;85;81;88;84;84;84;86 08:08:40 INFO - PROCESS | 1959 | |11;stanford-crypto-ccm;143;164;154;153;137;136;141;140;197;149 08:08:40 INFO - PROCESS | 1959 | |12;stanford-crypto-pbkdf2;169;163;166;163;166;166;191;230;152;239 08:08:40 INFO - PROCESS | 1959 | |13;stanford-crypto-sha256-iterative;69;69;69;81;91;92;85;88;76;68 08:08:40 INFO - PROCESS | 1959 | __end_tp_report 08:08:40 INFO - PROCESS | 1959 | __start_cc_report 08:08:40 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,940 08:08:40 INFO - PROCESS | 1959 | __end_cc_report 08:08:40 INFO - PROCESS | 1959 | __startTimestamp1474729720167__endTimestamp 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | ------- Summary: start ------- 08:08:40 INFO - PROCESS | 1959 | Number of tests: 14 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#0] ai-astar Cycles:10 Average:129.10 Median:119.50 stddev:23.63 (19.8%) stddev-sans-first:23.10 08:08:40 INFO - PROCESS | 1959 | Values: 103.0 121.0 166.0 116.0 116.0 117.0 142.0 174.0 118.0 118.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:140.00 stddev:14.62 (10.4%) stddev-sans-first:14.71 08:08:40 INFO - PROCESS | 1959 | Values: 143.0 113.0 145.0 146.0 112.0 118.0 114.0 137.0 126.0 144.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#2] audio-dft Cycles:10 Average:211.70 Median:201.50 stddev:28.68 (14.2%) stddev-sans-first:30.42 08:08:40 INFO - PROCESS | 1959 | Values: 210.0 199.0 195.0 204.0 197.0 195.0 196.0 248.0 279.0 194.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#3] audio-fft Cycles:10 Average:76.20 Median:84.00 stddev:17.64 (21.0%) stddev-sans-first:18.28 08:08:40 INFO - PROCESS | 1959 | Values: 87.0 60.0 50.0 84.0 84.0 88.0 50.0 71.0 102.0 86.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:76.50 stddev:17.78 (23.2%) stddev-sans-first:18.86 08:08:40 INFO - PROCESS | 1959 | Values: 83.0 70.0 87.0 65.0 73.0 80.0 125.0 100.0 70.0 87.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#5] imaging-gaussian-blur Cycles:10 Average:93.80 Median:88.00 stddev:14.47 (16.4%) stddev-sans-first:15.17 08:08:40 INFO - PROCESS | 1959 | Values: 100.0 133.0 89.0 90.0 89.0 87.0 93.0 85.0 87.0 85.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#6] imaging-darkroom Cycles:10 Average:110.70 Median:94.50 stddev:21.32 (22.6%) stddev-sans-first:22.51 08:08:40 INFO - PROCESS | 1959 | Values: 105.0 154.0 95.0 135.0 103.0 95.0 97.0 98.0 131.0 94.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#7] imaging-desaturate Cycles:10 Average:121.20 Median:117.00 stddev:29.53 (25.2%) stddev-sans-first:27.71 08:08:40 INFO - PROCESS | 1959 | Values: 82.0 96.0 139.0 150.0 149.0 90.0 116.0 89.0 152.0 149.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:59.00 stddev:2.15 (3.6%) stddev-sans-first:2.03 08:08:40 INFO - PROCESS | 1959 | Values: 55.0 56.0 56.0 55.0 59.0 60.0 59.0 58.0 59.0 61.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#9] json-stringify-tinderbox Cycles:10 Average:84.40 Median:72.50 stddev:14.82 (20.4%) stddev-sans-first:15.13 08:08:40 INFO - PROCESS | 1959 | Values: 73.0 66.0 72.0 81.0 67.0 93.0 103.0 102.0 102.0 85.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.50 stddev:2.04 (2.4%) stddev-sans-first:2.06 08:08:40 INFO - PROCESS | 1959 | Values: 83.0 87.0 86.0 85.0 81.0 88.0 84.0 84.0 84.0 86.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:151.00 stddev:18.28 (12.1%) stddev-sans-first:19.13 08:08:40 INFO - PROCESS | 1959 | Values: 143.0 164.0 154.0 153.0 137.0 136.0 141.0 140.0 197.0 149.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:167.50 stddev:30.13 (18.0%) stddev-sans-first:31.67 08:08:40 INFO - PROCESS | 1959 | Values: 169.0 163.0 166.0 163.0 166.0 166.0 191.0 230.0 152.0 239.0 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - PROCESS | 1959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:83.00 stddev:9.80 (11.8%) stddev-sans-first:9.73 08:08:40 INFO - PROCESS | 1959 | Values: 69.0 69.0 69.0 81.0 91.0 92.0 85.0 88.0 76.0 68.0 08:08:40 INFO - PROCESS | 1959 | -------- Summary: end -------- 08:08:40 INFO - PROCESS | 1959 | 08:08:40 INFO - TEST-INFO | 1959: exit 0 08:08:40 INFO - TEST-OK | kraken | took 60563ms 08:08:40 INFO - SUITE-END | took 1174s 08:08:41 INFO - Completed test suite (00:19:34) 08:08:41 INFO - javascript benchmark 08:08:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7402.9236730689545, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3189.059227527879, 3425.8972230833083, 3459.723222142228, 3464.584249890014, 3467.861285548578, 5779.07534794433, 5857.472827445529, 5864.384239654839, 5875.88248235035, 5892.0, 5849.356570777221, 5876.559258055652, 5957.106434034886, 5962.433568810956, 5989.341172471036, 5353.946460535403, 5364.873376590921, 5368.516833484986, 5427.104527752936, 5479.150731636602, 4846.812530929927, 5002.799888004493, 5403.648762830423, 5452.6455780374345, 5456.508914197721, 5280.2343660169445, 5304.283921670563, 5433.864153396157, 5453.64551304166, 5469.72651367432, 4330.761808100553, 5361.544268737162, 5377.569794416438, 5457.863553411157, 5499.807506737285, 5250.842474725764, 5363.329583802025, 5379.784808607651, 5400.648957817729, 5451.400345961941, 5745.597808153431, 5904.763809447617, 5913.379095195029, 6033.944059789563, 6042.365551617105, 6145.293291271516, 6198.946179149555, 6238.500919926395, 6252.593581417239, 6305.369463053704, 6308.842278943017, 6323.683815809237, 6349.174607301067, 6359.586626869285, 6383.904241436382, 5998.310194327621, 6025.216721826222, 6029.427204415573, 6044.909326360152, 6051.152838602599, 6213.440790328892, 6248.187735594343, 6341.0805433212845, 6355.110284560165, 6371.585846920028, 4758.286257061469, 6240.375962403723, 6247.312795592481, 6255.24937007562, 6264.310925798159, 6268.09112678659, 6294.464970477469, 6306.180196574416, 6310.211223597051, 6412.7114279857515, 5092.872678183001, 6158.938410615926, 6204.255489341218, 6252.531060170414, 6298.8425289367215, 5645.576581756302, 6068.150458935753, 6245.094461303085, 6292.779752708725, 6305.432511073934, 5033.546980771748, 5036.194208926554, 5038.269450929594, 5051.444341122474, 5070.391553013662, 4339.370791235317, 4442.155990361821, 4522.773861306921, 4534.614557762628, 4537.1833070047705, 5212.983468223736, 5978.730957106941, 5987.311459182162, 6093.4515893568905, 6122.672617327995, 6211.844703882349, 6262.2172228471445, 6270.435660790551, 6280.9685951569945, 6281.057841323838, 5865.589408741433, 5925.970370148121, 5948.256467941507, 5958.165856780054, 6029.487493563096, 5520.392756796749, 5521.779128834802, 5527.778888844401, 5530.225768392428, 5538.224648549206, 6479.0, 6482.67586620667, 6496.870062598721, 6503.707333169924, 6522.119513865568, 5123.231515272739, 6167.969160154171, 6169.56813023102, 6171.814845554641, 6253.749850006131, 6480.837979050561, 6496.155499784998, 6511.413972742476, 6518.771842985662, 6532.869342613026, 6271.310155882758, 6272.435480806749, 6279.591826531261, 6289.937100628935, 6298.118263443213, 5209.0, 6146.293176284785, 6193.969030154821, 6250.0, 6260.060990851409, 6116.761878222105, 6234.781782637586, 6239.812805615838, 6263.6241825490615, 6272.874542509033, 5184.0, 6178.1659475971965, 6211.440970312694, 6221.3156552778255, 6228.657423841732, 5438.945610544002, 5774.509166720875, 5908.793192238251, 6078.209832721895, 6124.785632502841, 4771.021940502119, 6112.321110680095, 6126.548209435115, 6144.8939190944275, 6170.167027451236, 6119.133664232452, 6128.655903792168, 6130.765048853685, 6136.637394603021, 6152.630842149485], "value": 5763.818031701437, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.40275627902355, 496.71687138331146, 521.2494008627576, 526.8208809004938, 527.4145698274914, 38810.44758209672, 40612.0, 40728.796356018254, 40779.9805004875, 40833.59166408335, 41983.79008104955, 42275.36586951191, 42538.0, 42802.0, 42872.57127428725, 9599.664011759573, 9629.374090684083, 9679.516024198798, 9779.46212958287, 9786.608535658565, 9628.422294662343, 9720.270979676518, 9756.853647195298, 9762.121409073183, 9763.121319081316, 9716.368436051669, 9758.512074396287, 9810.215182785396, 9827.017298270188, 9861.457619830906, 9708.563114659857, 9715.61137554497, 9736.513174341255, 9747.512624368754, 9801.754956126082, 9652.0, 9725.319227654067, 9725.513724313827, 9731.12419882214, 9733.415995040321, 39027.60972390268, 39751.8012409939, 39958.801235962965, 40055.0, 40158.397624035664, 3210.727088197506, 3267.4451497000064, 3337.0656216259486, 3360.9495857562156, 3452.4130897747445, 28484.00305989301, 29525.814039866287, 30876.53685194724, 30999.22501937447, 31090.68909310923, 3079.7690173237097, 3179.9205019874457, 3197.456432406473, 3201.3117179806454, 3222.146131275214, 513393.0, 513846.0, 517959.41020295036, 518056.0, 518593.0, 60201.0, 61376.07935880966, 61542.69228653828, 61803.6909815448, 61975.6901215491, 29507.0, 31618.0, 35374.11564710851, 35805.8209708955, 36160.457593136125, 16399.42602008924, 16869.987800731997, 16910.661786764194, 16955.321787128625, 17012.57468563271, 10848.78302433947, 12884.96920246378, 13038.087333886537, 13060.085793994329, 13078.0, 15551.377944882304, 16898.817082804333, 18674.066296685112, 19072.904635476734, 19175.808241917402, 7327.230640782747, 7839.568823714636, 7915.525068495908, 7971.202879712098, 7974.481658692166, 850.3792231670915, 941.1247539787926, 942.5475771629656, 969.6024629901707, 1029.763154474475, 24036.87981560081, 28828.135155945354, 30180.0, 30290.394192116033, 30943.8452807739, 981.0728861226215, 1021.22897212604, 1034.5654824973528, 1040.0483557544762, 1054.414799786126, 13470.39383227757, 14331.641708957151, 15773.684526309638, 15786.36854525829, 16051.197440127948, 667537.0, 676386.0, 683378.0, 686383.5680821564, 688520.1147988556, 56865.71567142138, 57161.71419142878, 57576.0, 57665.0, 57684.134737978966, 1194.8864857838664, 1370.0, 1382.3364784903101, 1397.3921344215298, 1399.6290982889338, 26074.86962565175, 26133.0, 29526.704732952396, 30286.394272114874, 30367.392652147275, 48279.27581086357, 48601.0, 48780.5121948776, 48823.535293939814, 48841.755791220814, 619172.0, 620110.8994454999, 622212.0, 626648.7335126773, 627751.0, 25653.4346565342, 26151.346216344744, 26537.0, 26665.466690666464, 26700.332491687863, 46270.0, 46734.76632616815, 47293.527064728914, 47328.52671473241, 47757.0, 37119.515219392, 38206.808965954995, 39192.804035979636, 41684.58315416807, 41744.47722708404, 37910.62089379071, 38680.8395748128, 38843.417348739225, 39055.804720976215, 39299.2140157201, 36508.63491365052, 37260.6273937268, 37546.8122659385, 37654.68208612686, 38008.619913801616, 29579.26051848721, 33533.496997545546, 34310.0, 34632.65367346294, 35148.82425587958, 25596.23211303664, 25668.229953101436, 25835.741642583333, 25855.577943212553, 26032.609510856975], "value": 19641.150367210976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6733598061988, 378.0529772918838, 385.4411103899346, 389.5208893061536, 402.1073217457244, 18651.90674046631, 19741.802581974192, 20337.49156271094, 21101.47246318841, 21257.468563285925, 9291.628334866597, 11847.22993005454, 18437.90781046096, 18803.93156752756, 20699.586008279824, 5304.151335786265, 5429.185622156669, 5519.9448005520035, 5527.39198688146, 5537.197106419567, 4615.399998000255, 5255.500727430888, 5291.259223708684, 5409.29679141711, 5414.512693857552, 5261.736913154346, 5270.9736451317685, 5272.446393128705, 5392.352917649868, 5417.160340147283, 4705.576498115169, 5369.62412631116, 5930.0, 6006.0, 6124.877502449971, 5708.828735137911, 5720.084786434192, 5879.559033072536, 5908.852278693067, 5912.793052243193, 10776.353418794897, 12152.0, 13421.530246441327, 13431.66420839477, 13515.729685406237, 2204.228520017981, 2496.5631014572377, 2662.6671666041743, 2967.3323502212047, 2968.688287729779, 9842.311038227326, 9859.556319965619, 10161.949190254076, 10242.487875606264, 10404.635837745642, 1818.3726614318039, 1860.5999710062267, 1884.387574038443, 1903.7525121734225, 1944.222311075567, 92118.0, 107396.0, 108567.0, 117010.0, 119505.0, 20796.0, 21361.67957480639, 21791.782082178976, 22096.790320967775, 22119.44701382446, 35381.82309088438, 35837.0, 36014.8199259002, 36028.819855900554, 36052.73815416448, 9380.8592871107, 10390.896091039143, 11109.388983605817, 11413.315201087962, 11517.905798949087, 7639.618019099134, 9362.25101991839, 9391.953040234892, 9539.52302384878, 9591.705119808876, 9604.079184163194, 9784.608615655294, 9944.552495137736, 9973.202143828476, 9975.453804660145, 3352.2122301259183, 3809.961900381016, 3829.851044686583, 3910.413437984268, 3917.2557214129224, 803.2008151888791, 899.9010108888017, 955.5556666150273, 990.0643891522442, 1020.5203554329453, 20384.184632614528, 21220.995050020043, 21794.237201697866, 21935.0, 21967.0, 930.1117432851611, 941.8916824565125, 948.151404492975, 971.2036130373167, 1011.1809434358194, 11119.444027798578, 11383.487743051583, 11558.884411155781, 11594.88405115938, 11611.941940290413, 620167.0, 623964.0, 628634.0, 632914.0, 636609.0, 75734.62132689302, 102078.0, 129628.3518582401, 131845.34077329552, 144295.0, 962.3504134709043, 968.864358989742, 999.0159692702682, 1011.726833754882, 1012.099231683802, 19189.424317270503, 19620.411387658394, 19816.504587385432, 19834.50413739668, 19856.0, 34667.41123736673, 36139.58320845639, 46302.0, 56845.43154568567, 56913.0, 67117.3288267111, 81139.78290325768, 83038.0, 83250.0, 84387.5780621093, 7626.771196864103, 7738.187490313436, 8012.839743204987, 8116.0, 8180.345572354078, 9450.858237126311, 12426.37868106573, 12483.438245278803, 12645.430955606837, 12762.361881905681, 10677.679669609925, 10875.836862447228, 11111.777764444505, 11359.54561817518, 11448.313101213955, 9590.616375345187, 10671.839922401015, 10740.516676749721, 10898.237123401603, 10929.016388525071, 10490.160787137163, 10942.890571094187, 10981.505832237728, 11083.390413527333, 11126.777464450828, 7900.419916016935, 7913.525188488709, 7997.080335761462, 8217.712380066669, 8288.171182881904, 10774.73063173427, 10779.760327562431, 10859.0, 10889.891101088888, 11052.226344155832], "value": 10104.17775226789, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.7792353223483, 1485.1534625263598, 1661.5264649574874, 1807.611363556835, 1817.0914542728635, 8184.304334131591, 8475.364347673934, 8686.91313086869, 9277.953610231947, 9294.209992150667, 7780.8832867507035, 8008.599570021504, 8021.799455013627, 9000.144986226298, 9013.774655633613, 2015.7379540659767, 2189.474526113729, 2369.57825304817, 2438.317271164068, 2454.4109413740753, 2005.3983804858558, 2433.85396876188, 2440.9511809763794, 2460.5570997220493, 2471.789897858684, 2447.596146635803, 2449.8530088194675, 2450.4853980664084, 2458.9262322130367, 2464.3223113643803, 2139.529303553216, 2428.3807629054477, 2433.452473193535, 2449.865257410842, 2452.411421258903, 2425.866577338246, 2441.6215486599604, 2444.5966415541416, 2446.1805295226122, 2451.0, 9031.683891063847, 9091.909080909238, 9159.038300978435, 9173.220276276525, 9186.0, 5347.973260133675, 5396.514313711785, 5417.943501017303, 5522.751476183541, 5524.806631767909, 3654.9086272843124, 3670.210904655512, 3695.2609478104487, 3712.127650002274, 3724.1434470072036, 1079.6653037558383, 1093.7648405592756, 1099.5601759296264, 1101.7851518953807, 1102.5755084292525, 12077.577284795078, 12147.210431321935, 12183.573574924834, 12199.268043917393, 12238.632841014873, 4836.056968891033, 4854.150523658345, 4885.5847252983185, 4960.958198778225, 5021.924671129936, 10124.69625911224, 10238.33450825694, 10288.845667314847, 10301.433421161908, 10308.587656493657, 4541.500434952152, 5385.7307134643115, 5491.890162196733, 5493.505584497414, 5499.4225606310765, 4386.122775444924, 4517.909641807146, 4838.903221935612, 4959.950400495949, 4985.326980857611, 3556.8440256916606, 4005.7796821174534, 4027.194561087794, 4123.793810309473, 4134.214499245134, 1136.86926003509, 1312.2126723965544, 1324.6357251755844, 1326.9336533173303, 1336.525533435636, 870.2602787630464, 871.4205053639386, 911.3438324406417, 914.5792935249726, 933.0203286549232, 5957.731902064417, 6025.276966763929, 6066.332703402622, 6098.786542470993, 6150.384961503813, 952.7570469530364, 960.8606752021058, 964.7057647417465, 976.2434113562047, 986.1174249047206, 4008.238434697398, 4008.8596899108393, 4078.490188726409, 4091.6931230157857, 4109.219248342805, 9324.533773311307, 9923.553440095213, 10785.56857725698, 10792.812790593029, 11178.776424471465, 10862.293950893167, 10920.563177472972, 11028.0, 11099.5560177592, 11127.109831213484, 7999.680012799539, 8212.794680132925, 8417.032041315204, 8431.494110353398, 8481.957590212132, 5274.446183150714, 6007.738374941311, 6083.6653984029535, 6085.878282434238, 6259.123722678738, 10060.597576097167, 10247.282690211614, 10292.279540432099, 10311.432871192157, 10312.02035806597, 9252.565852292906, 10019.699409017741, 10274.743131421475, 10502.579896804042, 10572.259941803999, 7099.503034787515, 7338.926610733824, 7546.6981320748755, 7563.697452101855, 7773.844523109619, 8539.060703322753, 8722.694705685271, 8742.737717868475, 8753.12468753145, 8775.868361974703, 7487.8876816846705, 7557.168711441627, 7635.427342949412, 7638.961805190938, 7722.92277077222, 6655.168103987002, 6678.379619462198, 7225.096862892138, 7547.73582924595, 7670.7315243966195, 6383.0, 6770.78125937336, 7131.322524360177, 7204.56772593646, 7212.495125341386, 4451.6661250407, 5031.949680503149, 5060.822871199491, 5104.897902042013, 5163.483651634957, 4490.0, 5131.281620573197, 5189.896202076013, 5259.605529585373, 5298.523132918056], "value": 4658.07083969874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.801341047856, 300.7083129364516, 311.1800405930373, 312.4126641913203, 317.2038184157765, 5341.545968592674, 5515.944840551593, 5531.502164805167, 5596.58025648076, 5707.5148612368, 5231.319928409311, 5350.224217488462, 5417.295751552293, 5447.727613619313, 5454.372747134071, 3790.2419516096893, 4182.6862985276075, 4185.414042034103, 4189.476315460567, 4213.410122582841, 3563.216092459668, 3736.4395340698975, 3749.1564398010364, 3863.536375634928, 4199.223143718422, 3921.9215615687667, 3950.2889479893606, 4050.453188819516, 4164.354525048622, 4200.3069493533685, 3421.469672200813, 3460.3425349183826, 4171.520275168364, 4176.874693759192, 4199.622034016923, 3524.1542029912894, 3611.4221724524214, 3629.5825980012373, 3635.1820840310984, 3639.089478024032, 4364.759938203398, 4596.49438561758, 5113.897722045575, 5385.0, 5427.6200665953, 4561.217657229087, 4701.64737644678, 4827.179379505493, 4838.225883858566, 4846.515348465161, 5751.756814842215, 5821.767129314822, 5878.706064696791, 5894.675792831393, 5896.852578685524, 3569.1434055826676, 3665.6173487233245, 3692.6861216796606, 3932.5477570079233, 3958.881233562969, 5652.830415087554, 5782.479576838105, 6057.151998720183, 6144.784932527385, 6278.058291256302, 4017.6183262590007, 4020.2160578686876, 4025.3358195897936, 4045.6763458923215, 4058.492688413948, 3564.429691249388, 3775.528058992626, 3958.7822669752863, 4022.597740225954, 4039.343869013749, 3953.2686453006286, 4718.740469274223, 4730.314104454835, 4744.881377965578, 4753.453352864396, 5179.456157103526, 5819.854503637358, 5864.970675146597, 5920.733566989496, 5943.494802941798, 1095.6603452929617, 1123.662901129658, 1280.6553119224777, 1369.760291948925, 1379.3861731529373, 727.7089164334203, 741.269849198539, 818.3289702443939, 834.3033566971646, 839.8320335932716, 4435.822567097344, 4633.791479383436, 4678.3216433616935, 4689.859304220879, 4715.877854965211, 3937.9803100984313, 4055.4322394864744, 4152.5432202457705, 5039.3952725672425, 5076.974615126901, 4008.959910400917, 4117.8970525737095, 4667.016517979845, 4679.766011699401, 4700.130475861976, 2242.856143366862, 2326.2904814031544, 2371.5612611666897, 2503.14641308908, 2624.7375262473984, 4556.810232837028, 4744.810207591727, 5134.5341894222, 5257.764425360037, 5263.0, 4284.764337961442, 4770.833020844254, 4787.736674482867, 5224.294720212799, 5237.852480482984, 4509.053098849213, 4775.450823155312, 4863.90272194547, 6465.903011454832, 6474.482041436768, 5251.684898906078, 5898.557608179318, 6080.148779171008, 6178.474829639351, 6209.720562574786, 5718.599698021098, 5823.1847541343395, 5889.558283128868, 5889.617174883619, 6105.755769769159, 5513.696746678971, 5523.834284971457, 5789.855253618524, 6326.367363263636, 6363.331850155852, 3580.928381432409, 3984.8007599620482, 4052.209819085368, 4069.8372065117064, 4089.9795501022304, 4977.411745892044, 5417.295751552273, 5737.110747834093, 5991.2510936132985, 6182.629042257479, 5684.436779885565, 5765.3946335634155, 5984.820455386345, 5988.700564971821, 6014.939850601613, 4562.817487300471, 5677.672154416835, 5956.731947062306, 5992.711567013113, 6020.90968635462, 4358.86923392286, 5302.39022512416, 5411.161270003156, 5617.466340697627, 5794.420557944172, 5620.4098569649595, 5652.321721393295, 5825.533957283492, 5838.416158384298, 5904.468597826216, 5240.633155679066, 5804.01331773591, 5828.475437210672, 5831.825045248649, 5889.52883769306], "value": 4059.1519673751436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.1544527063807, 698.0889938630087, 702.4977141343938, 708.4686485136148, 749.8762704153814, 15192.088474691527, 15392.461263855766, 15571.06573605583, 15698.529044128665, 15751.976121552105, 11912.52349906005, 13991.090579112377, 14110.082844615119, 14166.575002749909, 14279.143251404897, 675.8409328002475, 698.9685464154126, 822.7161629237903, 822.7984143884756, 825.0264687668549, 611.4588589098657, 673.8079647300495, 799.3684988858795, 820.3888103363003, 834.1825011488745, 873.2402809555696, 887.6405055952317, 891.6076926152505, 892.8616064510011, 893.1782759860944, 854.2055888024136, 873.8470767615673, 886.5567216391804, 887.1572006593698, 887.8135591525787, 646.4569761400446, 654.8493846415304, 656.1601150527333, 658.6048370977423, 660.4452260101538, 14712.852871471256, 14716.264186790617, 14727.263636818223, 14733.631659208499, 14743.894207934341, 14492.20292883891, 14521.927390363086, 14550.854491455057, 14907.92546037263, 14959.252037398195, 11535.307881527135, 11997.920187183196, 12030.69923251917, 12047.879521204852, 12379.75240495194, 3794.0, 3799.5820459749407, 3814.885553433374, 3883.262180185756, 3902.0635047588657, 119085.0, 121279.0, 122339.99999999911, 122357.38821305925, 122630.0, 10783.245172837826, 10931.726706832393, 11007.559697612005, 11264.54941802335, 11340.94329528347, 22647.0, 23445.531089378117, 23470.17854375123, 23472.413189670395, 23528.882355588114, 8040.718574849852, 8149.0, 8173.918260817434, 8306.252437280673, 8454.704085356983, 4459.375687403766, 4490.281554951257, 4527.139843429738, 4584.15193189261, 4607.585317321457, 3557.6442355764734, 3630.945535816965, 3727.962720372816, 3801.7718936863876, 3988.581198974124, 712.8217945513621, 730.5251586468731, 733.6331834082958, 741.0736579275905, 744.1776836595592, 622.707327556057, 645.3997782062727, 648.3548868875499, 658.5949640970769, 663.1014974709296, 9212.493312867857, 9602.711918642452, 9651.841095425714, 9746.853797193047, 9794.902050979541, 569.6838254768643, 605.1739375752067, 650.1320736816309, 652.1847690387016, 676.8680107379014, 4559.563737422701, 4737.8341758038305, 4756.286557016406, 4788.521147885183, 4800.39162404096, 119318.4034079824, 135509.0, 136694.48180350175, 139672.20655586832, 144609.0, 66288.33711662918, 78776.0, 92122.53938730263, 97356.0, 106000.0, 84559.57720211483, 108025.0, 111037.0, 111072.44463777791, 114337.42831285957, 7013.824654383681, 8980.281577473655, 9015.188633023059, 9125.133112354315, 9178.403403778733, 52355.73822130865, 55446.44553554413, 60891.21704902517, 61446.69276653767, 62201.68899155475, 86747.56626216829, 86794.0, 91192.54403727938, 93474.13051739063, 95054.0, 11360.261582997078, 11737.237079589799, 11752.94123529411, 11884.702882428008, 11928.58249961282, 12400.937995309965, 13072.542461013818, 13428.93285533566, 13441.663958400726, 13465.932670336586, 12265.202761820454, 12496.87503124957, 12902.225866448043, 12939.611811645666, 12944.288064156563, 12512.37438128108, 12530.812037819622, 12575.0, 13011.804822927854, 13036.47854085826, 12275.079369047537, 12509.186902851285, 12623.621291361274, 12642.30467324306, 12658.936705316415, 10119.342242754197, 10284.074433301039, 10358.689239322832, 10777.89222107769, 11078.778424431628, 10436.895631043591, 10664.0, 10665.200109991627, 10665.36007839532, 10690.25168238247], "value": 7609.46868118185, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 121.0, 166.0, 116.0, 116.0, 117.0, 142.0, 174.0, 118.0, 118.0], "value": 129.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 113.0, 145.0, 146.0, 112.0, 118.0, 114.0, 137.0, 126.0, 144.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 199.0, 195.0, 204.0, 197.0, 195.0, 196.0, 248.0, 279.0, 194.0], "value": 211.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 60.0, 50.0, 84.0, 84.0, 88.0, 50.0, 71.0, 102.0, 86.0], "value": 76.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 87.0, 65.0, 73.0, 80.0, 125.0, 100.0, 70.0, 87.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 133.0, 89.0, 90.0, 89.0, 87.0, 93.0, 85.0, 87.0, 85.0], "value": 93.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 154.0, 95.0, 135.0, 103.0, 95.0, 97.0, 98.0, 131.0, 94.0], "value": 110.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 96.0, 139.0, 150.0, 149.0, 90.0, 116.0, 89.0, 152.0, 149.0], "value": 121.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 59.0, 60.0, 59.0, 58.0, 59.0, 61.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 66.0, 72.0, 81.0, 67.0, 93.0, 103.0, 102.0, 102.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 86.0, 85.0, 81.0, 88.0, 84.0, 84.0, 84.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 164.0, 154.0, 153.0, 137.0, 136.0, 141.0, 140.0, 197.0, 149.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 166.0, 163.0, 166.0, 166.0, 191.0, 230.0, 152.0, 239.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 81.0, 91.0, 92.0, 85.0, 88.0, 76.0, 68.0], "value": 78.8, "unit": "score"}]}]} 08:08:41 INFO - Return code: 0 08:08:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:08:41 ERROR - # TBPL SUCCESS # 08:08:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:08:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:08:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:08:41 INFO - 2016-09-24 08:08:41.512 screenresolution[1964:69027] starting screenresolution argv=screenresolution get 08:08:41 INFO - 2016-09-24 08:08:41.515 screenresolution[1964:69027] Display 0: 1600x1200x32@60 08:08:41 INFO - 2016-09-24 08:08:41.521 screenresolution[1965:69030] starting screenresolution argv=screenresolution list 08:08:41 INFO - Available Modes on Display 0 08:08:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:08:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:08:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:08:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:08:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:08:41 INFO - Intel Iris: 08:08:41 INFO - Chipset Model: Intel Iris 08:08:41 INFO - Type: GPU 08:08:41 INFO - Bus: Built-In 08:08:41 INFO - VRAM (Dynamic, Max): 1536 MB 08:08:41 INFO - Vendor: Intel (0x8086) 08:08:41 INFO - Device ID: 0x0a2e 08:08:41 INFO - Revision ID: 0x0009 08:08:41 INFO - Displays: 08:08:41 INFO - Display: 08:08:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:08:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:08:41 INFO - Display Serial Number: 1600x1200 60 08:08:41 INFO - Main Display: Yes 08:08:41 INFO - Mirror: Off 08:08:41 INFO - Online: Yes 08:08:41 INFO - Rotation: Supported 08:08:41 INFO - Return code: 0 08:08:41 INFO - Running post-action listener: _resource_record_post_action 08:08:41 INFO - [mozharness: 2016-09-24 15:08:41.761438Z] Finished run-tests step (success) 08:08:41 INFO - Running post-run listener: _resource_record_post_run 08:08:41 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 942080; Write bytes: 665781760; Read time: 5; Write time: 1918 08:08:41 INFO - TinderboxPrint: CPU usage
54.2% 08:08:41 INFO - TinderboxPrint: I/O read bytes / time
942,080 / 5 08:08:41 INFO - TinderboxPrint: I/O write bytes / time
665,781,760 / 1,918 08:08:41 INFO - TinderboxPrint: CPU idle
2,209.6 (45.7%) 08:08:41 INFO - TinderboxPrint: CPU system
977.8 (20.2%) 08:08:41 INFO - TinderboxPrint: CPU user
1,642.3 (34.0%) 08:08:41 INFO - TinderboxPrint: Swap in / out
363,008,000 / 0 08:08:41 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355660288; Write bytes: 356374016; Read time: 27163; Write time: 716 08:08:41 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 106496; Write bytes: 298389504; Read time: 2; Write time: 1164 08:08:42 INFO - Running post-run listener: _upload_blobber_files 08:08:42 INFO - Blob upload gear active. 08:08:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:08:42 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 08:08:42 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'] 08:08:42 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 08:08:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:43 INFO - (blobuploader) - INFO - Done attempting. 08:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:44 INFO - (blobuploader) - INFO - Done attempting. 08:08:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:08:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:47 INFO - (blobuploader) - INFO - Done attempting. 08:08:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:08:47 INFO - Return code: 0 08:08:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:08:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:08:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/758b64f8c54cbd232e1c631adc5514d812d81a7cc069a744ce13f00b5042e0f78c89c5bbe3c235915d6994434ccca94cd48065203f3d2c83adf2e5fb48692cfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e56638e9dd49d0f602f58c02b84c55117c47c967ab19fea8c4d747d7eb51c2db0826cd7ee91f5c977402553c34688fc13dceca395403e0001a1dbcaa44ea81b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085265e4ccf7a7e7e1f388300d61bed97fefbe77edb77bdef8f41dfed101404e46be936511f95a4627a18fedeb25fc177eda70a310bf1452c396a12084beb783"} 08:08:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:08:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:08:47 INFO - Contents: 08:08:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/758b64f8c54cbd232e1c631adc5514d812d81a7cc069a744ce13f00b5042e0f78c89c5bbe3c235915d6994434ccca94cd48065203f3d2c83adf2e5fb48692cfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e56638e9dd49d0f602f58c02b84c55117c47c967ab19fea8c4d747d7eb51c2db0826cd7ee91f5c977402553c34688fc13dceca395403e0001a1dbcaa44ea81b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085265e4ccf7a7e7e1f388300d61bed97fefbe77edb77bdef8f41dfed101404e46be936511f95a4627a18fedeb25fc177eda70a310bf1452c396a12084beb783"} 08:08:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:08:47 INFO - Copying logs to upload dir... 08:08:47 INFO - mkdir: /builds/slave/test/build/upload/logs 08:08:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.311409 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-24 08:08:47.842281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-24 08:08:47.845415) ========= 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.L89g8VT5Cu/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.sIec2LnjIK/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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/758b64f8c54cbd232e1c631adc5514d812d81a7cc069a744ce13f00b5042e0f78c89c5bbe3c235915d6994434ccca94cd48065203f3d2c83adf2e5fb48692cfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e56638e9dd49d0f602f58c02b84c55117c47c967ab19fea8c4d747d7eb51c2db0826cd7ee91f5c977402553c34688fc13dceca395403e0001a1dbcaa44ea81b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085265e4ccf7a7e7e1f388300d61bed97fefbe77edb77bdef8f41dfed101404e46be936511f95a4627a18fedeb25fc177eda70a310bf1452c396a12084beb783"} build_url:https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/K7SRazt4QK6xKO_MyEhmeg/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/758b64f8c54cbd232e1c631adc5514d812d81a7cc069a744ce13f00b5042e0f78c89c5bbe3c235915d6994434ccca94cd48065203f3d2c83adf2e5fb48692cfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e56638e9dd49d0f602f58c02b84c55117c47c967ab19fea8c4d747d7eb51c2db0826cd7ee91f5c977402553c34688fc13dceca395403e0001a1dbcaa44ea81b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085265e4ccf7a7e7e1f388300d61bed97fefbe77edb77bdef8f41dfed101404e46be936511f95a4627a18fedeb25fc177eda70a310bf1452c396a12084beb783"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-24 08:08:47.883347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 08:08:47.884051) ========= 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.L89g8VT5Cu/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.sIec2LnjIK/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.004600 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 08:08:47.936626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-24 08:08:47.937382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-24 08:08:47.938128) ========= ========= Total master_lag: 0.20 =========