builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1478619960.6 results: success (0) buildid: 20161108062935 builduid: e46360cda33a4597ac8e8f6b717065c5 revision: 71a57bc90cf23e334c6c680c929f5b0c5c836ada ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:00.599173) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:00.599648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:00.599931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:00.622684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:00.623043) ========= 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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-08 07:46:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.2M=0s 2016-11-08 07:46:00 (24.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.342807 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:00.987152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:00.987470) ========= 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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.025878 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:01.037514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 07:46:01.038033) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 71a57bc90cf23e334c6c680c929f5b0c5c836ada --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 71a57bc90cf23e334c6c680c929f5b0c5c836ada --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BJzjbWCdNr/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.km0nyJB3GZ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-08 07:46:01,112 truncating revision to first 12 chars 2016-11-08 07:46:01,112 Setting DEBUG logging. 2016-11-08 07:46:01,112 attempt 1/10 2016-11-08 07:46:01,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/71a57bc90cf2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 07:46:02,762 unpacking tar archive at: mozilla-aurora-71a57bc90cf2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.913103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 07:46:02.973841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:02.974200) ========= script_repo_revision: 71a57bc90cf23e334c6c680c929f5b0c5c836ada ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:02.974661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:02.974954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 07:46:02.993204) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-08 07:46:02.993487) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:03 INFO - MultiFileLogger online at 20161108 07:46:03 in /builds/slave/test 07:46:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:46:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:03 INFO - {'append_to_log': False, 07:46:03 INFO - 'base_work_dir': '/builds/slave/test', 07:46:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:46:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:03 INFO - 'branch': 'Mozilla-Aurora', 07:46:03 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:03 INFO - 'config_files': ('talos/mac_config.py',), 07:46:03 INFO - 'default_actions': ('clobber', 07:46:03 INFO - 'read-buildbot-config', 07:46:03 INFO - 'download-and-extract', 07:46:03 INFO - 'populate-webroot', 07:46:03 INFO - 'create-virtualenv', 07:46:03 INFO - 'install', 07:46:03 INFO - 'run-tests'), 07:46:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:03 INFO - 'download_minidump_stackwalk': True, 07:46:03 INFO - 'download_symbols': 'ondemand', 07:46:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:03 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:03 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:03 INFO - 'installer_path': 'installer.exe', 07:46:03 INFO - 'log_level': 'info', 07:46:03 INFO - 'log_name': 'talos', 07:46:03 INFO - 'log_to_console': True, 07:46:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:46:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:46:03 INFO - 'opt_config_files': (), 07:46:03 INFO - 'pip_index': False, 07:46:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:03 INFO - 'cmd': ('bash', 07:46:03 INFO - '-c', 07:46:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:03 INFO - 'enabled': True, 07:46:03 INFO - 'halt_on_failure': False, 07:46:03 INFO - 'name': 'check_screen_resolution'},), 07:46:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:03 INFO - 'cmd': ('bash', 07:46:03 INFO - '-c', 07:46:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:03 INFO - 'enabled': True, 07:46:03 INFO - 'halt_on_failure': False, 07:46:03 INFO - 'name': 'check_screen_resolution'},), 07:46:03 INFO - 'run_cmd_checks_enabled': True, 07:46:03 INFO - 'sps_profile': False, 07:46:03 INFO - 'sps_profile_interval': 0, 07:46:03 INFO - 'suite': 'dromaeojs', 07:46:03 INFO - 'system_bits': '32', 07:46:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:03 INFO - 'title': 't-yosemite-r7-0163', 07:46:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:03 INFO - 'use_talos_json': True, 07:46:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:03 INFO - 'work_dir': 'build'} 07:46:03 INFO - [mozharness: 2016-11-08 15:46:03.189020Z] Running clobber step. 07:46:03 INFO - Running pre-action listener: _resource_record_pre_action 07:46:03 INFO - Running main action method: clobber 07:46:03 INFO - rmtree: /builds/slave/test/build 07:46:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:05 INFO - Running post-action listener: _resource_record_post_action 07:46:05 INFO - [mozharness: 2016-11-08 15:46:05.572620Z] Finished clobber step (success) 07:46:05 INFO - [mozharness: 2016-11-08 15:46:05.572747Z] Running read-buildbot-config step. 07:46:05 INFO - Running pre-action listener: _resource_record_pre_action 07:46:05 INFO - Running main action method: read_buildbot_config 07:46:05 INFO - Using buildbot properties: 07:46:05 INFO - { 07:46:05 INFO - "project": "", 07:46:05 INFO - "product": "firefox", 07:46:05 INFO - "script_repo_revision": "production", 07:46:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:46:05 INFO - "repository": "", 07:46:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:46:05 INFO - "buildid": "20161108062935", 07:46:05 INFO - "pgo_build": "False", 07:46:05 INFO - "basedir": "/builds/slave/test", 07:46:05 INFO - "buildnumber": 25, 07:46:05 INFO - "slavename": "t-yosemite-r7-0163", 07:46:05 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:46:05 INFO - "platform": "yosemite_r7", 07:46:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:46:05 INFO - "branch": "mozilla-aurora", 07:46:05 INFO - "repo_path": "releases/mozilla-aurora", 07:46:05 INFO - "revision": "71a57bc90cf23e334c6c680c929f5b0c5c836ada", 07:46:05 INFO - "stage_platform": "macosx64", 07:46:05 INFO - "builduid": "e46360cda33a4597ac8e8f6b717065c5", 07:46:05 INFO - "slavebuilddir": "test" 07:46:05 INFO - } 07:46:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:46:05 INFO - Running post-action listener: _resource_record_post_action 07:46:05 INFO - [mozharness: 2016-11-08 15:46:05.576038Z] Finished read-buildbot-config step (success) 07:46:05 INFO - [mozharness: 2016-11-08 15:46:05.576157Z] Running download-and-extract step. 07:46:05 INFO - Running pre-action listener: _resource_record_pre_action 07:46:05 INFO - Running main action method: download_and_extract 07:46:05 INFO - mkdir: /builds/slave/test/build/tests 07:46: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:46:05 INFO - trying https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:46:05 INFO - Downloading https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/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:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/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:46:06 INFO - Downloaded 1199 bytes. 07:46:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:46:06 INFO - Using the following test package requirements: 07:46:06 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:46:06 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:46:06 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:46:06 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:46:06 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:46:06 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:46:06 INFO - u'jsshell-mac.zip'], 07:46:06 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:46:06 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:46:06 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:46:06 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:46:06 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:46:06 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:46:06 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:46:06 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:46:06 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:46:06 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:46:06 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:46:06 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:46:06 INFO - Fetch https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:46:07 INFO - Expected file size: 16423323 07:46:14 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:46:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:46:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:46:14 INFO - Fetch https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:46:14 INFO - Expected file size: 16423323 07:46:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:46:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:46:21 INFO - Fetch https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:46:22 INFO - Expected file size: 14414089 07:46:23 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:46:23 INFO - trying https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:46:23 INFO - Downloading https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:46:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/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:46:26 INFO - Downloaded 115460605 bytes. 07:46:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:46:26 INFO - mkdir: /builds/slave/test/properties 07:46:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:26 INFO - Contents: 07:46:26 INFO - build_url:https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:46:26 INFO - Running post-action listener: _resource_record_post_action 07:46:26 INFO - Running post-action listener: set_extra_try_arguments 07:46:26 INFO - [mozharness: 2016-11-08 15:46:26.978511Z] Finished download-and-extract step (success) 07:46:26 INFO - [mozharness: 2016-11-08 15:46:26.978631Z] Running populate-webroot step. 07:46:26 INFO - Running pre-action listener: _resource_record_pre_action 07:46:26 INFO - Running main action method: populate_webroot 07:46:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:26 INFO - '--tppagecycles', 07:46:26 INFO - '7'], 07:46:26 INFO - 'tests': ['tsvgm']}}, 07:46:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:26 INFO - 'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:26 INFO - 'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['damp', 'tps']}, 07:46:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:26 INFO - 'tests': ['damp', 'tps']}, 07:46:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['dromaeo_dom']}, 07:46:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['basic_compositor_video']}, 07:46:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:46:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['a11yr', 07:46:26 INFO - 'ts_paint', 07:46:26 INFO - 'tpaint', 07:46:26 INFO - 'sessionrestore', 07:46:26 INFO - 'sessionrestore_no_auto_restore', 07:46:26 INFO - 'tabpaint']}, 07:46:26 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:26 INFO - 'ts_paint', 07:46:26 INFO - 'tpaint', 07:46:26 INFO - 'sessionrestore', 07:46:26 INFO - 'sessionrestore_no_auto_restore', 07:46:26 INFO - 'tabpaint']}, 07:46:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:26 INFO - 'ts_paint', 07:46:26 INFO - 'tpaint', 07:46:26 INFO - 'sessionrestore', 07:46:26 INFO - 'sessionrestore_no_auto_restore', 07:46:26 INFO - 'tabpaint']}, 07:46:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:26 INFO - 'ts_paint', 07:46:26 INFO - 'tpaint', 07:46:26 INFO - 'sessionrestore', 07:46:26 INFO - 'sessionrestore_no_auto_restore', 07:46:26 INFO - 'tabpaint']}, 07:46:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['a11yr', 07:46:26 INFO - 'ts_paint', 07:46:26 INFO - 'tpaint', 07:46:26 INFO - 'sessionrestore', 07:46:26 INFO - 'sessionrestore_no_auto_restore', 07:46:26 INFO - 'tabpaint']}, 07:46:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['a11yr', 07:46:26 INFO - 'ts_paint', 07:46:26 INFO - 'tpaint', 07:46:26 INFO - 'sessionrestore', 07:46:26 INFO - 'sessionrestore_no_auto_restore', 07:46:26 INFO - 'tabpaint']}, 07:46:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['tsvgx', 07:46:26 INFO - 'tsvgr_opacity', 07:46:26 INFO - 'tart', 07:46:26 INFO - 'tscrollx', 07:46:26 INFO - 'cart']}, 07:46:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:26 INFO - 'tsvgr_opacity', 07:46:26 INFO - 'tart', 07:46:26 INFO - 'tscrollx', 07:46:26 INFO - 'cart']}, 07:46:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:26 INFO - 'talos_options': ['--disable-e10s'], 07:46:26 INFO - 'tests': ['tp5o']}, 07:46:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:26 INFO - 'tests': ['tp5o']}, 07:46:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:26 INFO - 'talos_options': ['--disable-e10s', 07:46:26 INFO - '--xperf_path', 07:46:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:26 INFO - 'tests': ['tp5n']}, 07:46:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:26 INFO - 'talos_options': ['--xperf_path', 07:46:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:26 INFO - 'tests': ['tp5n']}}, 07:46:26 INFO - 'talos.zip': {'path': '', 07:46:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:26 INFO - Running post-action listener: _resource_record_post_action 07:46:26 INFO - [mozharness: 2016-11-08 15:46:26.996968Z] Finished populate-webroot step (success) 07:46:26 INFO - [mozharness: 2016-11-08 15:46:26.997066Z] Running create-virtualenv step. 07:46:26 INFO - Running pre-action listener: _resource_record_pre_action 07:46:26 INFO - Running main action method: create_virtualenv 07:46:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:26 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:46:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:27 INFO - Using real prefix '/tools/python27' 07:46:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:30 INFO - Installing pip.................done. 07:46:30 INFO - Return code: 0 07:46:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:46:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:30 INFO - 'HOME': '/Users/cltbld', 07:46:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:30 INFO - 'LOGNAME': 'cltbld', 07:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:30 INFO - 'MOZ_NO_REMOTE': '1', 07:46:30 INFO - 'NO_EM_RESTART': '1', 07:46:30 INFO - 'PAGER': '/bin/cat', 07:46:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:30 INFO - 'PWD': '/builds/slave/test', 07:46:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:30 INFO - 'SHELL': '/bin/bash', 07:46:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:30 INFO - 'USER': 'cltbld', 07:46:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:30 INFO - 'XPC_FLAGS': '0x0', 07:46:30 INFO - 'XPC_SERVICE_NAME': '0', 07:46:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:30 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:46:30 INFO - Cleaning up... 07:46:30 INFO - Return code: 0 07:46:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:46:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:30 INFO - 'HOME': '/Users/cltbld', 07:46:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:30 INFO - 'LOGNAME': 'cltbld', 07:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:30 INFO - 'MOZ_NO_REMOTE': '1', 07:46:30 INFO - 'NO_EM_RESTART': '1', 07:46:30 INFO - 'PAGER': '/bin/cat', 07:46:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:30 INFO - 'PWD': '/builds/slave/test', 07:46:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:30 INFO - 'SHELL': '/bin/bash', 07:46:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:30 INFO - 'USER': 'cltbld', 07:46:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:30 INFO - 'XPC_FLAGS': '0x0', 07:46:30 INFO - 'XPC_SERVICE_NAME': '0', 07:46:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:31 INFO - Downloading/unpacking psutil>=3.1.1 07:46:31 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:46:31 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:46:31 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:46:31 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:46:31 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:46:31 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:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:34 INFO - Installing collected packages: psutil 07:46:34 INFO - Running setup.py install for psutil 07:46:34 INFO - building 'psutil._psutil_osx' extension 07:46:34 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:46:35 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:46:35 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:46:35 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:46:35 INFO - building 'psutil._psutil_posix' extension 07:46:35 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:46:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:46:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:46:35 INFO - ^ 07:46:35 INFO - 1 warning generated. 07:46:35 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:46:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:35 INFO - Successfully installed psutil 07:46:35 INFO - Cleaning up... 07:46:35 INFO - Return code: 0 07:46:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:35 INFO - 'HOME': '/Users/cltbld', 07:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:35 INFO - 'LOGNAME': 'cltbld', 07:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:35 INFO - 'MOZ_NO_REMOTE': '1', 07:46:35 INFO - 'NO_EM_RESTART': '1', 07:46:35 INFO - 'PAGER': '/bin/cat', 07:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:35 INFO - 'PWD': '/builds/slave/test', 07:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:35 INFO - 'SHELL': '/bin/bash', 07:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:35 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:35 INFO - 'USER': 'cltbld', 07:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:35 INFO - 'XPC_FLAGS': '0x0', 07:46:35 INFO - 'XPC_SERVICE_NAME': '0', 07:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:38 INFO - Installing collected packages: mozsystemmonitor 07:46:38 INFO - Running setup.py install for mozsystemmonitor 07:46:38 INFO - Successfully installed mozsystemmonitor 07:46:38 INFO - Cleaning up... 07:46:38 INFO - Return code: 0 07:46:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:38 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:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:38 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:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:38 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 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:38 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:46:38 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:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:38 INFO - 'HOME': '/Users/cltbld', 07:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:38 INFO - 'LOGNAME': 'cltbld', 07:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:38 INFO - 'MOZ_NO_REMOTE': '1', 07:46:38 INFO - 'NO_EM_RESTART': '1', 07:46:38 INFO - 'PAGER': '/bin/cat', 07:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:38 INFO - 'PWD': '/builds/slave/test', 07:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:38 INFO - 'SHELL': '/bin/bash', 07:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:38 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:38 INFO - 'USER': 'cltbld', 07:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:38 INFO - 'XPC_FLAGS': '0x0', 07:46:38 INFO - 'XPC_SERVICE_NAME': '0', 07:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:39 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:39 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:46:39 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:46:39 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:46:39 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:46:39 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:46:39 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:46:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:41 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:42 INFO - warning: no files found matching '*.txt' 07:46:42 INFO - no previously-included directories found matching 'build' 07:46:42 INFO - no previously-included directories found matching 'dist' 07:46:42 INFO - no previously-included directories found matching '.git*' 07:46:42 INFO - Installing collected packages: jsonschema, functools32 07:46:42 INFO - Running setup.py install for functools32 07:46:42 INFO - warning: no files found matching '*.txt' 07:46:42 INFO - no previously-included directories found matching 'build' 07:46:42 INFO - no previously-included directories found matching 'dist' 07:46:42 INFO - no previously-included directories found matching '.git*' 07:46:42 INFO - Successfully installed jsonschema functools32 07:46:42 INFO - Cleaning up... 07:46:42 INFO - Return code: 0 07:46:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:42 INFO - 'HOME': '/Users/cltbld', 07:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:42 INFO - 'LOGNAME': 'cltbld', 07:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:42 INFO - 'MOZ_NO_REMOTE': '1', 07:46:42 INFO - 'NO_EM_RESTART': '1', 07:46:42 INFO - 'PAGER': '/bin/cat', 07:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:42 INFO - 'PWD': '/builds/slave/test', 07:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:42 INFO - 'SHELL': '/bin/bash', 07:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:42 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:42 INFO - 'USER': 'cltbld', 07:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:42 INFO - 'XPC_FLAGS': '0x0', 07:46:42 INFO - 'XPC_SERVICE_NAME': '0', 07:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:46:42 INFO - Cleaning up... 07:46:42 INFO - Return code: 0 07:46:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:42 INFO - 'HOME': '/Users/cltbld', 07:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:42 INFO - 'LOGNAME': 'cltbld', 07:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:42 INFO - 'MOZ_NO_REMOTE': '1', 07:46:42 INFO - 'NO_EM_RESTART': '1', 07:46:42 INFO - 'PAGER': '/bin/cat', 07:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:42 INFO - 'PWD': '/builds/slave/test', 07:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:42 INFO - 'SHELL': '/bin/bash', 07:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:42 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:42 INFO - 'USER': 'cltbld', 07:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:42 INFO - 'XPC_FLAGS': '0x0', 07:46:42 INFO - 'XPC_SERVICE_NAME': '0', 07:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:46 INFO - Downloading docopt-0.6.1.tar.gz 07:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:46 INFO - Running setup.py install for blobuploader 07:46:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:46 INFO - Running setup.py install for requests 07:46:47 INFO - Running setup.py install for docopt 07:46:47 INFO - Successfully installed blobuploader requests docopt 07:46:47 INFO - Cleaning up... 07:46:47 INFO - Return code: 0 07:46:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 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 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:47 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:46:47 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:46:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:47 INFO - 'HOME': '/Users/cltbld', 07:46:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:47 INFO - 'LOGNAME': 'cltbld', 07:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:47 INFO - 'MOZ_NO_REMOTE': '1', 07:46:47 INFO - 'NO_EM_RESTART': '1', 07:46:47 INFO - 'PAGER': '/bin/cat', 07:46:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:47 INFO - 'PWD': '/builds/slave/test', 07:46:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:47 INFO - 'SHELL': '/bin/bash', 07:46:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:47 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:47 INFO - 'USER': 'cltbld', 07:46:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:47 INFO - 'XPC_FLAGS': '0x0', 07:46:47 INFO - 'XPC_SERVICE_NAME': '0', 07:46:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:47 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-0hynaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:47 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-z_s_6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-iGtbSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-RmxpCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-TeDM64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-vnYrkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-C94BF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Y_ZN2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5spz9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-K7U5MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-isN1h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Jo5Usb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-BaGqTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-u2Pdoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rhElFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-IGi_fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-1UQSnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:49 INFO - Running setup.py install for manifestparser 07:46:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:49 INFO - Running setup.py install for mozcrash 07:46:49 INFO - Running setup.py install for mozdebug 07:46:49 INFO - Running setup.py install for mozdevice 07:46:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:46:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:50 INFO - Running setup.py install for mozfile 07:46:50 INFO - Running setup.py install for mozhttpd 07:46:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:50 INFO - Running setup.py install for mozinfo 07:46:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:50 INFO - Running setup.py install for mozInstall 07:46:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:50 INFO - Running setup.py install for mozleak 07:46:50 INFO - Running setup.py install for mozlog 07:46:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:51 INFO - Running setup.py install for moznetwork 07:46:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:51 INFO - Running setup.py install for mozprocess 07:46:51 INFO - Running setup.py install for mozprofile 07:46:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:51 INFO - Running setup.py install for mozrunner 07:46:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:51 INFO - Running setup.py install for mozscreenshot 07:46:51 INFO - Running setup.py install for moztest 07:46:51 INFO - Running setup.py install for mozversion 07:46:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:52 INFO - Cleaning up... 07:46:52 INFO - Return code: 0 07:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:52 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 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:52 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:46:52 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:46:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:52 INFO - 'HOME': '/Users/cltbld', 07:46:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:52 INFO - 'LOGNAME': 'cltbld', 07:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:52 INFO - 'MOZ_NO_REMOTE': '1', 07:46:52 INFO - 'NO_EM_RESTART': '1', 07:46:52 INFO - 'PAGER': '/bin/cat', 07:46:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:52 INFO - 'PWD': '/builds/slave/test', 07:46:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:52 INFO - 'SHELL': '/bin/bash', 07:46:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:52 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:52 INFO - 'USER': 'cltbld', 07:46:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:52 INFO - 'XPC_FLAGS': '0x0', 07:46:52 INFO - 'XPC_SERVICE_NAME': '0', 07:46:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-8uxk68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-lbh0uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3TSxFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-skiAYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-xIOWW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-yCXxuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-7xlgY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YCH0C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-2hD3HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-jYYtLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rvBqkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-z0G6zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-OLDIw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NzVHA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-cccsvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:54 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:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3fb_0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:54 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:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-6fGlAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:56 INFO - Downloading blessings-1.6.tar.gz 07:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:56 INFO - Installing collected packages: blessings 07:46:56 INFO - Running setup.py install for blessings 07:46:56 INFO - Successfully installed blessings 07:46:56 INFO - Cleaning up... 07:46:57 INFO - Return code: 0 07:46:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:57 INFO - Reading from file tmpfile_stdout 07:46:57 INFO - Current package versions: 07:46:57 INFO - blessings == 1.6 07:46:57 INFO - blobuploader == 1.2.4 07:46:57 INFO - docopt == 0.6.1 07:46:57 INFO - functools32 == 3.2.3-2 07:46:57 INFO - jsonschema == 2.5.1 07:46:57 INFO - manifestparser == 1.1 07:46:57 INFO - mozInstall == 1.12 07:46:57 INFO - mozcrash == 0.17 07:46:57 INFO - mozdebug == 0.1 07:46:57 INFO - mozdevice == 0.48 07:46:57 INFO - mozfile == 1.2 07:46:57 INFO - mozhttpd == 0.7 07:46:57 INFO - mozinfo == 0.9 07:46:57 INFO - mozleak == 0.1 07:46:57 INFO - mozlog == 3.4 07:46:57 INFO - moznetwork == 0.27 07:46:57 INFO - mozprocess == 0.23 07:46:57 INFO - mozprofile == 0.28 07:46:57 INFO - mozrunner == 6.12 07:46:57 INFO - mozscreenshot == 0.1 07:46:57 INFO - mozsystemmonitor == 0.3 07:46:57 INFO - moztest == 0.7 07:46:57 INFO - mozversion == 1.4 07:46:57 INFO - psutil == 3.1.1 07:46:57 INFO - requests == 1.2.3 07:46:57 INFO - wsgiref == 0.1.2 07:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:57 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 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:57 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:46:57 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:46:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:57 INFO - 'HOME': '/Users/cltbld', 07:46:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:57 INFO - 'LOGNAME': 'cltbld', 07:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:57 INFO - 'MOZ_NO_REMOTE': '1', 07:46:57 INFO - 'NO_EM_RESTART': '1', 07:46:57 INFO - 'PAGER': '/bin/cat', 07:46:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:57 INFO - 'PWD': '/builds/slave/test', 07:46:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:57 INFO - 'SHELL': '/bin/bash', 07:46:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:57 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:57 INFO - 'USER': 'cltbld', 07:46:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:57 INFO - 'XPC_FLAGS': '0x0', 07:46:57 INFO - 'XPC_SERVICE_NAME': '0', 07:46:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 INFO - Cleaning up... 07:46:58 INFO - Return code: 0 07:46:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:46: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:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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 0x108288490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26acdb2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, '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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:46:58 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:46:58 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:46:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:46:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:58 INFO - 'HOME': '/Users/cltbld', 07:46:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:58 INFO - 'LOGNAME': 'cltbld', 07:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:58 INFO - 'MOZ_NO_REMOTE': '1', 07:46:58 INFO - 'NO_EM_RESTART': '1', 07:46:58 INFO - 'PAGER': '/bin/cat', 07:46:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:58 INFO - 'PWD': '/builds/slave/test', 07:46:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:58 INFO - 'SHELL': '/bin/bash', 07:46:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:46:58 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:46:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:58 INFO - 'USER': 'cltbld', 07:46:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:58 INFO - 'XPC_FLAGS': '0x0', 07:46:58 INFO - 'XPC_SERVICE_NAME': '0', 07:46:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:46:58 INFO - Cleaning up... 07:46:58 INFO - Return code: 0 07:46:58 INFO - Running post-action listener: _resource_record_post_action 07:46:58 INFO - Running post-action listener: _start_resource_monitoring 07:46:58 INFO - Starting resource monitoring. 07:46:58 INFO - [mozharness: 2016-11-08 15:46:58.339166Z] Finished create-virtualenv step (success) 07:46:58 INFO - [mozharness: 2016-11-08 15:46:58.340143Z] Running install step. 07:46:58 INFO - Running pre-action listener: _resource_record_pre_action 07:46:58 INFO - Running main action method: install 07:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:58 INFO - Reading from file tmpfile_stdout 07:46:58 INFO - Detecting whether we're running mozinstall >=1.0... 07:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:46:58 INFO - Reading from file tmpfile_stdout 07:46:58 INFO - Output received: 07:46:58 INFO - Usage: mozinstall [options] installer 07:46:58 INFO - Options: 07:46:58 INFO - -h, --help show this help message and exit 07:46:58 INFO - -d DEST, --destination=DEST 07:46:58 INFO - Directory to install application into. [default: 07:46:58 INFO - "/builds/slave/test"] 07:46:58 INFO - --app=APP Application being installed. [default: firefox] 07:46:58 INFO - mkdir: /builds/slave/test/build/application 07:46:58 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:46:58 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:47:30 INFO - Reading from file tmpfile_stdout 07:47:30 INFO - Output received: 07:47:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:47:30 INFO - Running post-action listener: _resource_record_post_action 07:47:30 INFO - [mozharness: 2016-11-08 15:47:30.632876Z] Finished install step (success) 07:47:30 INFO - [mozharness: 2016-11-08 15:47:30.633034Z] Running run-tests step. 07:47:30 INFO - Running pre-action listener: _resource_record_pre_action 07:47:30 INFO - Running main action method: run_tests 07:47:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:30 INFO - 2016-11-08 07:47:30.647 screenresolution[1637:7472] starting screenresolution argv=screenresolution get 07:47:30 INFO - 2016-11-08 07:47:30.650 screenresolution[1637:7472] Display 0: 1600x1200x32@60 07:47:30 INFO - 2016-11-08 07:47:30.655 screenresolution[1638:7474] starting screenresolution argv=screenresolution list 07:47:30 INFO - Available Modes on Display 0 07:47:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:30 INFO - Intel Iris: 07:47:30 INFO - Chipset Model: Intel Iris 07:47:30 INFO - Type: GPU 07:47:30 INFO - Bus: Built-In 07:47:30 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:30 INFO - Vendor: Intel (0x8086) 07:47:30 INFO - Device ID: 0x0a2e 07:47:30 INFO - Revision ID: 0x0009 07:47:30 INFO - Displays: 07:47:30 INFO - Display: 07:47:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:30 INFO - Display Serial Number: 1600x1200 60 07:47:30 INFO - Main Display: Yes 07:47:30 INFO - Mirror: Off 07:47:30 INFO - Online: Yes 07:47:30 INFO - Rotation: Supported 07:47:30 INFO - Return code: 0 07:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:30 INFO - Python 2.7.3 07:47:30 INFO - Return code: 0 07:47:30 INFO - grabbing minidump binary from tooltool 07:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:30 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 0x10809cd30>, '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 0x107f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108094b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:30 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:47:30 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:47:30 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:47:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:31 INFO - Return code: 0 07:47:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:47:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:47:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:31 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:47:31 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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:47:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJzjbWCdNr/Render', 07:47:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:31 INFO - 'HOME': '/Users/cltbld', 07:47:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:31 INFO - 'LOGNAME': 'cltbld', 07:47:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:31 INFO - 'MOZ_NO_REMOTE': '1', 07:47:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:31 INFO - 'NO_EM_RESTART': '1', 07:47:31 INFO - 'PAGER': '/bin/cat', 07:47:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:31 INFO - 'PWD': '/builds/slave/test', 07:47:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:31 INFO - 'SHELL': '/bin/bash', 07:47:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.km0nyJB3GZ/Listeners', 07:47:31 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:47:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:31 INFO - 'USER': 'cltbld', 07:47:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:31 INFO - 'XPC_FLAGS': '0x0', 07:47:31 INFO - 'XPC_SERVICE_NAME': '0', 07:47:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:47:31 INFO - mozversion application_buildid: 20161108062935 07:47:31 INFO - mozversion application_changeset: 71a57bc90cf23e334c6c680c929f5b0c5c836ada 07:47:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:47:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:31 INFO - mozversion application_name: Firefox 07:47:31 INFO - mozversion application_remotingname: firefox-dev 07:47:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:47:31 INFO - mozversion application_vendor: Mozilla 07:47:31 INFO - mozversion application_version: 51.0a2 07:47:31 INFO - mozversion platform_buildid: 20161108062935 07:47:31 INFO - mozversion platform_changeset: 71a57bc90cf23e334c6c680c929f5b0c5c836ada 07:47:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:47:31 INFO - mozversion platform_version: 51.0a2 07:47:31 INFO - using testdate: 1478620051 07:47:31 INFO - actual date: 1478620051 07:47:31 INFO - starting webserver on 'localhost:49280' 07:47:31 INFO - SUITE-START | Running 2 tests 07:47:31 INFO - TEST-START | dromaeo_css 07:47:31 INFO - operating with platform_type : mac_ 07:47:31 INFO - Initialising browser for dromaeo_css test... 07:47:31 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpw1iVcy/profile http://localhost:49280/getInfo.html) 07:47:33 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 07:47:33 INFO - PROCESS | 1648 | colorDepth:24 07:47:33 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 07:47:33 INFO - PROCESS | 1648 | __metrics 07:47:33 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:47:33 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:34 INFO - TEST-INFO | 1648: exit 0 07:47:34 INFO - Browser initialized. 07:47:34 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:34 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpw1iVcy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:46 INFO - PROCESS | 1650 | RSS: Main: 219926528 07:47:46 INFO - PROCESS | 1650 | 07:48:37 INFO - PROCESS | 1650 | 1478620117786 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:50:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 07:50:51 INFO - PROCESS | 1650 | RSS: Main: 368173056 07:50:51 INFO - PROCESS | 1650 | 07:53:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 07:53:55 INFO - PROCESS | 1650 | RSS: Main: 353157120 07:53:55 INFO - PROCESS | 1650 | 07:56:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 07:56:58 INFO - PROCESS | 1650 | RSS: Main: 351293440 07:56:58 INFO - PROCESS | 1650 | 08:00:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 08:00:00 INFO - PROCESS | 1650 | RSS: Main: 323260416 08:00:00 INFO - PROCESS | 1650 | 08:03:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 08:03:04 INFO - PROCESS | 1650 | RSS: Main: 313233408 08:03:04 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 08:06:08 INFO - PROCESS | 1650 | RSS: Main: 439885824 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | __start_tp_report 08:06:08 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 08:06:08 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 08:06:08 INFO - PROCESS | 1650 | |i|pagename|runs| 08:06:08 INFO - PROCESS | 1650 | |0;dojo.html;3279.524468952002;3301.570795796547;3324.4182268103077;3346.1969127409398;3376.3247350529887;5632.662040277586;5673.971630141844;5677.6309539879985;5681.2614360133175;5707.571932105093;5642.181883626871;5646.18130371096;5727.2268243787075;5730.341010783761;5760.164776107462;5158.767855446514;5182.896342073156;5185.274061631356;5243.764030618612;5251.396089449724;4853.660243782937;5157.896842063156;5191.896162076756;5273.393559740641;5325.3875804282425;4422.248217802965;5248.134057880445;5261.86845328866;5266.8683282917855;5283.365996080456;4273.487181538204;4554.294084416921;5249.1601343785005;5259.947400525984;5264.131418315973;5134.794608215667;5218.843434696965;5222.895542089175;5224.686518808883;5247.422783493813;5651.4348565143155;5652.632578882401;5742.196092547047;5761.020626493506;5776.364599894008;6051;6054.122152287893;6098.69506524672;6105.114758360058;6108.144859719643;6145.402195429176;6159.630422174639;6196.256449226076;6222.43998040174;6230.283517395512;5687.203791469197;5700.3444603871085;5706;5737.196792449061;5746.482816546531;6239.251289845157;6281.3404592518045;6296.811095667137;6299;6299.370062993664;6133.723982420713;6135.110408990671;6137;6146.446819786241;6150.323464418911;6140.938590614126;6167.96916015426;6191.938080619136;6220.377962203744;6238.625682459067;6160.44555989963;6197.504199664107;6213.689315534205;6232.127502149703;6234.5635805494085;6231.345708700521;6231.906521402183;6238.750449982041;6244.718987645567;6245.375462453719;4828.517148285144;4837.201861692782;4876.463589005207;4901.215805471107;4914.70511769295;4388.561143885586;4420.646348292129;4424.247877860771;4425.535318791481;4439.267520859086;5765.88468230633;5777.191193232867;5791.044477661223;5797.565182611321;5843.503302219359;5199.428062913076;6197.1324014637985;6226.6575338355915;6253.6560489172625;6254.906176407358;5659.377468478464;5729.88540229193;5736.282964629421;5764.827055188351;5794.8551286217335;5370.624056316098;5426.620136590401;5441.918371224435;5472.015037293326;5503.697296648723;6272;6281.52888533371;6281.7173227203975;6295.150154729053;6308.400701933309;6137.754489820357;6232.875342493034;6266.0528953811745;6330.620162790247;6341.207349081365;6203.751849925952;6229.937700622936;6242.406971337716;6260.436560709558;6289.654069026247;5633.887322253614;5871.4715675589405;6194.752209911733;6199.938000620116;6211.782587609412;4770.570648641639;5692.003899317686;6280.214973128359;6282.4974002080635;6302.401271879165;5852.151438041375;5980.1328807321825;6046.848828779316;6061.090836374579;6152.661603611844;5992.370801065999;6107.947487154961;6130.428711073822;6134.405972711667;6136.764169924236;5986.132010858489;5997.580169388276;6002.549808764273;6012.5791194617705;6016.067509536029;5969.940300596939;6035.849103772441;6066.514678825595;6112.205413296421;6143.109249158936;5895;5940.1683764272175;5946.881062378815;5971.611845230046;6000.939990600038 08:06:08 INFO - PROCESS | 1650 | |1;ext.html;501.1780679685319;513.1046324164331;518.7276679743135;538.5781536742999;560.6748086110057;29774.404511909775;30949.916752913625;39840.99999999996;40983;40989.38515922256;42706.78646606763;42866;42888.9277768056;42918;42957.140857182836;9613.855792163124;9795;9795.608175672964;9796.118349348557;9801.460919649417;9655.13103820656;9738.561764720605;9743.366681165702;9755.756106097333;9774.755631109243;9682.080202380797;9754.90245097547;9771.169450596672;9774.609015639402;9816.165625921769;9695.272854535902;9754.170895473893;9756.219502439788;9764.414135151914;9784.070513301296;9680.56437460316;9755.609775608968;9763.414195148314;9765.316427850054;9765.414075155513;40535.594644053774;40717.796411018055;40771.59228407737;40871.795641021905;40926.59073409258;3227.935441291161;3378.0879162626197;3823.617638236182;3966.206758648253;4016.879493615196;29524.114276571738;29673;30788;31140.873015873014;31541;3126.7185953264316;3152.889648862302;3155.794873333249;3356.681115294043;3361.159710072482;488962.33113006665;489209;495025;495482;496053;57531;57989.4201057984;58072.709636451546;58144.709276453345;58178.7091064542;60625.39374606198;60732.392676073556;60846;60856.391436085076;60902;16310.836891630932;16541.917290413712;16542.83457165437;16553.337866485206;16574.502764917073;13008.349582520836;13015.869841301466;13025.283609401384;13069.803952940714;13090.280034598189;13361.799573006412;14248.715025699428;15708.842911570739;15709.821763367792;15920.283587238602;5617.522510586646;6581.2760596334365;6756.797296081126;6772.762953296709;6796.694148763218;901.2069378946485;966.6568368229177;1033.8862725100232;1070.9678709638724;1084.8264277715684;29378;29686.257843554085;29904.55143172854;30296;30543.541846872315;1095.085603521053;1107.2636696596674;1133.489929531714;1141.2011591885548;1233.7964235901156;15056.774148387783;15402.22988850553;15427.765778737674;15473.690526189414;15828.208589570475;198100;199105.0044749767;199111;201604.99197504212;651344;57132.714336428886;57307.713461432424;57347.42652573504;57380.71309643425;57394.13908791372;1255.8430196225472;1273.1469915156868;1275.196626125535;1403.1510935883848;1416.8512306207906;29013.7098629011;29520.489181375106;32197.51703724399;32770;32880.50679239861;46965;53095;54456;54568.90862182814;54574.454255456934;630364;634309;635438;637148;637817;25759.227223183334;26080.73919260783;26436;26462.353764623385;26507.33731656724;46375.53624463847;46684;47506;47782;48197.51802481931;38124.809375952944;39127.608723912395;39152;40545.18909621732;40765.1846963065;38529;38680.41979370368;38787.80606096952;39683.00792480096;40169;37133;38012;38132.428013579265;38178;38248.808755956044;31913.840430797696;33036;34186.48720269248;34726.65273347234;34896.30207395888;26011.219663410127;26061.478770424863;26277.868610656824;26373.07694230693;26634.733652663224 08:06:08 INFO - PROCESS | 1650 | |2;jquery.html;351.3517560101612;374.32994939059085;374.7726196705788;382.9559600645925;404.106923698626;14857.62855928601;15132.092074475526;16596.751048734277;20320.89839550804;21017.579648407023;21374;21911.342659720194;22102;22277.331680049585;22638.66042009371;6619.801405957817;6703.329667033282;6858.142732158481;6918.238993710688;6949.305069493061;6816.829579260509;6841.521093523455;6869.416099631538;6887;6894.379505844473;4438.822447102112;6343.873122537547;8000.63997120131;8054.919450805475;8146.981627296588;7709.0749110107145;7862.764117076496;7900;7956.085050219241;8152.021757389121;7324.194338622748;7541.886871696929;7595.506292090997;7635.885461718079;7637.389008879276;24635.630465543032;24846.751532484624;27196.32009199766;28273.151805445665;29243.707562924523;2401.1955994741784;2578.2048863783184;2684.9194524164304;3158.6051743532057;3257.2833976525126;16867.746983795252;17012.744808827876;17065.40271090506;17370.218340174597;18005.459836204805;1984.186483541741;1984.2360691134018;1997.7103320018662;2055.9383218503467;2138.4012476506605;148692;151343;153839.23080384528;155499.2225038879;156369;17740.46778596644;19701.802981969995;19853.305134320228;20320;22016.33950981473;35685.28629427449;35716.464253036225;36290.09274768152;36413.08967275839;36505.63494365075;10782.137429005661;10916.672499825017;11089.5564177432;11235.269707468988;11242.943785281184;7958.363330933512;8946.955265223762;9052.818943621223;9159.496227707406;9311.068893110634;8084.959575202086;9560.90439095614;9568.138867501959;9730.318877678636;9748.61005559784;3678.716777615248;3702.426123950738;3722.218334149805;3726.2733766915735;3756.4740936268945;853.2107800284712;923.93532452729;951.4243882451018;959.5298303831072;960.851068084448;19868.70196947047;20825.37523874286;20834.47913802137;20846.791532084484;20868.26961056356;941.1576638908139;958.712386284112;969.9563519641633;970.2480577552453;971.7959228562081;8848.601812918434;10372;10709.946450267855;10844.64441944757;10896.673099807018;598436.0078199581;598831;604592;609694;612939;94816.10367792606;117793.82206178;119469;125883;131711;930.093159169804;954.2461455450117;972.1153750087386;974.0892265731563;976.6191185437685;14334.784978225543;17611.29554817844;18008.909955450137;18766.343177988703;19182.520436988627;55165.62085947883;56657.150142747065;58049.70975145097;58616.70691646515;59321.81356372762;81438.96402589983;81704.59147704224;82346;82760;83087.58456207922;5834.591578589458;7431.033965584439;7527.134379546423;7641.197674244125;8071.991001124859;11079.33523988531;13183.53857614979;13320.134191277535;13669.794953075512;13680.93159534196;10922.180836437457;11657.009154221647;11786;11844.46699898524;11890.821637675615;11240.426340312526;11418.086553075567;11428.14288928317;11879.930806227481;12139.150259482105;11455.713607159887;11533.884661153617;11610.535578576762;11892.643220703392;12068.094892883244;7402.777916662509;7410.888836667346;7599.962000189964;7634.160242373224;7714.498557593738;10943.179261555257;11439;11467.885321146681;11702.2978621283;11736.237144585575 08:06:08 INFO - PROCESS | 1650 | |3;mootools.html;1351.8580549042351;1448.5002674077446;1515.8029456170696;1828.542864283929;1877.108373522577;8578.48529088255;9150.359474836747;9165.725028249155;9166.083391660839;9170.358074934757;8001.159878212777;8247.876281855762;8248.670053197864;8349.582520873962;8914.153155450222;2148.9355319340407;2181.0512427094186;2342.472943587696;2415.335782659765;2421.9636705449434;2393.2580899920995;2411.9035238590436;2415.7342692303832;2417.9758202417925;2418.588839897213;2406.8074554035725;2417.226487523993;2419.661247425362;2421.6367544868235;2423.8909249083745;2368.751281115484;2400.867952262625;2405.0980882169188;2406.3382569793357;2411.397150712322;2386.6181410974336;2402.5675378431874;2413.083028449178;2419.346776370388;2422.63660450932;8865.778355541099;9046.185843274072;9063;9067.637294508211;9069.954650226773;4728.3143944127905;5268.5521730652945;5436.320459942507;5446.183072539111;5455.618106732531;3617.0776452004834;3645.708343332527;3703.870364537255;3767.6624798196794;3771.4719939208535;1094.5567045346568;1105.5798796457375;1107.0313475708756;1124.2579897267765;1124.370352602537;11940.044796416265;12092.214006089576;12093.516259349615;12095;12130.514779408724;4752.405949256343;4771.23660214364;4785.282773478392;4848.418189817245;4891.608671306287;10153.644622438327;10153.898461015444;10156.542955566869;10158.984101589782;10169.593216271414;5376.973115134399;5383.246345511631;5383.892322153535;5390.649607775482;5393.191021346751;4549.886252843706;4905.3132561441425;4921.286413470027;4921.680090794087;4935.457099719028;3798.4112462568346;3807.3908174691915;3841.9039524011564;3883.5533913600298;3891.7664940103687;1187.4003628167893;1190.4166958190597;1196.8144937534696;1202.8255902894032;1203.3802591665299;820.1142765812908;836.3768992100923;878.8311545644277;900.4687234531658;925.6390007896925;5575.135853942646;5733.3406658234835;5733.598648094593;5763.337216220105;6007.068904319837;441.139777434005;443.662816259645;447.48092213032726;457.3551292677309;457.5675986193082;3696.1868388954385;3816.7900765458166;3861.3242682530445;3915.960840391617;3975.284448799244;10425.322354046963;10529.789404211873;10936.343819370704;11029.83455248172;11038.834417483744;10705;10974.725631859108;10979.341239525495;10979.39613321275;10993.010629043265;8054.436189466798;8159.877601835978;8253.793655158548;8378.79053023667;8383.24550790444;5856.267966504187;5874.353821079763;5925;6068.51451883857;6113.419225173601;10202.979702029737;10289;10293.691189264335;10294.485275736033;10314.948425257826;8429.87355189685;8799.648014079365;10150.03574660406;10232.283740138118;10515.526801293807;6979.616121113185;7217.170025447141;7556.8488630228185;7643.770686879402;7740.14858365568;7419.332260096618;7643.159252482334;8314.750557483285;8459.196376344238;8634.740957771277;7504.024476817979;7526.774196774106;7532.5857077859055;7569.848603028019;7691.461597688108;6597.637129957899;7423.740169094056;7523.3229009389415;7530.28462296081;7561.243875612395;6886.035954966409;7020.333068358498;7025.156981162293;7027.8945815811785;7039.612821294878;4815.109204797123;4886.900447399306;4916.385451818523;4929;5015.097282489041;4855.320255164209;4896.4124305083615;4924.852254432372;5005.549500544968;5063.721495317645 08:06:08 INFO - PROCESS | 1650 | |4;prototype.html;279.8768541841591;299.2056091078187;302.496343587926;307.86761692472237;313.78819296974535;4177.895552611186;4197.5382707902145;4852.932354881925;5356.437574054727;5388.922215556885;4801.807927682898;4973.676711013782;5090.294751258323;5327.760250788714;5331.733413329328;3456.0796127272415;4104.917901641966;4110.815013324393;4116.259073366793;4125.216208920303;4025.7987100644996;4161.771102589357;4162.897736642991;4170.47869016373;4185.937210941823;3432.8626854925774;3938.9167978805913;4085.44846445729;4110.403991421242;4110.622941314663;3419.4186988212064;4090.386442033689;4098.036961314089;4102.169503042891;4121.196366708493;2827.7737780977677;3341.0979035660234;3431.4852772084137;3591.676749092594;3610.458431235336;3953.9126740146403;4566.840160594396;4735.242361222222;4832.95167048332;5204.141316682742;4198.580141985807;4674.610907092365;4688.929666055012;4706.623470122382;4721.315409265637;5064.442911279756;5307.01820163271;5639.718014099279;5645.532161637962;5650.6892120933335;3231.434498962672;3566.5006899034156;3887.71705337238;3941.960580394188;3975.185087057175;5908.881822363572;5942.494887934531;5945;5949.375315591844;5987.940120598825;3366.208940898936;3644.706129324105;3926.9410958835642;3954.4463775071513;3962.5244970603712;3477.808720520345;3840.8847734568008;3935.8819235422984;3950.4074388841327;3964.7621142731527;3892.260470510594;4589.426321709786;4595.563421474954;4598.068811099346;4620.283856002325;5663.980483512924;5716.628419152742;5736.42635736423;5776.653400795965;5806.187133801272;1268.403850190409;1288.3815768431205;1312.5143696832233;1313.914595551286;1330;734.9669264883094;784.9372050235968;799.6641410607559;800.4116974024088;821.1460081515157;3983.964169315999;4080.81636326366;4190.769507677107;4523.17301686446;4543.977280113579;4665.906681866344;4873.756312184377;4904.4605093439695;4911.022072121522;4918.3360246367;3797.9620203798163;4170.979145104316;4409.582573505559;4469.5306992765945;4559.879655959929;2420.1166574200643;2528.103922058456;2542.4915016996306;2559.7184309725917;2562.7437256274225;4668.5098064702715;4710.929336059962;4960.082384758831;4978.004399120118;4996.052329125833;5453.300616195009;5463.7814487420055;5934.8813023739285;6000.579959402888;6016.2479690038745;5565.916511252334;6101.034327687039;6102.552058087166;6105.297890742621;6148.938510614837;5568.443155684399;5784.363719990882;5795.478406943395;5904.545840683249;6013.939860601338;5232.764525596282;5256.947430525645;5464.453554644663;5527.972360138174;5854.531637468907;5561.888762224814;5588.692621905834;5867;6071.726772295169;6099;3210.9357812843145;3331.9167020824675;3635.527381440396;3657.707383409374;3707.8331475083146;5861.35525092248;5864.618799778001;5878.943528965;5894.764209431746;5911.733971971185;5442.6462279951675;5758.798442054508;5763.279590051244;5778.219940308173;5782.306123265235;4760.761961901961;5641.746121424628;5643.830685079454;5653.519450846724;5667.773289068556;5341.732913354394;5511.972440137773;5524.66851988882;5562.582806289625;5581.665100094007;4508.32375143731;5058.319090881839;5182.378114626269;5614.9719251403485;5629.761452480611;4509.489321077344;5436.510714035598;5695.629784064023;5715.6568206472275;5724.398938111438 08:06:08 INFO - PROCESS | 1650 | |5;yui.html;643.4787821864287;737.9483436159469;753.796474951763;755.5091270057382;770.0797546931419;15063.472778452757;16199.757003644954;16276.348946042173;16287.674246515062;16314.265858036388;14411.63970900728;14598.562043138696;14605.269736513184;14615.634609134777;14656.267186640678;678.5080816408089;700.7302188657353;828.9917100828975;835.9205875441824;856.8671855862351;848.0967769325648;855.7732200966749;860.9182127697859;862.905080441151;864.2308345572445;925.3799954030816;926.8378033844084;927.2952556057411;927.8329900617886;928.9210417114554;712.5831388637653;734.0530715377157;918.4902379179553;920.8434566123775;921.7511271956567;537.7660717587862;665.171861033017;671.2850813883248;673.0946876451166;675.0347003784586;14873;14928.402863885432;14949.626259343495;14953.850461495464;14965.326560304813;13575;13927.721445571133;13990.020698551105;14030.750828577755;14037;11113.888861111447;11565.479553420117;11639.418029098511;11975.94012029943;12090.637280881587;4597.218472859622;4622.1911165546235;4773.856784296477;4808.639352048575;4848.563629273347;106653.46673266661;107769.07055844419;111678.44160779225;112298.75402491905;114637.85362146355;10324.535395907202;10497.16022718196;10989.725256868642;11044.447777611087;11104;20715.792842071387;20735.792642073688;20745.481362966046;20768.68846967297;20788.1684732612;6848.657567121723;7538.472306938462;7676.080979755061;7819.413543984224;8082.2725954664365;4385.210662080793;4400.163968845909;4491.258942274553;4543.9548903751665;4679.695819771704;3610;3672.7245456590863;3755.887323380303;3756.023433907204;3777.0746167189213;616.8889599872066;681.8874885643813;685.1880521581942;687.7558466744334;695.3602685529326;637.6907200007993;639.6354078175395;655.0272350825436;669.334012657409;688.7417218543046;8859.601317940707;9325.673601423918;9413.388129771543;9413.529323533796;9425.38734982224;554.2268535393184;648.9634473574359;651.9902201466982;689.4105539763531;696.3837004251172;4030.679661808396;4375.387445757597;4682.882927926761;4695.624350051988;4832.081904438145;116592.41703791596;167767;172622.13688931725;174677;176679;88481.67277490842;120155;141275.0688409244;142139.2893035549;143758;95685.043149569;98517;110780;120407.39796300963;128877;9472.95263523678;9981.642272388985;10166.440845753554;10201;10217.693469195936;45533.31700024568;50080;59003.99999999828;62003;62167.067493986724;83541;93616.06383936074;94874.10251795064;95610;98345;12755.411793978601;12777.616671499869;13096.69462015117;13142.934285328512;13715.862841371458;13771.517996870061;14714.63213419673;14837.258137093319;15437.996530225499;15476.458323959057;14054.718905622034;14106.858931410965;14235.786463202852;14505.927470362582;14540.636484087983;13795.862041379458;13932.373043212878;13942.860571394562;14510.419583216553;14544.709105817612;11993.40032998364;13180.077394582288;13855.515056972958;14416.711665766416;14473.638159046108;11023.724406889893;11471.369074700639;11499.540018399504;11662.76674466489;11679;11500.367479788358;11658.358790266617;11767.88232117668;11804.586839460577;11812.232204906653 08:06:08 INFO - PROCESS | 1650 | __end_tp_report 08:06:08 INFO - PROCESS | 1650 | __start_cc_report 08:06:08 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1391 08:06:08 INFO - PROCESS | 1650 | __end_cc_report 08:06:08 INFO - PROCESS | 1650 | __startTimestamp1478621168347__endTimestamp 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | ------- Summary: start ------- 08:06:08 INFO - PROCESS | 1650 | Number of tests: 6 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5702.26 Median:5940.17 stddev:657.78 (11.1%) stddev-sans-first:631.74 08:06:08 INFO - PROCESS | 1650 | Values: 3279.5 3301.6 3324.4 3346.2 3376.3 5632.7 5674.0 5677.6 5681.3 5707.6 5642.2 5646.2 5727.2 5730.3 5760.2 5158.8 5182.9 5185.3 5243.8 5251.4 4853.7 5157.9 5191.9 5273.4 5325.4 4422.2 5248.1 5261.9 5266.9 5283.4 4273.5 4554.3 5249.2 5259.9 5264.1 5134.8 5218.8 5222.9 5224.7 5247.4 5651.4 5652.6 5742.2 5761.0 5776.4 6051.0 6054.1 6098.7 6105.1 6108.1 6145.4 6159.6 6196.3 6222.4 6230.3 5687.2 5700.3 5706.0 5737.2 5746.5 6239.3 6281.3 6296.8 6299.0 6299.4 6133.7 6135.1 6137.0 6146.4 6150.3 6140.9 6168.0 6191.9 6220.4 6238.6 6160.4 6197.5 6213.7 6232.1 6234.6 6231.3 6231.9 6238.8 6244.7 6245.4 4828.5 4837.2 4876.5 4901.2 4914.7 4388.6 4420.6 4424.2 4425.5 4439.3 5765.9 5777.2 5791.0 5797.6 5843.5 5199.4 6197.1 6226.7 6253.7 6254.9 5659.4 5729.9 5736.3 5764.8 5794.9 5370.6 5426.6 5441.9 5472.0 5503.7 6272.0 6281.5 6281.7 6295.2 6308.4 6137.8 6232.9 6266.1 6330.6 6341.2 6203.8 6229.9 6242.4 6260.4 6289.7 5633.9 5871.5 6194.8 6199.9 6211.8 4770.6 5692.0 6280.2 6282.5 6302.4 5852.2 5980.1 6046.8 6061.1 6152.7 5992.4 6107.9 6130.4 6134.4 6136.8 5986.1 5997.6 6002.5 6012.6 6016.1 5969.9 6035.8 6066.5 6112.2 6143.1 5895.0 5940.2 5946.9 5971.6 6000.9 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:62081.36 Median:21928.94 stddev:135340.10 (617.2%) stddev-sans-first:135640.79 08:06:08 INFO - PROCESS | 1650 | Values: 501.2 513.1 518.7 538.6 560.7 29774.4 30949.9 39841.0 40983.0 40989.4 42706.8 42866.0 42888.9 42918.0 42957.1 9613.9 9795.0 9795.6 9796.1 9801.5 9655.1 9738.6 9743.4 9755.8 9774.8 9682.1 9754.9 9771.2 9774.6 9816.2 9695.3 9754.2 9756.2 9764.4 9784.1 9680.6 9755.6 9763.4 9765.3 9765.4 40535.6 40717.8 40771.6 40871.8 40926.6 3227.9 3378.1 3823.6 3966.2 4016.9 29524.1 29673.0 30788.0 31140.9 31541.0 3126.7 3152.9 3155.8 3356.7 3361.2 488962.3 489209.0 495025.0 495482.0 496053.0 57531.0 57989.4 58072.7 58144.7 58178.7 60625.4 60732.4 60846.0 60856.4 60902.0 16310.8 16541.9 16542.8 16553.3 16574.5 13008.3 13015.9 13025.3 13069.8 13090.3 13361.8 14248.7 15708.8 15709.8 15920.3 5617.5 6581.3 6756.8 6772.8 6796.7 901.2 966.7 1033.9 1071.0 1084.8 29378.0 29686.3 29904.6 30296.0 30543.5 1095.1 1107.3 1133.5 1141.2 1233.8 15056.8 15402.2 15427.8 15473.7 15828.2 198100.0 199105.0 199111.0 201605.0 651344.0 57132.7 57307.7 57347.4 57380.7 57394.1 1255.8 1273.1 1275.2 1403.2 1416.9 29013.7 29520.5 32197.5 32770.0 32880.5 46965.0 53095.0 54456.0 54568.9 54574.5 630364.0 634309.0 635438.0 637148.0 637817.0 25759.2 26080.7 26436.0 26462.4 26507.3 46375.5 46684.0 47506.0 47782.0 48197.5 38124.8 39127.6 39152.0 40545.2 40765.2 38529.0 38680.4 38787.8 39683.0 40169.0 37133.0 38012.0 38132.4 38178.0 38248.8 31913.8 33036.0 34186.5 34726.7 34896.3 26011.2 26061.5 26277.9 26373.1 26634.7 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:37656.38 Median:36003.28 stddev:101425.05 (281.7%) stddev-sans-first:101670.89 08:06:08 INFO - PROCESS | 1650 | Values: 351.4 374.3 374.8 383.0 404.1 14857.6 15132.1 16596.8 20320.9 21017.6 21374.0 21911.3 22102.0 22277.3 22638.7 6619.8 6703.3 6858.1 6918.2 6949.3 6816.8 6841.5 6869.4 6887.0 6894.4 4438.8 6343.9 8000.6 8054.9 8147.0 7709.1 7862.8 7900.0 7956.1 8152.0 7324.2 7541.9 7595.5 7635.9 7637.4 24635.6 24846.8 27196.3 28273.2 29243.7 2401.2 2578.2 2684.9 3158.6 3257.3 16867.7 17012.7 17065.4 17370.2 18005.5 1984.2 1984.2 1997.7 2055.9 2138.4 148692.0 151343.0 153839.2 155499.2 156369.0 17740.5 19701.8 19853.3 20320.0 22016.3 35685.3 35716.5 36290.1 36413.1 36505.6 10782.1 10916.7 11089.6 11235.3 11242.9 7958.4 8947.0 9052.8 9159.5 9311.1 8085.0 9560.9 9568.1 9730.3 9748.6 3678.7 3702.4 3722.2 3726.3 3756.5 853.2 923.9 951.4 959.5 960.9 19868.7 20825.4 20834.5 20846.8 20868.3 941.2 958.7 970.0 970.2 971.8 8848.6 10372.0 10709.9 10844.6 10896.7 598436.0 598831.0 604592.0 609694.0 612939.0 94816.1 117793.8 119469.0 125883.0 131711.0 930.1 954.2 972.1 974.1 976.6 14334.8 17611.3 18008.9 18766.3 19182.5 55165.6 56657.2 58049.7 58616.7 59321.8 81439.0 81704.6 82346.0 82760.0 83087.6 5834.6 7431.0 7527.1 7641.2 8072.0 11079.3 13183.5 13320.1 13669.8 13680.9 10922.2 11657.0 11786.0 11844.5 11890.8 11240.4 11418.1 11428.1 11879.9 12139.2 11455.7 11533.9 11610.5 11892.6 12068.1 7402.8 7410.9 7600.0 7634.2 7714.5 10943.2 11439.0 11467.9 11702.3 11736.2 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5733.45 Median:4761.82 stddev:3265.39 (68.6%) stddev-sans-first:3257.95 08:06:08 INFO - PROCESS | 1650 | Values: 1351.9 1448.5 1515.8 1828.5 1877.1 8578.5 9150.4 9165.7 9166.1 9170.4 8001.2 8247.9 8248.7 8349.6 8914.2 2148.9 2181.1 2342.5 2415.3 2422.0 2393.3 2411.9 2415.7 2418.0 2418.6 2406.8 2417.2 2419.7 2421.6 2423.9 2368.8 2400.9 2405.1 2406.3 2411.4 2386.6 2402.6 2413.1 2419.3 2422.6 8865.8 9046.2 9063.0 9067.6 9070.0 4728.3 5268.6 5436.3 5446.2 5455.6 3617.1 3645.7 3703.9 3767.7 3771.5 1094.6 1105.6 1107.0 1124.3 1124.4 11940.0 12092.2 12093.5 12095.0 12130.5 4752.4 4771.2 4785.3 4848.4 4891.6 10153.6 10153.9 10156.5 10159.0 10169.6 5377.0 5383.2 5383.9 5390.6 5393.2 4549.9 4905.3 4921.3 4921.7 4935.5 3798.4 3807.4 3841.9 3883.6 3891.8 1187.4 1190.4 1196.8 1202.8 1203.4 820.1 836.4 878.8 900.5 925.6 5575.1 5733.3 5733.6 5763.3 6007.1 441.1 443.7 447.5 457.4 457.6 3696.2 3816.8 3861.3 3916.0 3975.3 10425.3 10529.8 10936.3 11029.8 11038.8 10705.0 10974.7 10979.3 10979.4 10993.0 8054.4 8159.9 8253.8 8378.8 8383.2 5856.3 5874.4 5925.0 6068.5 6113.4 10203.0 10289.0 10293.7 10294.5 10314.9 8429.9 8799.6 10150.0 10232.3 10515.5 6979.6 7217.2 7556.8 7643.8 7740.1 7419.3 7643.2 8314.8 8459.2 8634.7 7504.0 7526.8 7532.6 7569.8 7691.5 6597.6 7423.7 7523.3 7530.3 7561.2 6886.0 7020.3 7025.2 7027.9 7039.6 4815.1 4886.9 4916.4 4929.0 5015.1 4855.3 4896.4 4924.9 5005.5 5063.7 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4451.10 Median:4781.28 stddev:1426.31 (29.8%) stddev-sans-first:1395.53 08:06:08 INFO - PROCESS | 1650 | Values: 279.9 299.2 302.5 307.9 313.8 4177.9 4197.5 4852.9 5356.4 5388.9 4801.8 4973.7 5090.3 5327.8 5331.7 3456.1 4104.9 4110.8 4116.3 4125.2 4025.8 4161.8 4162.9 4170.5 4185.9 3432.9 3938.9 4085.4 4110.4 4110.6 3419.4 4090.4 4098.0 4102.2 4121.2 2827.8 3341.1 3431.5 3591.7 3610.5 3953.9 4566.8 4735.2 4833.0 5204.1 4198.6 4674.6 4688.9 4706.6 4721.3 5064.4 5307.0 5639.7 5645.5 5650.7 3231.4 3566.5 3887.7 3942.0 3975.2 5908.9 5942.5 5945.0 5949.4 5987.9 3366.2 3644.7 3926.9 3954.4 3962.5 3477.8 3840.9 3935.9 3950.4 3964.8 3892.3 4589.4 4595.6 4598.1 4620.3 5664.0 5716.6 5736.4 5776.7 5806.2 1268.4 1288.4 1312.5 1313.9 1330.0 735.0 784.9 799.7 800.4 821.1 3984.0 4080.8 4190.8 4523.2 4544.0 4665.9 4873.8 4904.5 4911.0 4918.3 3798.0 4171.0 4409.6 4469.5 4559.9 2420.1 2528.1 2542.5 2559.7 2562.7 4668.5 4710.9 4960.1 4978.0 4996.1 5453.3 5463.8 5934.9 6000.6 6016.2 5565.9 6101.0 6102.6 6105.3 6148.9 5568.4 5784.4 5795.5 5904.5 6013.9 5232.8 5256.9 5464.5 5528.0 5854.5 5561.9 5588.7 5867.0 6071.7 6099.0 3210.9 3331.9 3635.5 3657.7 3707.8 5861.4 5864.6 5878.9 5894.8 5911.7 5442.6 5758.8 5763.3 5778.2 5782.3 4760.8 5641.7 5643.8 5653.5 5667.8 5341.7 5512.0 5524.7 5562.6 5581.7 4508.3 5058.3 5182.4 5615.0 5629.8 4509.5 5436.5 5695.6 5715.7 5724.4 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25171.55 Median:3641.36 stddev:40995.42 (1125.8%) stddev-sans-first:41069.05 08:06:08 INFO - PROCESS | 1650 | Values: 643.5 737.9 753.8 755.5 770.1 15063.5 16199.8 16276.3 16287.7 16314.3 14411.6 14598.6 14605.3 14615.6 14656.3 678.5 700.7 829.0 835.9 856.9 848.1 855.8 860.9 862.9 864.2 925.4 926.8 927.3 927.8 928.9 712.6 734.1 918.5 920.8 921.8 537.8 665.2 671.3 673.1 675.0 14873.0 14928.4 14949.6 14953.9 14965.3 13575.0 13927.7 13990.0 14030.8 14037.0 11113.9 11565.5 11639.4 11975.9 12090.6 4597.2 4622.2 4773.9 4808.6 4848.6 106653.5 107769.1 111678.4 112298.8 114637.9 10324.5 10497.2 10989.7 11044.4 11104.0 20715.8 20735.8 20745.5 20768.7 20788.2 6848.7 7538.5 7676.1 7819.4 8082.3 4385.2 4400.2 4491.3 4544.0 4679.7 3610.0 3672.7 3755.9 3756.0 3777.1 616.9 681.9 685.2 687.8 695.4 637.7 639.6 655.0 669.3 688.7 8859.6 9325.7 9413.4 9413.5 9425.4 554.2 649.0 652.0 689.4 696.4 4030.7 4375.4 4682.9 4695.6 4832.1 116592.4 167767.0 172622.1 174677.0 176679.0 88481.7 120155.0 141275.1 142139.3 143758.0 95685.0 98517.0 110780.0 120407.4 128877.0 9473.0 9981.6 10166.4 10201.0 10217.7 45533.3 50080.0 59004.0 62003.0 62167.1 83541.0 93616.1 94874.1 95610.0 98345.0 12755.4 12777.6 13096.7 13142.9 13715.9 13771.5 14714.6 14837.3 15438.0 15476.5 14054.7 14106.9 14235.8 14505.9 14540.6 13795.9 13932.4 13942.9 14510.4 14544.7 11993.4 13180.1 13855.5 14416.7 14473.6 11023.7 11471.4 11499.5 11662.8 11679.0 11500.4 11658.4 11767.9 11804.6 11812.2 08:06:08 INFO - PROCESS | 1650 | -------- Summary: end -------- 08:06:08 INFO - PROCESS | 1650 | 08:06:08 INFO - TEST-INFO | 1650: exit 0 08:06:08 INFO - TEST-OK | dromaeo_css | took 1117751ms 08:06:08 INFO - TEST-START | kraken 08:06:08 INFO - operating with platform_type : mac_ 08:06:08 INFO - Initialising browser for kraken test... 08:06:08 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpSXQXoj/profile http://localhost:49280/getInfo.html) 08:06:11 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:06:11 INFO - PROCESS | 1659 | colorDepth:24 08:06:11 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:06:11 INFO - PROCESS | 1659 | __metrics 08:06:11 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:06:11 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:11 INFO - TEST-INFO | 1659: exit 0 08:06:11 INFO - Browser initialized. 08:06:11 INFO - Running cycle 1/1 for kraken test... 08:06:11 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpSXQXoj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:23 INFO - PROCESS | 1660 | RSS: Main: 220258304 08:06:23 INFO - PROCESS | 1660 | 08:06:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:27 INFO - PROCESS | 1660 | RSS: Main: 270999552 08:06:27 INFO - PROCESS | 1660 | 08:06:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 08:06:31 INFO - PROCESS | 1660 | RSS: Main: 282288128 08:06:31 INFO - PROCESS | 1660 | 08:06:34 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 08:06:34 INFO - PROCESS | 1660 | RSS: Main: 379318272 08:06:34 INFO - PROCESS | 1660 | 08:06:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 08:06:37 INFO - PROCESS | 1660 | RSS: Main: 281120768 08:06:37 INFO - PROCESS | 1660 | 08:06:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:39 INFO - PROCESS | 1660 | RSS: Main: 281776128 08:06:39 INFO - PROCESS | 1660 | 08:06:42 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:43 INFO - PROCESS | 1660 | RSS: Main: 319938560 08:06:43 INFO - PROCESS | 1660 | 08:06:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:46 INFO - PROCESS | 1660 | RSS: Main: 319545344 08:06:46 INFO - PROCESS | 1660 | 08:06:49 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 08:06:50 INFO - PROCESS | 1660 | RSS: Main: 318918656 08:06:50 INFO - PROCESS | 1660 | 08:06:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:52 INFO - PROCESS | 1660 | RSS: Main: 291528704 08:06:52 INFO - PROCESS | 1660 | 08:06:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:54 INFO - PROCESS | 1660 | RSS: Main: 296935424 08:06:54 INFO - PROCESS | 1660 | 08:06:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:57 INFO - PROCESS | 1660 | RSS: Main: 298569728 08:06:57 INFO - PROCESS | 1660 | 08:07:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:01 INFO - PROCESS | 1660 | RSS: Main: 316506112 08:07:01 INFO - PROCESS | 1660 | 08:07:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:04 INFO - PROCESS | 1660 | RSS: Main: 310456320 08:07:04 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 08:07:06 INFO - PROCESS | 1660 | RSS: Main: 355217408 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | __start_tp_report 08:07:06 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 08:07:06 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 08:07:06 INFO - PROCESS | 1660 | |i|pagename|runs| 08:07:06 INFO - PROCESS | 1660 | |0;ai-astar;115;116;115;113;113;115;113;112;114;113 08:07:06 INFO - PROCESS | 1660 | |1;audio-beat-detection;144;109;136;137;138;136;137;109;136;108 08:07:06 INFO - PROCESS | 1660 | |2;audio-dft;184;184;187;186;182;185;185;186;183;184 08:07:06 INFO - PROCESS | 1660 | |3;audio-fft;82;60;58;89;61;59;58;59;83;58 08:07:06 INFO - PROCESS | 1660 | |4;audio-oscillator;84;70;92;71;68;69;91;67;68;89 08:07:06 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;89;86;134;86;95;122;87;84;87;84 08:07:06 INFO - PROCESS | 1660 | |6;imaging-darkroom;94;93;93;93;93;93;93;93;94;93 08:07:06 INFO - PROCESS | 1660 | |7;imaging-desaturate;84;85;86;85;86;86;85;86;85;86 08:07:06 INFO - PROCESS | 1660 | |8;json-parse-financial;57;54;53;54;57;59;58;58;57;58 08:07:06 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;67;65;82;76;74;68;70;70;70;72 08:07:06 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;82;82;81;82;80;79;71;80;96;105 08:07:06 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;137;146;149;155;155;143;138;150;197;136 08:07:06 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;162;164;164;163;164;165;161;162;190;218 08:07:06 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;67;67;66;66;67 08:07:06 INFO - PROCESS | 1660 | __end_tp_report 08:07:06 INFO - PROCESS | 1660 | __start_cc_report 08:07:06 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1966 08:07:06 INFO - PROCESS | 1660 | __end_cc_report 08:07:06 INFO - PROCESS | 1660 | __startTimestamp1478621226777__endTimestamp 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | ------- Summary: start ------- 08:07:06 INFO - PROCESS | 1660 | Number of tests: 14 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.29 (1.1%) stddev-sans-first:1.30 08:07:06 INFO - PROCESS | 1660 | Values: 115.0 116.0 115.0 113.0 113.0 115.0 113.0 112.0 114.0 113.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:136.50 stddev:14.23 (10.4%) stddev-sans-first:14.02 08:07:06 INFO - PROCESS | 1660 | Values: 144.0 109.0 136.0 137.0 138.0 136.0 137.0 109.0 136.0 108.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:1.51 (0.8%) stddev-sans-first:1.58 08:07:06 INFO - PROCESS | 1660 | Values: 184.0 184.0 187.0 186.0 182.0 185.0 185.0 186.0 183.0 184.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:66.70 Median:60.50 stddev:12.56 (20.8%) stddev-sans-first:12.04 08:07:06 INFO - PROCESS | 1660 | Values: 82.0 60.0 58.0 89.0 61.0 59.0 58.0 59.0 83.0 58.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.50 stddev:10.67 (13.8%) stddev-sans-first:11.01 08:07:06 INFO - PROCESS | 1660 | Values: 84.0 70.0 92.0 71.0 68.0 69.0 91.0 67.0 68.0 89.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:95.40 Median:86.50 stddev:17.69 (20.5%) stddev-sans-first:18.61 08:07:06 INFO - PROCESS | 1660 | Values: 89.0 86.0 134.0 86.0 95.0 122.0 87.0 84.0 87.0 84.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 08:07:06 INFO - PROCESS | 1660 | Values: 94.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 93.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 08:07:06 INFO - PROCESS | 1660 | Values: 84.0 85.0 86.0 85.0 86.0 86.0 85.0 86.0 85.0 86.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.50 stddev:2.07 (3.6%) stddev-sans-first:2.19 08:07:06 INFO - PROCESS | 1660 | Values: 57.0 54.0 53.0 54.0 57.0 59.0 58.0 58.0 57.0 58.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:4.93 (6.9%) stddev-sans-first:4.96 08:07:06 INFO - PROCESS | 1660 | Values: 67.0 65.0 82.0 76.0 74.0 68.0 70.0 70.0 70.0 72.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.50 stddev:9.61 (11.8%) stddev-sans-first:10.17 08:07:06 INFO - PROCESS | 1660 | Values: 82.0 82.0 81.0 82.0 80.0 79.0 71.0 80.0 96.0 105.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:149.50 stddev:17.73 (11.9%) stddev-sans-first:18.11 08:07:06 INFO - PROCESS | 1660 | Values: 137.0 146.0 149.0 155.0 155.0 143.0 138.0 150.0 197.0 136.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:164.00 stddev:18.49 (11.3%) stddev-sans-first:19.31 08:07:06 INFO - PROCESS | 1660 | Values: 162.0 164.0 164.0 163.0 164.0 165.0 161.0 162.0 190.0 218.0 08:07:06 INFO - PROCESS | 1660 | 08:07:06 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:07:06 INFO - PROCESS | 1660 | Values: 67.0 66.0 67.0 66.0 66.0 67.0 67.0 66.0 66.0 67.0 08:07:06 INFO - PROCESS | 1660 | -------- Summary: end -------- 08:07:06 INFO - PROCESS | 1660 | 08:07:07 INFO - TEST-INFO | 1660: exit 0 08:07:07 INFO - TEST-OK | kraken | took 58757ms 08:07:07 INFO - SUITE-END | took 1176s 08:07:07 INFO - Completed test suite (00:19:36) 08:07:07 INFO - javascript benchmark 08:07:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.524468952002, 3301.570795796547, 3324.4182268103077, 3346.1969127409398, 3376.3247350529887, 5632.662040277586, 5673.971630141844, 5677.6309539879985, 5681.2614360133175, 5707.571932105093, 5642.181883626871, 5646.18130371096, 5727.2268243787075, 5730.341010783761, 5760.164776107462, 5158.767855446514, 5182.896342073156, 5185.274061631356, 5243.764030618612, 5251.396089449724, 4853.660243782937, 5157.896842063156, 5191.896162076756, 5273.393559740641, 5325.3875804282425, 4422.248217802965, 5248.134057880445, 5261.86845328866, 5266.8683282917855, 5283.365996080456, 4273.487181538204, 4554.294084416921, 5249.1601343785005, 5259.947400525984, 5264.131418315973, 5134.794608215667, 5218.843434696965, 5222.895542089175, 5224.686518808883, 5247.422783493813, 5651.4348565143155, 5652.632578882401, 5742.196092547047, 5761.020626493506, 5776.364599894008, 6051.0, 6054.122152287893, 6098.69506524672, 6105.114758360058, 6108.144859719643, 6145.402195429176, 6159.630422174639, 6196.256449226076, 6222.43998040174, 6230.283517395512, 5687.203791469197, 5700.3444603871085, 5706.0, 5737.196792449061, 5746.482816546531, 6239.251289845157, 6281.3404592518045, 6296.811095667137, 6299.0, 6299.370062993664, 6133.723982420713, 6135.110408990671, 6137.0, 6146.446819786241, 6150.323464418911, 6140.938590614126, 6167.96916015426, 6191.938080619136, 6220.377962203744, 6238.625682459067, 6160.44555989963, 6197.504199664107, 6213.689315534205, 6232.127502149703, 6234.5635805494085, 6231.345708700521, 6231.906521402183, 6238.750449982041, 6244.718987645567, 6245.375462453719, 4828.517148285144, 4837.201861692782, 4876.463589005207, 4901.215805471107, 4914.70511769295, 4388.561143885586, 4420.646348292129, 4424.247877860771, 4425.535318791481, 4439.267520859086, 5765.88468230633, 5777.191193232867, 5791.044477661223, 5797.565182611321, 5843.503302219359, 5199.428062913076, 6197.1324014637985, 6226.6575338355915, 6253.6560489172625, 6254.906176407358, 5659.377468478464, 5729.88540229193, 5736.282964629421, 5764.827055188351, 5794.8551286217335, 5370.624056316098, 5426.620136590401, 5441.918371224435, 5472.015037293326, 5503.697296648723, 6272.0, 6281.52888533371, 6281.7173227203975, 6295.150154729053, 6308.400701933309, 6137.754489820357, 6232.875342493034, 6266.0528953811745, 6330.620162790247, 6341.207349081365, 6203.751849925952, 6229.937700622936, 6242.406971337716, 6260.436560709558, 6289.654069026247, 5633.887322253614, 5871.4715675589405, 6194.752209911733, 6199.938000620116, 6211.782587609412, 4770.570648641639, 5692.003899317686, 6280.214973128359, 6282.4974002080635, 6302.401271879165, 5852.151438041375, 5980.1328807321825, 6046.848828779316, 6061.090836374579, 6152.661603611844, 5992.370801065999, 6107.947487154961, 6130.428711073822, 6134.405972711667, 6136.764169924236, 5986.132010858489, 5997.580169388276, 6002.549808764273, 6012.5791194617705, 6016.067509536029, 5969.940300596939, 6035.849103772441, 6066.514678825595, 6112.205413296421, 6143.109249158936, 5895.0, 5940.1683764272175, 5946.881062378815, 5971.611845230046, 6000.939990600038], "value": 5660.1866701030585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.1780679685319, 513.1046324164331, 518.7276679743135, 538.5781536742999, 560.6748086110057, 29774.404511909775, 30949.916752913625, 39840.99999999996, 40983.0, 40989.38515922256, 42706.78646606763, 42866.0, 42888.9277768056, 42918.0, 42957.140857182836, 9613.855792163124, 9795.0, 9795.608175672964, 9796.118349348557, 9801.460919649417, 9655.13103820656, 9738.561764720605, 9743.366681165702, 9755.756106097333, 9774.755631109243, 9682.080202380797, 9754.90245097547, 9771.169450596672, 9774.609015639402, 9816.165625921769, 9695.272854535902, 9754.170895473893, 9756.219502439788, 9764.414135151914, 9784.070513301296, 9680.56437460316, 9755.609775608968, 9763.414195148314, 9765.316427850054, 9765.414075155513, 40535.594644053774, 40717.796411018055, 40771.59228407737, 40871.795641021905, 40926.59073409258, 3227.935441291161, 3378.0879162626197, 3823.617638236182, 3966.206758648253, 4016.879493615196, 29524.114276571738, 29673.0, 30788.0, 31140.873015873014, 31541.0, 3126.7185953264316, 3152.889648862302, 3155.794873333249, 3356.681115294043, 3361.159710072482, 488962.33113006665, 489209.0, 495025.0, 495482.0, 496053.0, 57531.0, 57989.4201057984, 58072.709636451546, 58144.709276453345, 58178.7091064542, 60625.39374606198, 60732.392676073556, 60846.0, 60856.391436085076, 60902.0, 16310.836891630932, 16541.917290413712, 16542.83457165437, 16553.337866485206, 16574.502764917073, 13008.349582520836, 13015.869841301466, 13025.283609401384, 13069.803952940714, 13090.280034598189, 13361.799573006412, 14248.715025699428, 15708.842911570739, 15709.821763367792, 15920.283587238602, 5617.522510586646, 6581.2760596334365, 6756.797296081126, 6772.762953296709, 6796.694148763218, 901.2069378946485, 966.6568368229177, 1033.8862725100232, 1070.9678709638724, 1084.8264277715684, 29378.0, 29686.257843554085, 29904.55143172854, 30296.0, 30543.541846872315, 1095.085603521053, 1107.2636696596674, 1133.489929531714, 1141.2011591885548, 1233.7964235901156, 15056.774148387783, 15402.22988850553, 15427.765778737674, 15473.690526189414, 15828.208589570475, 198100.0, 199105.0044749767, 199111.0, 201604.99197504212, 651344.0, 57132.714336428886, 57307.713461432424, 57347.42652573504, 57380.71309643425, 57394.13908791372, 1255.8430196225472, 1273.1469915156868, 1275.196626125535, 1403.1510935883848, 1416.8512306207906, 29013.7098629011, 29520.489181375106, 32197.51703724399, 32770.0, 32880.50679239861, 46965.0, 53095.0, 54456.0, 54568.90862182814, 54574.454255456934, 630364.0, 634309.0, 635438.0, 637148.0, 637817.0, 25759.227223183334, 26080.73919260783, 26436.0, 26462.353764623385, 26507.33731656724, 46375.53624463847, 46684.0, 47506.0, 47782.0, 48197.51802481931, 38124.809375952944, 39127.608723912395, 39152.0, 40545.18909621732, 40765.1846963065, 38529.0, 38680.41979370368, 38787.80606096952, 39683.00792480096, 40169.0, 37133.0, 38012.0, 38132.428013579265, 38178.0, 38248.808755956044, 31913.840430797696, 33036.0, 34186.48720269248, 34726.65273347234, 34896.30207395888, 26011.219663410127, 26061.478770424863, 26277.868610656824, 26373.07694230693, 26634.733652663224], "value": 19569.494788527674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.3517560101612, 374.32994939059085, 374.7726196705788, 382.9559600645925, 404.106923698626, 14857.62855928601, 15132.092074475526, 16596.751048734277, 20320.89839550804, 21017.579648407023, 21374.0, 21911.342659720194, 22102.0, 22277.331680049585, 22638.66042009371, 6619.801405957817, 6703.329667033282, 6858.142732158481, 6918.238993710688, 6949.305069493061, 6816.829579260509, 6841.521093523455, 6869.416099631538, 6887.0, 6894.379505844473, 4438.822447102112, 6343.873122537547, 8000.63997120131, 8054.919450805475, 8146.981627296588, 7709.0749110107145, 7862.764117076496, 7900.0, 7956.085050219241, 8152.021757389121, 7324.194338622748, 7541.886871696929, 7595.506292090997, 7635.885461718079, 7637.389008879276, 24635.630465543032, 24846.751532484624, 27196.32009199766, 28273.151805445665, 29243.707562924523, 2401.1955994741784, 2578.2048863783184, 2684.9194524164304, 3158.6051743532057, 3257.2833976525126, 16867.746983795252, 17012.744808827876, 17065.40271090506, 17370.218340174597, 18005.459836204805, 1984.186483541741, 1984.2360691134018, 1997.7103320018662, 2055.9383218503467, 2138.4012476506605, 148692.0, 151343.0, 153839.23080384528, 155499.2225038879, 156369.0, 17740.46778596644, 19701.802981969995, 19853.305134320228, 20320.0, 22016.33950981473, 35685.28629427449, 35716.464253036225, 36290.09274768152, 36413.08967275839, 36505.63494365075, 10782.137429005661, 10916.672499825017, 11089.5564177432, 11235.269707468988, 11242.943785281184, 7958.363330933512, 8946.955265223762, 9052.818943621223, 9159.496227707406, 9311.068893110634, 8084.959575202086, 9560.90439095614, 9568.138867501959, 9730.318877678636, 9748.61005559784, 3678.716777615248, 3702.426123950738, 3722.218334149805, 3726.2733766915735, 3756.4740936268945, 853.2107800284712, 923.93532452729, 951.4243882451018, 959.5298303831072, 960.851068084448, 19868.70196947047, 20825.37523874286, 20834.47913802137, 20846.791532084484, 20868.26961056356, 941.1576638908139, 958.712386284112, 969.9563519641633, 970.2480577552453, 971.7959228562081, 8848.601812918434, 10372.0, 10709.946450267855, 10844.64441944757, 10896.673099807018, 598436.0078199581, 598831.0, 604592.0, 609694.0, 612939.0, 94816.10367792606, 117793.82206178, 119469.0, 125883.0, 131711.0, 930.093159169804, 954.2461455450117, 972.1153750087386, 974.0892265731563, 976.6191185437685, 14334.784978225543, 17611.29554817844, 18008.909955450137, 18766.343177988703, 19182.520436988627, 55165.62085947883, 56657.150142747065, 58049.70975145097, 58616.70691646515, 59321.81356372762, 81438.96402589983, 81704.59147704224, 82346.0, 82760.0, 83087.58456207922, 5834.591578589458, 7431.033965584439, 7527.134379546423, 7641.197674244125, 8071.991001124859, 11079.33523988531, 13183.53857614979, 13320.134191277535, 13669.794953075512, 13680.93159534196, 10922.180836437457, 11657.009154221647, 11786.0, 11844.46699898524, 11890.821637675615, 11240.426340312526, 11418.086553075567, 11428.14288928317, 11879.930806227481, 12139.150259482105, 11455.713607159887, 11533.884661153617, 11610.535578576762, 11892.643220703392, 12068.094892883244, 7402.777916662509, 7410.888836667346, 7599.962000189964, 7634.160242373224, 7714.498557593738, 10943.179261555257, 11439.0, 11467.885321146681, 11702.2978621283, 11736.237144585575], "value": 11083.402498411973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.8580549042351, 1448.5002674077446, 1515.8029456170696, 1828.542864283929, 1877.108373522577, 8578.48529088255, 9150.359474836747, 9165.725028249155, 9166.083391660839, 9170.358074934757, 8001.159878212777, 8247.876281855762, 8248.670053197864, 8349.582520873962, 8914.153155450222, 2148.9355319340407, 2181.0512427094186, 2342.472943587696, 2415.335782659765, 2421.9636705449434, 2393.2580899920995, 2411.9035238590436, 2415.7342692303832, 2417.9758202417925, 2418.588839897213, 2406.8074554035725, 2417.226487523993, 2419.661247425362, 2421.6367544868235, 2423.8909249083745, 2368.751281115484, 2400.867952262625, 2405.0980882169188, 2406.3382569793357, 2411.397150712322, 2386.6181410974336, 2402.5675378431874, 2413.083028449178, 2419.346776370388, 2422.63660450932, 8865.778355541099, 9046.185843274072, 9063.0, 9067.637294508211, 9069.954650226773, 4728.3143944127905, 5268.5521730652945, 5436.320459942507, 5446.183072539111, 5455.618106732531, 3617.0776452004834, 3645.708343332527, 3703.870364537255, 3767.6624798196794, 3771.4719939208535, 1094.5567045346568, 1105.5798796457375, 1107.0313475708756, 1124.2579897267765, 1124.370352602537, 11940.044796416265, 12092.214006089576, 12093.516259349615, 12095.0, 12130.514779408724, 4752.405949256343, 4771.23660214364, 4785.282773478392, 4848.418189817245, 4891.608671306287, 10153.644622438327, 10153.898461015444, 10156.542955566869, 10158.984101589782, 10169.593216271414, 5376.973115134399, 5383.246345511631, 5383.892322153535, 5390.649607775482, 5393.191021346751, 4549.886252843706, 4905.3132561441425, 4921.286413470027, 4921.680090794087, 4935.457099719028, 3798.4112462568346, 3807.3908174691915, 3841.9039524011564, 3883.5533913600298, 3891.7664940103687, 1187.4003628167893, 1190.4166958190597, 1196.8144937534696, 1202.8255902894032, 1203.3802591665299, 820.1142765812908, 836.3768992100923, 878.8311545644277, 900.4687234531658, 925.6390007896925, 5575.135853942646, 5733.3406658234835, 5733.598648094593, 5763.337216220105, 6007.068904319837, 441.139777434005, 443.662816259645, 447.48092213032726, 457.3551292677309, 457.5675986193082, 3696.1868388954385, 3816.7900765458166, 3861.3242682530445, 3915.960840391617, 3975.284448799244, 10425.322354046963, 10529.789404211873, 10936.343819370704, 11029.83455248172, 11038.834417483744, 10705.0, 10974.725631859108, 10979.341239525495, 10979.39613321275, 10993.010629043265, 8054.436189466798, 8159.877601835978, 8253.793655158548, 8378.79053023667, 8383.24550790444, 5856.267966504187, 5874.353821079763, 5925.0, 6068.51451883857, 6113.419225173601, 10202.979702029737, 10289.0, 10293.691189264335, 10294.485275736033, 10314.948425257826, 8429.87355189685, 8799.648014079365, 10150.03574660406, 10232.283740138118, 10515.526801293807, 6979.616121113185, 7217.170025447141, 7556.8488630228185, 7643.770686879402, 7740.14858365568, 7419.332260096618, 7643.159252482334, 8314.750557483285, 8459.196376344238, 8634.740957771277, 7504.024476817979, 7526.774196774106, 7532.5857077859055, 7569.848603028019, 7691.461597688108, 6597.637129957899, 7423.740169094056, 7523.3229009389415, 7530.28462296081, 7561.243875612395, 6886.035954966409, 7020.333068358498, 7025.156981162293, 7027.8945815811785, 7039.612821294878, 4815.109204797123, 4886.900447399306, 4916.385451818523, 4929.0, 5015.097282489041, 4855.320255164209, 4896.4124305083615, 4924.852254432372, 5005.549500544968, 5063.721495317645], "value": 4515.1637656878165, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.8768541841591, 299.2056091078187, 302.496343587926, 307.86761692472237, 313.78819296974535, 4177.895552611186, 4197.5382707902145, 4852.932354881925, 5356.437574054727, 5388.922215556885, 4801.807927682898, 4973.676711013782, 5090.294751258323, 5327.760250788714, 5331.733413329328, 3456.0796127272415, 4104.917901641966, 4110.815013324393, 4116.259073366793, 4125.216208920303, 4025.7987100644996, 4161.771102589357, 4162.897736642991, 4170.47869016373, 4185.937210941823, 3432.8626854925774, 3938.9167978805913, 4085.44846445729, 4110.403991421242, 4110.622941314663, 3419.4186988212064, 4090.386442033689, 4098.036961314089, 4102.169503042891, 4121.196366708493, 2827.7737780977677, 3341.0979035660234, 3431.4852772084137, 3591.676749092594, 3610.458431235336, 3953.9126740146403, 4566.840160594396, 4735.242361222222, 4832.95167048332, 5204.141316682742, 4198.580141985807, 4674.610907092365, 4688.929666055012, 4706.623470122382, 4721.315409265637, 5064.442911279756, 5307.01820163271, 5639.718014099279, 5645.532161637962, 5650.6892120933335, 3231.434498962672, 3566.5006899034156, 3887.71705337238, 3941.960580394188, 3975.185087057175, 5908.881822363572, 5942.494887934531, 5945.0, 5949.375315591844, 5987.940120598825, 3366.208940898936, 3644.706129324105, 3926.9410958835642, 3954.4463775071513, 3962.5244970603712, 3477.808720520345, 3840.8847734568008, 3935.8819235422984, 3950.4074388841327, 3964.7621142731527, 3892.260470510594, 4589.426321709786, 4595.563421474954, 4598.068811099346, 4620.283856002325, 5663.980483512924, 5716.628419152742, 5736.42635736423, 5776.653400795965, 5806.187133801272, 1268.403850190409, 1288.3815768431205, 1312.5143696832233, 1313.914595551286, 1330.0, 734.9669264883094, 784.9372050235968, 799.6641410607559, 800.4116974024088, 821.1460081515157, 3983.964169315999, 4080.81636326366, 4190.769507677107, 4523.17301686446, 4543.977280113579, 4665.906681866344, 4873.756312184377, 4904.4605093439695, 4911.022072121522, 4918.3360246367, 3797.9620203798163, 4170.979145104316, 4409.582573505559, 4469.5306992765945, 4559.879655959929, 2420.1166574200643, 2528.103922058456, 2542.4915016996306, 2559.7184309725917, 2562.7437256274225, 4668.5098064702715, 4710.929336059962, 4960.082384758831, 4978.004399120118, 4996.052329125833, 5453.300616195009, 5463.7814487420055, 5934.8813023739285, 6000.579959402888, 6016.2479690038745, 5565.916511252334, 6101.034327687039, 6102.552058087166, 6105.297890742621, 6148.938510614837, 5568.443155684399, 5784.363719990882, 5795.478406943395, 5904.545840683249, 6013.939860601338, 5232.764525596282, 5256.947430525645, 5464.453554644663, 5527.972360138174, 5854.531637468907, 5561.888762224814, 5588.692621905834, 5867.0, 6071.726772295169, 6099.0, 3210.9357812843145, 3331.9167020824675, 3635.527381440396, 3657.707383409374, 3707.8331475083146, 5861.35525092248, 5864.618799778001, 5878.943528965, 5894.764209431746, 5911.733971971185, 5442.6462279951675, 5758.798442054508, 5763.279590051244, 5778.219940308173, 5782.306123265235, 4760.761961901961, 5641.746121424628, 5643.830685079454, 5653.519450846724, 5667.773289068556, 5341.732913354394, 5511.972440137773, 5524.66851988882, 5562.582806289625, 5581.665100094007, 4508.32375143731, 5058.319090881839, 5182.378114626269, 5614.9719251403485, 5629.761452480611, 4509.489321077344, 5436.510714035598, 5695.629784064023, 5715.6568206472275, 5724.398938111438], "value": 3991.9214675848657, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.4787821864287, 737.9483436159469, 753.796474951763, 755.5091270057382, 770.0797546931419, 15063.472778452757, 16199.757003644954, 16276.348946042173, 16287.674246515062, 16314.265858036388, 14411.63970900728, 14598.562043138696, 14605.269736513184, 14615.634609134777, 14656.267186640678, 678.5080816408089, 700.7302188657353, 828.9917100828975, 835.9205875441824, 856.8671855862351, 848.0967769325648, 855.7732200966749, 860.9182127697859, 862.905080441151, 864.2308345572445, 925.3799954030816, 926.8378033844084, 927.2952556057411, 927.8329900617886, 928.9210417114554, 712.5831388637653, 734.0530715377157, 918.4902379179553, 920.8434566123775, 921.7511271956567, 537.7660717587862, 665.171861033017, 671.2850813883248, 673.0946876451166, 675.0347003784586, 14873.0, 14928.402863885432, 14949.626259343495, 14953.850461495464, 14965.326560304813, 13575.0, 13927.721445571133, 13990.020698551105, 14030.750828577755, 14037.0, 11113.888861111447, 11565.479553420117, 11639.418029098511, 11975.94012029943, 12090.637280881587, 4597.218472859622, 4622.1911165546235, 4773.856784296477, 4808.639352048575, 4848.563629273347, 106653.46673266661, 107769.07055844419, 111678.44160779225, 112298.75402491905, 114637.85362146355, 10324.535395907202, 10497.16022718196, 10989.725256868642, 11044.447777611087, 11104.0, 20715.792842071387, 20735.792642073688, 20745.481362966046, 20768.68846967297, 20788.1684732612, 6848.657567121723, 7538.472306938462, 7676.080979755061, 7819.413543984224, 8082.2725954664365, 4385.210662080793, 4400.163968845909, 4491.258942274553, 4543.9548903751665, 4679.695819771704, 3610.0, 3672.7245456590863, 3755.887323380303, 3756.023433907204, 3777.0746167189213, 616.8889599872066, 681.8874885643813, 685.1880521581942, 687.7558466744334, 695.3602685529326, 637.6907200007993, 639.6354078175395, 655.0272350825436, 669.334012657409, 688.7417218543046, 8859.601317940707, 9325.673601423918, 9413.388129771543, 9413.529323533796, 9425.38734982224, 554.2268535393184, 648.9634473574359, 651.9902201466982, 689.4105539763531, 696.3837004251172, 4030.679661808396, 4375.387445757597, 4682.882927926761, 4695.624350051988, 4832.081904438145, 116592.41703791596, 167767.0, 172622.13688931725, 174677.0, 176679.0, 88481.67277490842, 120155.0, 141275.0688409244, 142139.2893035549, 143758.0, 95685.043149569, 98517.0, 110780.0, 120407.39796300963, 128877.0, 9472.95263523678, 9981.642272388985, 10166.440845753554, 10201.0, 10217.693469195936, 45533.31700024568, 50080.0, 59003.99999999828, 62003.0, 62167.067493986724, 83541.0, 93616.06383936074, 94874.10251795064, 95610.0, 98345.0, 12755.411793978601, 12777.616671499869, 13096.69462015117, 13142.934285328512, 13715.862841371458, 13771.517996870061, 14714.63213419673, 14837.258137093319, 15437.996530225499, 15476.458323959057, 14054.718905622034, 14106.858931410965, 14235.786463202852, 14505.927470362582, 14540.636484087983, 13795.862041379458, 13932.373043212878, 13942.860571394562, 14510.419583216553, 14544.709105817612, 11993.40032998364, 13180.077394582288, 13855.515056972958, 14416.711665766416, 14473.638159046108, 11023.724406889893, 11471.369074700639, 11499.540018399504, 11662.76674466489, 11679.0, 11500.367479788358, 11658.358790266617, 11767.88232117668, 11804.586839460577, 11812.232204906653], "value": 7909.284142297288, "unit": "score"}], "name": "dromaeo_css", "value": 7479.185199276185, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 113.0, 113.0, 115.0, 113.0, 112.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 136.0, 137.0, 138.0, 136.0, 137.0, 109.0, 136.0, 108.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 187.0, 186.0, 182.0, 185.0, 185.0, 186.0, 183.0, 184.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 58.0, 89.0, 61.0, 59.0, 58.0, 59.0, 83.0, 58.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 92.0, 71.0, 68.0, 69.0, 91.0, 67.0, 68.0, 89.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 134.0, 86.0, 95.0, 122.0, 87.0, 84.0, 87.0, 84.0], "value": 95.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 85.0, 86.0, 86.0, 85.0, 86.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 54.0, 57.0, 59.0, 58.0, 58.0, 57.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 82.0, 76.0, 74.0, 68.0, 70.0, 70.0, 70.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 82.0, 80.0, 79.0, 71.0, 80.0, 96.0, 105.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 146.0, 149.0, 155.0, 155.0, 143.0, 138.0, 150.0, 197.0, 136.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 163.0, 164.0, 165.0, 161.0, 162.0, 190.0, 218.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1445.1999999999998, "alertThreshold": 2.0}]} 08:07:08 INFO - Return code: 0 08:07:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:08 INFO - # TBPL SUCCESS # 08:07:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:08 INFO - 2016-11-08 08:07:08.081 screenresolution[1664:9849] starting screenresolution argv=screenresolution get 08:07:08 INFO - 2016-11-08 08:07:08.084 screenresolution[1664:9849] Display 0: 1600x1200x32@60 08:07:08 INFO - 2016-11-08 08:07:08.090 screenresolution[1665:9852] starting screenresolution argv=screenresolution list 08:07:08 INFO - Available Modes on Display 0 08:07:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:08 INFO - Intel Iris: 08:07:08 INFO - Chipset Model: Intel Iris 08:07:08 INFO - Type: GPU 08:07:08 INFO - Bus: Built-In 08:07:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:08 INFO - Vendor: Intel (0x8086) 08:07:08 INFO - Device ID: 0x0a2e 08:07:08 INFO - Revision ID: 0x0009 08:07:08 INFO - Displays: 08:07:08 INFO - Display: 08:07:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:08 INFO - Display Serial Number: 1600x1200 60 08:07:08 INFO - Main Display: Yes 08:07:08 INFO - Mirror: Off 08:07:08 INFO - Online: Yes 08:07:08 INFO - Rotation: Supported 08:07:08 INFO - Return code: 0 08:07:08 INFO - Running post-action listener: _resource_record_post_action 08:07:08 INFO - [mozharness: 2016-11-08 16:07:08.331946Z] Finished run-tests step (success) 08:07:08 INFO - Running post-run listener: _resource_record_post_run 08:07:08 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38286336; Write bytes: 664421376; Read time: 379; Write time: 2140 08:07:08 INFO - TinderboxPrint: CPU usage
53.6% 08:07:08 INFO - TinderboxPrint: I/O read bytes / time
38,286,336 / 379 08:07:08 INFO - TinderboxPrint: I/O write bytes / time
664,421,376 / 2,140 08:07:08 INFO - TinderboxPrint: CPU idle
2,246.6 (46.4%) 08:07:08 INFO - TinderboxPrint: CPU system
973.0 (20.1%) 08:07:08 INFO - TinderboxPrint: CPU user
1,618.2 (33.4%) 08:07:08 INFO - TinderboxPrint: Swap in / out
401,420,288 / 0 08:07:08 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 360829440; Write bytes: 356796416; Read time: 27414; Write time: 687 08:07:08 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36135936; Write bytes: 296221696; Read time: 353; Write time: 1415 08:07:08 INFO - Running post-run listener: _upload_blobber_files 08:07:08 INFO - Blob upload gear active. 08:07:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:08 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:07:08 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:07:08 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:07:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:10 INFO - (blobuploader) - INFO - Done attempting. 08:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:11 INFO - (blobuploader) - INFO - Done attempting. 08:07:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:13 INFO - (blobuploader) - INFO - Done attempting. 08:07:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:13 INFO - Return code: 0 08:07:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db473290adea342e5c3a44c3558b9c455f382904954fe04f6be0f30d8fa9aea8ca80a264f8cb68f0e4f5e2ac5cd8ea63c72da14f4a38ed6351ba1018237d4946", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd083fd7549f5a61e36b45a7f664bd2a7c02378b56ce0c50203633379a869ab5524aebdfc8017dae72a3b3700ce007f528fbd01b1fa5e1b9aa58e892f2c6ebdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4386d83dabbf6e05ddc263862850f7bd0e534fea700c481d831aab60ea3c18ce6f60154852a1ee26b761f053f9167f1bb3675d0af058aea56b56b19ab778847"} 08:07:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:13 INFO - Contents: 08:07:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db473290adea342e5c3a44c3558b9c455f382904954fe04f6be0f30d8fa9aea8ca80a264f8cb68f0e4f5e2ac5cd8ea63c72da14f4a38ed6351ba1018237d4946", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd083fd7549f5a61e36b45a7f664bd2a7c02378b56ce0c50203633379a869ab5524aebdfc8017dae72a3b3700ce007f528fbd01b1fa5e1b9aa58e892f2c6ebdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4386d83dabbf6e05ddc263862850f7bd0e534fea700c481d831aab60ea3c18ce6f60154852a1ee26b761f053f9167f1bb3675d0af058aea56b56b19ab778847"} 08:07:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:13 INFO - Copying logs to upload dir... 08:07:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.966032 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-08 08:07:13.996258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 08:07:13.999891) ========= 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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db473290adea342e5c3a44c3558b9c455f382904954fe04f6be0f30d8fa9aea8ca80a264f8cb68f0e4f5e2ac5cd8ea63c72da14f4a38ed6351ba1018237d4946", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd083fd7549f5a61e36b45a7f664bd2a7c02378b56ce0c50203633379a869ab5524aebdfc8017dae72a3b3700ce007f528fbd01b1fa5e1b9aa58e892f2c6ebdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4386d83dabbf6e05ddc263862850f7bd0e534fea700c481d831aab60ea3c18ce6f60154852a1ee26b761f053f9167f1bb3675d0af058aea56b56b19ab778847"} build_url:https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/XvVa7nOqSVWPp9QkrsM2mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db473290adea342e5c3a44c3558b9c455f382904954fe04f6be0f30d8fa9aea8ca80a264f8cb68f0e4f5e2ac5cd8ea63c72da14f4a38ed6351ba1018237d4946", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd083fd7549f5a61e36b45a7f664bd2a7c02378b56ce0c50203633379a869ab5524aebdfc8017dae72a3b3700ce007f528fbd01b1fa5e1b9aa58e892f2c6ebdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4386d83dabbf6e05ddc263862850f7bd0e534fea700c481d831aab60ea3c18ce6f60154852a1ee26b761f053f9167f1bb3675d0af058aea56b56b19ab778847"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 08:07:14.032373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 08:07:14.032672) ========= 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.BJzjbWCdNr/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.km0nyJB3GZ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005123 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 08:07:14.080912) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 08:07:14.081213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 08:07:14.081485) ========= ========= Total master_lag: 0.17 =========