builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0359 starttime: 1475751082.85 results: success (0) buildid: 20161006020300 builduid: 602648876c57478489985221c16fb201 revision: d7d42cef7968f3bf0539ffd631cbe8cca88665b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:22.852197) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:22.852608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:22.852962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:22.875348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:22.875626) ========= 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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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-10-06 03:51:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.31M=0.001s 2016-10-06 03:51:22 (8.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113770 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:23.010546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:23.010873) ========= 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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.020451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:23.059442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 03:51:23.059806) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d7d42cef7968f3bf0539ffd631cbe8cca88665b6 --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 d7d42cef7968f3bf0539ffd631cbe8cca88665b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ccOeTbLB8u/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.lNQ5qETXR1/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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-10-06 03:51:23,140 truncating revision to first 12 chars 2016-10-06 03:51:23,140 Setting DEBUG logging. 2016-10-06 03:51:23,141 attempt 1/10 2016-10-06 03:51:23,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d7d42cef7968?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 03:51:23,759 unpacking tar archive at: mozilla-aurora-d7d42cef7968/testing/mozharness/ program finished with exit code 0 elapsedTime=0.888850 ========= master_lag: 0.91 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 03:51:24.855697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:24.856039) ========= script_repo_revision: d7d42cef7968f3bf0539ffd631cbe8cca88665b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:24.860050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:24.860340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 03:51:24.878764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-06 03:51:24.879191) ========= /tools/buildbot/bin/python 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', '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:51:25 INFO - MultiFileLogger online at 20161006 03:51:25 in /builds/slave/test 03:51:25 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 03:51:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:51:25 INFO - {'append_to_log': False, 03:51:25 INFO - 'base_work_dir': '/builds/slave/test', 03:51:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:51:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:51:25 INFO - 'branch': 'Mozilla-Aurora', 03:51:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:51:25 INFO - 'config_files': ('talos/mac_config.py',), 03:51:25 INFO - 'default_actions': ('clobber', 03:51:25 INFO - 'read-buildbot-config', 03:51:25 INFO - 'download-and-extract', 03:51:25 INFO - 'populate-webroot', 03:51:25 INFO - 'create-virtualenv', 03:51:25 INFO - 'install', 03:51:25 INFO - 'run-tests'), 03:51:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:51:25 INFO - 'download_minidump_stackwalk': True, 03:51:25 INFO - 'download_symbols': 'ondemand', 03:51:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:51:25 INFO - 'tooltool.py': '/tools/tooltool.py', 03:51:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:51:25 INFO - '/tools/misc-python/virtualenv.py')}, 03:51:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:51:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:51:25 INFO - 'installer_path': 'installer.exe', 03:51:25 INFO - 'log_level': 'info', 03:51:25 INFO - 'log_name': 'talos', 03:51:25 INFO - 'log_to_console': True, 03:51:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:51:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:51:25 INFO - 'opt_config_files': (), 03:51:25 INFO - 'pip_index': False, 03:51:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:51:25 INFO - 'cmd': ('bash', 03:51:25 INFO - '-c', 03:51:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:51:25 INFO - 'enabled': True, 03:51:25 INFO - 'halt_on_failure': False, 03:51:25 INFO - 'name': 'check_screen_resolution'},), 03:51:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:51:25 INFO - 'cmd': ('bash', 03:51:25 INFO - '-c', 03:51:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:51:25 INFO - 'enabled': True, 03:51:25 INFO - 'halt_on_failure': False, 03:51:25 INFO - 'name': 'check_screen_resolution'},), 03:51:25 INFO - 'run_cmd_checks_enabled': True, 03:51:25 INFO - 'sps_profile': False, 03:51:25 INFO - 'sps_profile_interval': 0, 03:51:25 INFO - 'suite': 'dromaeojs', 03:51:25 INFO - 'system_bits': '32', 03:51:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:51:25 INFO - 'title': 't-yosemite-r7-0359', 03:51:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:51:25 INFO - 'use_talos_json': True, 03:51:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:51:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:51:25 INFO - 'work_dir': 'build'} 03:51:25 INFO - [mozharness: 2016-10-06 10:51:25.078406Z] Running clobber step. 03:51:25 INFO - Running pre-action listener: _resource_record_pre_action 03:51:25 INFO - Running main action method: clobber 03:51:25 INFO - rmtree: /builds/slave/test/build 03:51:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:51:26 INFO - Running post-action listener: _resource_record_post_action 03:51:26 INFO - [mozharness: 2016-10-06 10:51:26.590775Z] Finished clobber step (success) 03:51:26 INFO - [mozharness: 2016-10-06 10:51:26.591014Z] Running read-buildbot-config step. 03:51:26 INFO - Running pre-action listener: _resource_record_pre_action 03:51:26 INFO - Running main action method: read_buildbot_config 03:51:26 INFO - Using buildbot properties: 03:51:26 INFO - { 03:51:26 INFO - "project": "", 03:51:26 INFO - "product": "firefox", 03:51:26 INFO - "script_repo_revision": "production", 03:51:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:51:26 INFO - "repository": "", 03:51:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:51:26 INFO - "buildid": "20161006020300", 03:51:26 INFO - "pgo_build": "False", 03:51:26 INFO - "basedir": "/builds/slave/test", 03:51:26 INFO - "buildnumber": 35, 03:51:26 INFO - "slavename": "t-yosemite-r7-0359", 03:51:26 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:51:26 INFO - "platform": "yosemite_r7", 03:51:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:51:26 INFO - "branch": "mozilla-aurora", 03:51:26 INFO - "repo_path": "releases/mozilla-aurora", 03:51:26 INFO - "revision": "d7d42cef7968f3bf0539ffd631cbe8cca88665b6", 03:51:26 INFO - "stage_platform": "macosx64", 03:51:26 INFO - "builduid": "602648876c57478489985221c16fb201", 03:51:26 INFO - "slavebuilddir": "test" 03:51:26 INFO - } 03:51:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:51:26 INFO - Running post-action listener: _resource_record_post_action 03:51:26 INFO - [mozharness: 2016-10-06 10:51:26.596584Z] Finished read-buildbot-config step (success) 03:51:26 INFO - [mozharness: 2016-10-06 10:51:26.596741Z] Running download-and-extract step. 03:51:26 INFO - Running pre-action listener: _resource_record_pre_action 03:51:26 INFO - Running main action method: download_and_extract 03:51:26 INFO - mkdir: /builds/slave/test/build/tests 03:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:26 INFO - trying https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:51:26 INFO - Downloading https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:51:27 INFO - Downloaded 1199 bytes. 03:51:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:51:27 INFO - Using the following test package requirements: 03:51:27 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:51:27 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:51:27 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:51:27 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:51:27 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:51:27 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:51:27 INFO - u'jsshell-mac.zip'], 03:51:27 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:51:27 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:51:27 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:51:27 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:51:27 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:51:27 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:51:27 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:51:27 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:51:27 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:51:27 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:51:27 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:51:27 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:51:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:51:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:51:27 INFO - Fetch https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:51:28 INFO - Expected file size: 16434144 03:51:35 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:51:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:51:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:51:35 INFO - Fetch https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:51:35 INFO - Expected file size: 16434144 03:51:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:51:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:51:42 INFO - Fetch https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:51:42 INFO - Expected file size: 14414059 03:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:43 INFO - trying https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:51:43 INFO - Downloading https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:51:46 INFO - Downloaded 115305547 bytes. 03:51:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:51:46 INFO - mkdir: /builds/slave/test/properties 03:51:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:46 INFO - Contents: 03:51:46 INFO - build_url:https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:51:47 INFO - Running post-action listener: _resource_record_post_action 03:51:47 INFO - Running post-action listener: set_extra_try_arguments 03:51:47 INFO - [mozharness: 2016-10-06 10:51:47.551188Z] Finished download-and-extract step (success) 03:51:47 INFO - [mozharness: 2016-10-06 10:51:47.551293Z] Running populate-webroot step. 03:51:47 INFO - Running pre-action listener: _resource_record_pre_action 03:51:47 INFO - Running main action method: populate_webroot 03:51:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:51:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:51:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:51:47 INFO - '--tppagecycles', 03:51:47 INFO - '7'], 03:51:47 INFO - 'tests': ['tsvgm']}}, 03:51:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:51:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:51:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:47 INFO - 'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:47 INFO - 'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['damp', 'tps']}, 03:51:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:47 INFO - 'tests': ['damp', 'tps']}, 03:51:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['dromaeo_dom']}, 03:51:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['basic_compositor_video']}, 03:51:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:51:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['a11yr', 03:51:47 INFO - 'ts_paint', 03:51:47 INFO - 'tpaint', 03:51:47 INFO - 'sessionrestore', 03:51:47 INFO - 'sessionrestore_no_auto_restore', 03:51:47 INFO - 'tabpaint']}, 03:51:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:47 INFO - 'ts_paint', 03:51:47 INFO - 'tpaint', 03:51:47 INFO - 'sessionrestore', 03:51:47 INFO - 'sessionrestore_no_auto_restore', 03:51:47 INFO - 'tabpaint']}, 03:51:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:51:47 INFO - 'ts_paint', 03:51:47 INFO - 'tpaint', 03:51:47 INFO - 'sessionrestore', 03:51:47 INFO - 'sessionrestore_no_auto_restore', 03:51:47 INFO - 'tabpaint']}, 03:51:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:51:47 INFO - 'ts_paint', 03:51:47 INFO - 'tpaint', 03:51:47 INFO - 'sessionrestore', 03:51:47 INFO - 'sessionrestore_no_auto_restore', 03:51:47 INFO - 'tabpaint']}, 03:51:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['a11yr', 03:51:47 INFO - 'ts_paint', 03:51:47 INFO - 'tpaint', 03:51:47 INFO - 'sessionrestore', 03:51:47 INFO - 'sessionrestore_no_auto_restore', 03:51:47 INFO - 'tabpaint']}, 03:51:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['a11yr', 03:51:47 INFO - 'ts_paint', 03:51:47 INFO - 'tpaint', 03:51:47 INFO - 'sessionrestore', 03:51:47 INFO - 'sessionrestore_no_auto_restore', 03:51:47 INFO - 'tabpaint']}, 03:51:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['tsvgx', 03:51:47 INFO - 'tsvgr_opacity', 03:51:47 INFO - 'tart', 03:51:47 INFO - 'tscrollx', 03:51:47 INFO - 'cart']}, 03:51:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:47 INFO - 'tsvgr_opacity', 03:51:47 INFO - 'tart', 03:51:47 INFO - 'tscrollx', 03:51:47 INFO - 'cart']}, 03:51:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:47 INFO - 'talos_options': ['--disable-e10s'], 03:51:47 INFO - 'tests': ['tp5o']}, 03:51:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:47 INFO - 'tests': ['tp5o']}, 03:51:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:47 INFO - 'talos_options': ['--disable-e10s', 03:51:47 INFO - '--xperf_path', 03:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:47 INFO - 'tests': ['tp5n']}, 03:51:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:47 INFO - 'talos_options': ['--xperf_path', 03:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:47 INFO - 'tests': ['tp5n']}}, 03:51:47 INFO - 'talos.zip': {'path': '', 03:51:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:51:47 INFO - Running post-action listener: _resource_record_post_action 03:51:47 INFO - [mozharness: 2016-10-06 10:51:47.570016Z] Finished populate-webroot step (success) 03:51:47 INFO - [mozharness: 2016-10-06 10:51:47.570122Z] Running create-virtualenv step. 03:51:47 INFO - Running pre-action listener: _resource_record_pre_action 03:51:47 INFO - Running main action method: create_virtualenv 03:51:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:51:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:51:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:51:47 INFO - Using real prefix '/tools/python27' 03:51:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:51:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:51:51 INFO - Installing pip.................done. 03:51:51 INFO - Return code: 0 03:51:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:51 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 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:51 INFO - 'HOME': '/Users/cltbld', 03:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:51 INFO - 'LOGNAME': 'cltbld', 03:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:51 INFO - 'MOZ_NO_REMOTE': '1', 03:51:51 INFO - 'NO_EM_RESTART': '1', 03:51:51 INFO - 'PAGER': '/bin/cat', 03:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:51 INFO - 'PWD': '/builds/slave/test', 03:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:51 INFO - 'SHELL': '/bin/bash', 03:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:51:51 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:51 INFO - 'USER': 'cltbld', 03:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:51 INFO - 'XPC_FLAGS': '0x0', 03:51:51 INFO - 'XPC_SERVICE_NAME': '0', 03:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:51:51 INFO - Cleaning up... 03:51:51 INFO - Return code: 0 03:51:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:51 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 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:51 INFO - 'HOME': '/Users/cltbld', 03:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:51 INFO - 'LOGNAME': 'cltbld', 03:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:51 INFO - 'MOZ_NO_REMOTE': '1', 03:51:51 INFO - 'NO_EM_RESTART': '1', 03:51:51 INFO - 'PAGER': '/bin/cat', 03:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:51 INFO - 'PWD': '/builds/slave/test', 03:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:51 INFO - 'SHELL': '/bin/bash', 03:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:51:51 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:51 INFO - 'USER': 'cltbld', 03:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:51 INFO - 'XPC_FLAGS': '0x0', 03:51:51 INFO - 'XPC_SERVICE_NAME': '0', 03:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:51 INFO - Downloading/unpacking psutil>=3.1.1 03:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:54 INFO - Installing collected packages: psutil 03:51:54 INFO - Running setup.py install for psutil 03:51:55 INFO - building 'psutil._psutil_osx' extension 03:51:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:51:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:51:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:51:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:51:55 INFO - building 'psutil._psutil_posix' extension 03:51:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:51:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:51:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:51:55 INFO - ^ 03:51:55 INFO - 1 warning generated. 03:51:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:51:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:55 INFO - Successfully installed psutil 03:51:55 INFO - Cleaning up... 03:51:55 INFO - Return code: 0 03:51:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:55 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 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:55 INFO - 'HOME': '/Users/cltbld', 03:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:55 INFO - 'LOGNAME': 'cltbld', 03:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:55 INFO - 'MOZ_NO_REMOTE': '1', 03:51:55 INFO - 'NO_EM_RESTART': '1', 03:51:55 INFO - 'PAGER': '/bin/cat', 03:51:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:55 INFO - 'PWD': '/builds/slave/test', 03:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:55 INFO - 'SHELL': '/bin/bash', 03:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:51:55 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:55 INFO - 'USER': 'cltbld', 03:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:55 INFO - 'XPC_FLAGS': '0x0', 03:51:55 INFO - 'XPC_SERVICE_NAME': '0', 03:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:58 INFO - Installing collected packages: mozsystemmonitor 03:51:58 INFO - Running setup.py install for mozsystemmonitor 03:51:58 INFO - Successfully installed mozsystemmonitor 03:51:58 INFO - Cleaning up... 03:51:58 INFO - Return code: 0 03:51:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:51: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==2.5.1'] in /builds/slave/test/build 03:51: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==2.5.1 03:51:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:51:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:58 INFO - 'HOME': '/Users/cltbld', 03:51:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:58 INFO - 'LOGNAME': 'cltbld', 03:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:58 INFO - 'MOZ_NO_REMOTE': '1', 03:51:58 INFO - 'NO_EM_RESTART': '1', 03:51:58 INFO - 'PAGER': '/bin/cat', 03:51:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:58 INFO - 'PWD': '/builds/slave/test', 03:51:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:58 INFO - 'SHELL': '/bin/bash', 03:51:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:51:58 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:51:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:58 INFO - 'USER': 'cltbld', 03:51:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:58 INFO - 'XPC_FLAGS': '0x0', 03:51:58 INFO - 'XPC_SERVICE_NAME': '0', 03:51:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:01 INFO - warning: no files found matching '*.txt' 03:52:01 INFO - no previously-included directories found matching 'build' 03:52:01 INFO - no previously-included directories found matching 'dist' 03:52:01 INFO - no previously-included directories found matching '.git*' 03:52:01 INFO - Installing collected packages: jsonschema, functools32 03:52:02 INFO - Running setup.py install for functools32 03:52:02 INFO - warning: no files found matching '*.txt' 03:52:02 INFO - no previously-included directories found matching 'build' 03:52:02 INFO - no previously-included directories found matching 'dist' 03:52:02 INFO - no previously-included directories found matching '.git*' 03:52:02 INFO - Successfully installed jsonschema functools32 03:52:02 INFO - Cleaning up... 03:52:02 INFO - Return code: 0 03:52:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:02 INFO - 'HOME': '/Users/cltbld', 03:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:02 INFO - 'LOGNAME': 'cltbld', 03:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:02 INFO - 'MOZ_NO_REMOTE': '1', 03:52:02 INFO - 'NO_EM_RESTART': '1', 03:52:02 INFO - 'PAGER': '/bin/cat', 03:52:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:02 INFO - 'PWD': '/builds/slave/test', 03:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:02 INFO - 'SHELL': '/bin/bash', 03:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:52:02 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:02 INFO - 'USER': 'cltbld', 03:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:02 INFO - 'XPC_FLAGS': '0x0', 03:52:02 INFO - 'XPC_SERVICE_NAME': '0', 03:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:02 INFO - Cleaning up... 03:52:02 INFO - Return code: 0 03:52:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:02 INFO - 'HOME': '/Users/cltbld', 03:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:02 INFO - 'LOGNAME': 'cltbld', 03:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:02 INFO - 'MOZ_NO_REMOTE': '1', 03:52:02 INFO - 'NO_EM_RESTART': '1', 03:52:02 INFO - 'PAGER': '/bin/cat', 03:52:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:02 INFO - 'PWD': '/builds/slave/test', 03:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:02 INFO - 'SHELL': '/bin/bash', 03:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:52:02 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:02 INFO - 'USER': 'cltbld', 03:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:02 INFO - 'XPC_FLAGS': '0x0', 03:52:02 INFO - 'XPC_SERVICE_NAME': '0', 03:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:06 INFO - Downloading docopt-0.6.1.tar.gz 03:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:06 INFO - Running setup.py install for blobuploader 03:52:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:06 INFO - Running setup.py install for requests 03:52:07 INFO - Running setup.py install for docopt 03:52:07 INFO - Successfully installed blobuploader requests docopt 03:52:07 INFO - Cleaning up... 03:52:07 INFO - Return code: 0 03:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:07 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 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:52:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:07 INFO - 'HOME': '/Users/cltbld', 03:52:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:07 INFO - 'LOGNAME': 'cltbld', 03:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:07 INFO - 'MOZ_NO_REMOTE': '1', 03:52:07 INFO - 'NO_EM_RESTART': '1', 03:52:07 INFO - 'PAGER': '/bin/cat', 03:52:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:07 INFO - 'PWD': '/builds/slave/test', 03:52:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:07 INFO - 'SHELL': '/bin/bash', 03:52:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:52:07 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:52:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:07 INFO - 'USER': 'cltbld', 03:52:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:07 INFO - 'XPC_FLAGS': '0x0', 03:52:07 INFO - 'XPC_SERVICE_NAME': '0', 03:52:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:07 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-MzYUaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:07 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-JFqdEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:07 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-qBkbwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:07 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-3H759R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-nE1EWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-cpSncj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-0NeYxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-B6HA1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-DTIECZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-gNj9pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-NetJaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-KfCAf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:08 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ac11o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:09 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ObtDKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:09 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-fSVZfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:09 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-zG1azo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:09 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-tNUjUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:09 INFO - Running setup.py install for manifestparser 03:52:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:09 INFO - Running setup.py install for mozcrash 03:52:09 INFO - Running setup.py install for mozdebug 03:52:09 INFO - Running setup.py install for mozdevice 03:52:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Running setup.py install for mozfile 03:52:10 INFO - Running setup.py install for mozhttpd 03:52:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Running setup.py install for mozinfo 03:52:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Running setup.py install for mozInstall 03:52:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Running setup.py install for mozleak 03:52:10 INFO - Running setup.py install for mozlog 03:52:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:10 INFO - Running setup.py install for moznetwork 03:52:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:11 INFO - Running setup.py install for mozprocess 03:52:11 INFO - Running setup.py install for mozprofile 03:52:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:11 INFO - Running setup.py install for mozrunner 03:52:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:11 INFO - Running setup.py install for mozscreenshot 03:52:11 INFO - Running setup.py install for moztest 03:52:11 INFO - Running setup.py install for mozversion 03:52:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:12 INFO - Cleaning up... 03:52:12 INFO - Return code: 0 03:52:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:12 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 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:52:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:52:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:12 INFO - 'HOME': '/Users/cltbld', 03:52:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:12 INFO - 'LOGNAME': 'cltbld', 03:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:12 INFO - 'MOZ_NO_REMOTE': '1', 03:52:12 INFO - 'NO_EM_RESTART': '1', 03:52:12 INFO - 'PAGER': '/bin/cat', 03:52:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:12 INFO - 'PWD': '/builds/slave/test', 03:52:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:12 INFO - 'SHELL': '/bin/bash', 03:52:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:52:12 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:52:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:12 INFO - 'USER': 'cltbld', 03:52:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:12 INFO - 'XPC_FLAGS': '0x0', 03:52:12 INFO - 'XPC_SERVICE_NAME': '0', 03:52:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:12 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-_HdTSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:12 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-omMhHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:12 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-kCr_Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:12 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-jtxtE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:12 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-7YOmAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:12 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-WsXbeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-uH18f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-tkd5SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-OV5tAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ozOj0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-_xgTiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-A0AFdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-jBsHwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-CJKq9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-4mZ8AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-BMIlrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-sW_VNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:16 INFO - Downloading blessings-1.6.tar.gz 03:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:16 INFO - Installing collected packages: blessings 03:52:16 INFO - Running setup.py install for blessings 03:52:16 INFO - Successfully installed blessings 03:52:16 INFO - Cleaning up... 03:52:17 INFO - Return code: 0 03:52:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:17 INFO - Reading from file tmpfile_stdout 03:52:17 INFO - Current package versions: 03:52:17 INFO - blessings == 1.6 03:52:17 INFO - blobuploader == 1.2.4 03:52:17 INFO - docopt == 0.6.1 03:52:17 INFO - functools32 == 3.2.3-2 03:52:17 INFO - jsonschema == 2.5.1 03:52:17 INFO - manifestparser == 1.1 03:52:17 INFO - mozInstall == 1.12 03:52:17 INFO - mozcrash == 0.17 03:52:17 INFO - mozdebug == 0.1 03:52:17 INFO - mozdevice == 0.48 03:52:17 INFO - mozfile == 1.2 03:52:17 INFO - mozhttpd == 0.7 03:52:17 INFO - mozinfo == 0.9 03:52:17 INFO - mozleak == 0.1 03:52:17 INFO - mozlog == 3.4 03:52:17 INFO - moznetwork == 0.27 03:52:17 INFO - mozprocess == 0.23 03:52:17 INFO - mozprofile == 0.28 03:52:17 INFO - mozrunner == 6.12 03:52:17 INFO - mozscreenshot == 0.1 03:52:17 INFO - mozsystemmonitor == 0.3 03:52:17 INFO - moztest == 0.7 03:52:17 INFO - mozversion == 1.4 03:52:17 INFO - psutil == 3.1.1 03:52:17 INFO - requests == 1.2.3 03:52:17 INFO - wsgiref == 0.1.2 03:52:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:17 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 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:52:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:52:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:17 INFO - 'HOME': '/Users/cltbld', 03:52:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:17 INFO - 'LOGNAME': 'cltbld', 03:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:17 INFO - 'MOZ_NO_REMOTE': '1', 03:52:17 INFO - 'NO_EM_RESTART': '1', 03:52:17 INFO - 'PAGER': '/bin/cat', 03:52:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:17 INFO - 'PWD': '/builds/slave/test', 03:52:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:17 INFO - 'SHELL': '/bin/bash', 03:52:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:52:17 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:52:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:17 INFO - 'USER': 'cltbld', 03:52:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:17 INFO - 'XPC_FLAGS': '0x0', 03:52:17 INFO - 'XPC_SERVICE_NAME': '0', 03:52:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:52:17 INFO - Cleaning up... 03:52:17 INFO - Return code: 0 03:52:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10877b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb29d8d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, '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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:52:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:52:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:52:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:17 INFO - 'HOME': '/Users/cltbld', 03:52:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:17 INFO - 'LOGNAME': 'cltbld', 03:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:17 INFO - 'MOZ_NO_REMOTE': '1', 03:52:17 INFO - 'NO_EM_RESTART': '1', 03:52:17 INFO - 'PAGER': '/bin/cat', 03:52:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:17 INFO - 'PWD': '/builds/slave/test', 03:52:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:17 INFO - 'SHELL': '/bin/bash', 03:52:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:52:17 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:52:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:17 INFO - 'USER': 'cltbld', 03:52:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:17 INFO - 'XPC_FLAGS': '0x0', 03:52:17 INFO - 'XPC_SERVICE_NAME': '0', 03:52:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:52:17 INFO - Cleaning up... 03:52:17 INFO - Return code: 0 03:52:17 INFO - Running post-action listener: _resource_record_post_action 03:52:17 INFO - Running post-action listener: _start_resource_monitoring 03:52:17 INFO - Starting resource monitoring. 03:52:17 INFO - [mozharness: 2016-10-06 10:52:17.917956Z] Finished create-virtualenv step (success) 03:52:17 INFO - [mozharness: 2016-10-06 10:52:17.918969Z] Running install step. 03:52:17 INFO - Running pre-action listener: _resource_record_pre_action 03:52:17 INFO - Running main action method: install 03:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:18 INFO - Reading from file tmpfile_stdout 03:52:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:18 INFO - Reading from file tmpfile_stdout 03:52:18 INFO - Output received: 03:52:18 INFO - Usage: mozinstall [options] installer 03:52:18 INFO - Options: 03:52:18 INFO - -h, --help show this help message and exit 03:52:18 INFO - -d DEST, --destination=DEST 03:52:18 INFO - Directory to install application into. [default: 03:52:18 INFO - "/builds/slave/test"] 03:52:18 INFO - --app=APP Application being installed. [default: firefox] 03:52:18 INFO - mkdir: /builds/slave/test/build/application 03:52:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:52:50 INFO - Reading from file tmpfile_stdout 03:52:50 INFO - Output received: 03:52:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:52:50 INFO - Running post-action listener: _resource_record_post_action 03:52:50 INFO - [mozharness: 2016-10-06 10:52:50.677578Z] Finished install step (success) 03:52:50 INFO - [mozharness: 2016-10-06 10:52:50.677745Z] Running run-tests step. 03:52:50 INFO - Running pre-action listener: _resource_record_pre_action 03:52:50 INFO - Running main action method: run_tests 03:52:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:52:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:52:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:52:50 INFO - 2016-10-06 03:52:50.692 screenresolution[2239:19434] starting screenresolution argv=screenresolution get 03:52:50 INFO - 2016-10-06 03:52:50.695 screenresolution[2239:19434] Display 0: 1600x1200x32@60 03:52:50 INFO - 2016-10-06 03:52:50.702 screenresolution[2240:19436] starting screenresolution argv=screenresolution list 03:52:50 INFO - Available Modes on Display 0 03:52:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:52:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:52:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:52:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:52:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:52:50 INFO - Intel Iris: 03:52:50 INFO - Chipset Model: Intel Iris 03:52:50 INFO - Type: GPU 03:52:50 INFO - Bus: Built-In 03:52:50 INFO - VRAM (Dynamic, Max): 1536 MB 03:52:50 INFO - Vendor: Intel (0x8086) 03:52:50 INFO - Device ID: 0x0a2e 03:52:50 INFO - Revision ID: 0x0009 03:52:50 INFO - Displays: 03:52:50 INFO - Display: 03:52:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:52:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:52:50 INFO - Display Serial Number: 1600x1200 60 03:52:50 INFO - Main Display: Yes 03:52:50 INFO - Mirror: Off 03:52:50 INFO - Online: Yes 03:52:50 INFO - Rotation: Supported 03:52:50 INFO - Return code: 0 03:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:50 INFO - Python 2.7.3 03:52:50 INFO - Return code: 0 03:52:50 INFO - grabbing minidump binary from tooltool 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 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 0x10858fd30>, '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 0x1083f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108587b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:52:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:52:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:52:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:51 INFO - Return code: 0 03:52:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:52:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:52:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:51 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/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--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 03:52:51 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/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0359 --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 03:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ccOeTbLB8u/Render', 03:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:51 INFO - 'HOME': '/Users/cltbld', 03:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:51 INFO - 'LOGNAME': 'cltbld', 03:52:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:51 INFO - 'MOZ_NO_REMOTE': '1', 03:52:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:51 INFO - 'NO_EM_RESTART': '1', 03:52:51 INFO - 'PAGER': '/bin/cat', 03:52:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:51 INFO - 'PWD': '/builds/slave/test', 03:52:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:51 INFO - 'SHELL': '/bin/bash', 03:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lNQ5qETXR1/Listeners', 03:52:51 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 03:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:51 INFO - 'USER': 'cltbld', 03:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:51 INFO - 'XPC_FLAGS': '0x0', 03:52:51 INFO - 'XPC_SERVICE_NAME': '0', 03:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:51 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/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--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 03:52:51 INFO - mozversion application_buildid: 20161006020300 03:52:51 INFO - mozversion application_changeset: d7d42cef7968f3bf0539ffd631cbe8cca88665b6 03:52:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:52:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:51 INFO - mozversion application_name: Firefox 03:52:51 INFO - mozversion application_remotingname: firefox-dev 03:52:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:52:51 INFO - mozversion application_vendor: Mozilla 03:52:51 INFO - mozversion application_version: 51.0a2 03:52:51 INFO - mozversion platform_buildid: 20161006020300 03:52:51 INFO - mozversion platform_changeset: d7d42cef7968f3bf0539ffd631cbe8cca88665b6 03:52:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:52:51 INFO - mozversion platform_version: 51.0a2 03:52:51 INFO - using testdate: 1475751171 03:52:51 INFO - actual date: 1475751171 03:52:51 INFO - starting webserver on 'localhost:51696' 03:52:51 INFO - SUITE-START | Running 2 tests 03:52:51 INFO - TEST-START | dromaeo_css 03:52:51 INFO - operating with platform_type : mac_ 03:52:51 INFO - Initialising browser for dromaeo_css test... 03:52:51 INFO - TEST-INFO | started process 2250 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmpGbYCdr/profile http://localhost:51696/getInfo.html) 03:52:53 INFO - PROCESS | 2250 | __metrics Screen width/height:1600/1200 03:52:53 INFO - PROCESS | 2250 | colorDepth:24 03:52:53 INFO - PROCESS | 2250 | Browser inner width/height: 1024/689 03:52:53 INFO - PROCESS | 2250 | __metrics 03:52:53 INFO - PROCESS | 2250 | 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" 03:52:53 INFO - PROCESS | 2250 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:54 INFO - TEST-INFO | 2250: exit 0 03:52:54 INFO - Browser initialized. 03:52:54 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:54 INFO - TEST-INFO | started process 2252 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmpGbYCdr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:06 INFO - PROCESS | 2252 | RSS: Main: 219656192 03:53:06 INFO - PROCESS | 2252 | 03:53:58 INFO - PROCESS | 2252 | 1475751238051 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:56:09 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51696/tests/dromaeo/cssquery-ext.html) 03:56:11 INFO - PROCESS | 2252 | RSS: Main: 332279808 03:56:11 INFO - PROCESS | 2252 | 03:59:14 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-ext.html (next: http://localhost:51696/tests/dromaeo/cssquery-jquery.html) 03:59:15 INFO - PROCESS | 2252 | RSS: Main: 363835392 03:59:15 INFO - PROCESS | 2252 | 04:02:17 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51696/tests/dromaeo/cssquery-mootools.html) 04:02:18 INFO - PROCESS | 2252 | RSS: Main: 322850816 04:02:18 INFO - PROCESS | 2252 | 04:05:20 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51696/tests/dromaeo/cssquery-prototype.html) 04:05:20 INFO - PROCESS | 2252 | RSS: Main: 322113536 04:05:20 INFO - PROCESS | 2252 | 04:08:24 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51696/tests/dromaeo/cssquery-yui.html) 04:08:24 INFO - PROCESS | 2252 | RSS: Main: 312123392 04:08:24 INFO - PROCESS | 2252 | 04:11:27 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-yui.html (next: http://localhost:51696/tests/dromaeo/cssquery-dojo.html) 04:11:28 INFO - PROCESS | 2252 | RSS: Main: 378728448 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - PROCESS | 2252 | __start_tp_report 04:11:28 INFO - PROCESS | 2252 | _x_x_mozilla_page_load 04:11:28 INFO - PROCESS | 2252 | _x_x_mozilla_page_load_details 04:11:28 INFO - PROCESS | 2252 | |i|pagename|runs| 04:11:28 INFO - PROCESS | 2252 | |0;dojo.html;2794.5249307617705;3262.967370326297;3274.967250327497;3299.2741596848687;3337.8331083445823;5636.520895723863;5677.460641239086;5682.801101961432;5711.628744131628;5737.311522617287;5575.498205161534;5641.971790141054;5656.519195868356;5658.8019419320335;5677.716114194294;5118.360204974379;5144.717040562787;5171.224316352558;5185.325907632003;5234.42421333653;5152.510511501401;5172.818951336704;5174;5257.342832145981;5299.205119232127;5179.015986962465;5220.347456567929;5223.477652234765;5228.92156617651;5243.449437809032;5220.216967454874;5229.843104706865;5269.736513174326;5278.2082687596785;5328.147496400596;5055.115354812893;5137.357830271216;5214.556762675177;5220.712860792655;5227.47725227478;5553.527950124244;5580.441955804387;5592.161175823659;5639.492445679908;5666.036773748431;6110.236220472441;6169.7532098716;6192.473639740628;6226.439620434183;6233.719482623293;6188.164597779287;6277.591956522811;6303.275123360826;6303.936960630381;6319.33646967071;5620;5667.744951477111;5674.460926212003;5699.145128230715;5751.396103409165;5175.9741201293755;6232.844178895473;6245.718942647592;6274.498040156776;6276.340984196685;4981;6072;6083.996140636834;6098.634081955008;6121.663308518075;6097.908531372033;6104.2064531611495;6145.064304744081;6238.251409830849;6260;6097.085437184458;6123.050927106306;6131.748241976024;6132.164921701071;6132.640831002815;6162.22972128484;6167.753289868445;6220.720067596969;6232.25212974446;6259.280182778948;4883.096627123993;4883.755812209375;4886.60907127429;4897.730624815669;4914.557689807934;4360.694751367374;4371.540988196193;4423.093265880487;4431.401760762255;4455.376247325377;5600.383957764642;5636.943630563724;5671.262735844396;5677.403872593401;5694.772209111672;6247.937520624827;6249.281332646713;6255.155554000243;6263.812085637438;6280.842978925563;5687.431256874363;5707.486326230659;5721.685307308055;5722.341930678025;5726.742296596663;5278.894422111536;5318.069337865858;5342.439043900412;5344.198370244494;5352.063388906926;6212.223472065992;6261.436470717657;6263.96868015657;6265.968670156803;6282.308946016026;6269.028300613412;6281.246250449975;6287.056941458818;6293.244810622755;6293.779717709858;6221.191245138103;6222.160008398808;6235.501159907287;6249.468795152463;6290.748370065329;6062.818115456544;6118.296395914349;6122.204113465221;6126.846828829315;6130.785422510191;6137.570370074052;6158.137860699416;6184.567080304336;6191.040388739752;6200.658963756856;6049.939500604937;6062.393760624079;6077.787277445445;6094.2077529920825;6101.298350689727;4932.975335123301;6019.307779605401;6045.697715114315;6049.455549000611;6084.269887613515;5717.113847353667;5767.163761254511;5869.207656966255;5887.735051922759;5890.764369425175;5896.970515147397;5993.940060599338;6048.939510604838;6111.54163437735;6122.215193971541;5937.703114844154;5947.345791962967;5966.284045914518;5999.070144127667;5999.1901093351835 04:11:28 INFO - PROCESS | 2252 | |1;ext.html;467.3223825453094;509.4701510429154;518.3960685801039;520.6771801483081;551.8328734726056;40890.795546022266;42735.57264427359;42747.290108395704;42782.786086069565;44814.103717925624;43243.3513497297;43780.56219437805;43850.7807460963;43924.780376098075;44059.33910991329;8390.328773698106;8820.911790882074;10115.494225288743;10122.696319110439;10131.088202061814;8778.122187781202;12092.33492157931;12329.938350308235;12350.320732359716;12609.24344539326;12308.507659693601;12377.381130943462;12386.380680965916;12405.131640785148;12412.06909481788;8839.646414143426;9040.367174297802;12369.257844529357;12471.43878525464;12474.750504989941;8988.685396011173;9055.139761722627;9059.637614495412;11926.224795388272;12315.630531083993;41973.1605367894;42233.577664223274;42338;42353;42356.94107647333;3234.256121092162;3332.9833350833333;3380.6112297085906;3555.4133567961258;3873.6707379872746;29225.35908865775;30747.923822666322;30799.92200273002;31325.37349253025;32328.838355808304;3285.917852053694;3313;3340.8997730068136;3348.916277093068;3392.5759280089987;482357;484304;487700;487703;488044;63226;63509.68245158745;63652.68173659102;63808.04287935685;63879;66577.33422665809;66627;66705;66723.66638166778;66736;16916.830831691772;17171.828281717022;17174.96950182993;17175.65648687044;17210.31158753661;11857.466414011391;12036.81944770829;12976.740465190644;13178.60464186076;13275.137116087424;17367.47897563075;17956;18046.2781488739;18092.457226282968;18139.27442902269;6375.2668443128705;6492.220933488012;6541.34586541342;6541.705623246965;6558.80323590293;871.8779370887954;877.5349064995562;917.27535247154;962.2109869906749;1095.950682219302;28891.85554072216;29781.255468613457;30178;30662.693373065984;30803;1026.440589878518;1038.7403149212696;1054.599252284127;1055.3562326980536;1057.8836328003913;15028.624284392978;15501.457448989231;15601.687966240612;15850;15893.523194304189;661634;690212.5489372521;694462;699016;915444;59502.70248648729;60236.49408764728;60567;60625.69687151536;60700.69649651812;1346.4681450826868;1369.8082268482422;1397.699494608664;1398.6573289543924;1408.0003197729727;29900.622041585262;30876.38247234998;30918.845405773725;31664.683353166172;31903.36193276168;51917.740411299215;52325.29072383504;52446;52457.47542524526;52483.47516524786;396485;467446;468617;472646;474205;26000.8699956499;26272.34319142037;26540;26588.601170982838;26650.333741656614;39257;40138.79930600328;40408.79795601003;46876.062478750915;46921.53078469171;38536.80731596324;39141.60858391494;39700;40820;41151.58848411478;38876.41685374778;39243;39314.80342598269;40622.39066413947;40762.77711668655;32374.83812580922;38069.04827379338;38491.10405439816;38902.41646375363;39199.2160156801;31328.650351223292;34470.82764586161;35176.94469165929;35296.82351588226;35732.82133589315;25575.23274301774;25704.228873133838;25730.614040789776;25988.480230395664;26189.345266368495 04:11:28 INFO - PROCESS | 2252 | |2;jquery.html;355.55022896036536;371.2537799023963;376.998115009425;388.20418142807245;406.7478163538606;12308.692282692926;14996.175210363426;16253.83746162538;20181.29365472209;20711;16085.517434476955;20819;20953.790462095374;20995.160193592237;21243.468913277175;5512.407652964565;5975.850603734898;6257.061440783873;6258;6262.467690246334;5381.300430943972;6145.293291271494;6208.503319734433;6209.130721698965;6219.036049412326;5875.7062146892695;6058.363871793465;6163.352847950968;6174.043023331368;6180.351063138373;6075.726592303335;6128.877422451526;6130.019196928492;6135;6145.692715364236;5086.745662716849;5271.130263506517;5328.987492376475;5336.67979921206;5337.172738225581;24615.87692061546;25159.119430819832;25185.37036574082;25255.49489010228;25486.725663716927;2301.0910690277415;2444.083468699238;2459.225344016647;2519.017583142576;3063.6170478690165;15595.688086238326;15719.528414147593;15813.841861581352;15941.123238221893;16178.514644560682;1758.2703178181039;1816.9370918012978;1904.2287873411153;1932.6811076172414;1958.5201625601676;119227;121355;122444;123755;126334.36832815777;9696.418214907128;10412.739681507872;10922.50848711794;10925.07136893373;11113.388763617917;13626.727465450835;13629.659258518617;13631.318434078257;13639.522616708566;13646.727065458635;7990.161033091558;8730.432521886058;8748.8687669685;8851.159139881702;8875.911240887508;8869.423487473294;8900.376973611785;8919.420237684659;9083.818323633623;9085.636574537077;6445.51658625605;6581.407673309425;6606.6036037837885;6619.040239165391;6727.428168605723;1558.3299181351902;1834;1844.2346426233232;1846.4057998511844;1880.8965506896977;838.0402597725819;927.0590350793949;996.14829320931;1022.0392830739081;1077.9299345542672;21520.461988450414;22486.325410237718;22515.54968900613;22518.32445026652;22563.548729025326;825.9710910118238;905.4386280505996;940.1256831147099;944.0370821761765;1011.5903059261011;9701.690271813355;10613.73465663349;10665.573377064986;11819.409029548488;11882.940585297018;627234;632051;632649;645382;649610;86566.13433865707;102391.4880425608;110187.44906275417;128850;135651;927.8190752803139;999.5202302894651;1009.2985375164337;1062.4953147254992;1074.747434352942;16789.664206716043;18070.277188912823;18748.250069997048;19197.520061998563;19253.133608987908;55908;57056.714716426155;57561.712191438775;57995.550111247554;58782.412175879406;76317.61841190759;77350.61324693341;78652.60673696594;79633.60183199047;81143.5942820282;6570.8357291068105;6629.707207094763;6746.494012949147;7105.360517553238;7253.492255542062;9271.67549135777;12322.383880805744;12894.742105158031;13219.735605288033;13540.187588744708;11155.05182059534;11242.437878106226;11293.604723834625;11454;11631.360275184947;11298.717532061435;11314.60398886035;11336.829947550958;11695.12286578527;11814;11318.26431281964;11384.373859437479;11524.13568982313;11845.644630661094;11864;7164.283571642794;7245.420366370783;7477.40180785525;7543.170251272465;7555.997660619831;9951.751206219902;11117.055050320814;11147.275427097213;11240.662780116609;11360.261582997078 04:11:28 INFO - PROCESS | 2252 | |3;mootools.html;1507.4648499782577;1527.3814105287358;1696.6437048219873;1860.2001139510005;1875.11869421372;8335.791605209864;8813;8818.382713210078;8832.425892316995;8832.558372081403;7756.689732410697;7971;7980.204453997848;8415.990081190266;8601.91398086019;2386.53462574798;2430.44099857033;2432.927012189637;2433.2335314376005;2433.707955045388;2385.940351491218;2415.2150551070886;2422.6366045093287;2423.212455951814;2429.6841410616594;2405.398650337416;2415.9516809663883;2418.7944024757917;2419.0444774314137;2420.407000284924;2395.808335333169;2403.07481619576;2404.422938494766;2404.495056038234;2405.194259922928;2366.4675448024227;2396.8681722505257;2398.952020959571;2399.8560086394873;2400.7479214682558;7336.669849856769;8700.086490918426;8730.214280714767;8792.384533082686;8808.823823523493;5148.099082660557;5324.440933701944;5326.201069839555;5332.733363331818;5334.706591137486;3439.4152993991083;3526.806025668587;3590.120420496995;3726.962730372689;3732.869349572779;962.9037096290385;1095.9452027398677;1107.6012635451232;1127.689885281546;1129.7514546799691;11405.20163588549;11554.13343999195;11578.768424631544;11585.594504192397;11594.47824847884;4595.4025976622825;4652.860414187579;4820.493848145894;4838.516148385133;4843.660943733976;8325.666973321;9875.358101723365;9886.357386769838;9886.703398898044;9893.258005649604;5320.893582128413;5323.920141197885;5325.707086110301;5329.706866122323;5332.226827110125;4692.835750748707;4809.326694262806;4865.70805751656;4867.610591152699;4875.878103047452;3799.0882188274613;3808.638179372955;3810.6760925321105;3883.3204189266767;3893.785841778673;989.5934040327321;1168.415792103948;1187.4181650991125;1189.6431070678934;1193.7433451807904;779.980500487481;905.3119629081814;908.9955599063072;910.5947853205392;926.6293482607011;5655.293088363955;5655.377908430151;5794.420557944256;5918.526517878559;6079.3920607939735;795.5902710104301;857.8627419612832;950.292032435826;958.9041095890356;993.4188499727596;3689.3543629864666;3691.2617476504806;3691.9446208306895;3702.315071711742;3957.6438120569287;9052.411593246417;10645.935406459446;10648.78702425947;10648.89351106479;10677.626283080055;10571.04860562553;10591.046805787517;10612;10687.732806679895;10708.089812366035;8106.594670266463;8223.465474744122;8261.586920653943;8269.793255168668;8273.875891861628;5435.211894275229;5588.636738611977;5647.096464565814;5827.766889324549;5853.64878107315;9590.568424420779;9920.900790992286;9931.950340248253;10054.547545360623;10109.747256318651;8882.88963879515;9250.21373183287;10175.033371829664;10226.6420675276;10230.28388012832;6880.621565813928;6930.44556435494;7481.438892083224;7555.13115991668;7641.579713115832;8353.081161072156;8359.373047021376;8417.989841218849;8439.324854011787;8452.239298463168;6726.8654626908165;7185.964070179615;7463.589502577411;7557.168711441627;7596.278353556403;5947.464728174485;7316.4146868249345;7320.048393708784;7438.516496427715;7499.850003000019;6719.260881302955;6886.208086069965;6890.44876409876;6892.138482689664;6896.586204827727;3920;4086.9182616348103;4097.549269580284;4912.508749125059;4915.508449155056;4917.901641967069;4943;4958.876028099182;5025.447200807981;5051.494850514919 04:11:28 INFO - PROCESS | 2252 | |4;prototype.html;298.2841181165204;300.5506767382762;307.3085557495634;309.6748414165126;311.4502902377303;4392.516823149455;5551.472610102034;5556.583256255782;5573.804916827907;5585.832425027255;5170.612204084689;5319.13830159444;5332.386775520817;5334.386545547263;5376.435474275204;3486.8256587170667;3915.921681566367;4098.97950510247;4108.424820525114;4168.7081904266715;3790.3366910790637;4142.482189726285;4143.647789937859;4148.3777433385085;4165.770882601456;3527.7706949048356;3663.285659296438;3957.9208415831667;4133.1527036957505;4152.6055024772595;3389.86440542378;4102.056526998807;4122.690798190148;4132.979335103335;4135.400366946806;3598.442241452579;3598.6684926577072;3601.7118630509494;3614.7469677122613;3619.49327094207;4957.553820156168;5291.603129765283;5295.549878260353;5299.933026119777;5310.654807437504;4669.875206780906;4693.859184224479;4702.694324868872;4711.104890070876;4716.551927566876;5126.2054381570915;5689.687067211302;5750.683712395817;5754.108113242454;5759.732858771064;3140.7173354397987;3805.6384643459105;3885.339492286318;3885.669718073967;3902.453656488094;5983.222181116427;5993.3706960768495;6037.54718396122;6037.667928263943;6042.546808989299;3892;3901.5318161820765;3909.198614284065;3920.2355540669864;3927.5286965564314;3072.6927307269543;3446.5691788526433;3865.768053916774;3883.922321553553;4024.9736317239503;4382.677181094025;4682.648801339845;4683.15703173432;4692.577668009827;4750.168720473972;4828.706364476916;4850.198303679332;5591.496765291144;5764.011416061452;5839.445252700986;1106.970517418792;1320.9075364724376;1336.5990202939079;1364.2905689041643;1365.2388418939456;709.4749885085104;772.6523064620943;800.7117437722416;803.2650125135435;806.9152738962324;4005.819738111792;4018.477597912253;4503.347014682919;4549.476810166807;4578.886357277017;4279.726009602657;4922.360093187935;4935.90128197434;4983.875403114878;4999.800007999712;3844.6026385481023;3917.3144699678014;3960.88117356474;4363.52001279859;4530.478994915561;2326.964500797163;2489.5020995800915;2609.543329917257;2614.7382514125143;2632.8551929644054;4156.3374650139585;5065.468125846733;5132.230165475134;5159.406668233126;5249.632525723239;4763.476017638057;4932.608252192943;5032.496750324938;5071.54356107952;5102.515261050195;4446.487734430037;5016.6322035421745;5062.506870259509;5064.772085256172;5146.948530514647;4257.680673949404;4707.929381059218;4904.841869577374;4907.435644900882;4994.625403094709;4210.9868740884785;4239.59723826236;4613.746243956614;4895.314655948099;4899.485554016919;4844.346013288302;4954.950450495593;5068.873278168076;5130.640855140105;5138.820141295037;3033.529802880557;3121.8282994435526;3361.7478689097925;3411.6247212806074;3412.641672624438;3757.210985693035;4548.52038190791;4628.652851036119;4725.574698277172;5011.874703132451;3885.7668539887695;4313.956860431355;4338.9132217354845;4776.47458779527;4857.546938795886;4139.855105071308;4681.545998911366;4814.518548145157;4845.3350657139135;4867.561919427127;4435.8891027723275;4663.813447462064;4675.742834144155;4678.391809064936;5304.389995150453;4814.566688998007;5223.399309079505;5340.225667278145;5408.053590621704;5683.261176047087;5538.97230513861;5576.442355764391;5579.74891129892;5580.888382232251;5592.7762889483965 04:11:28 INFO - PROCESS | 2252 | |5;yui.html;695.6973716433351;705.5519744961945;742.1650643026593;778.256764789626;791.8020494876281;15092.849071509281;16305.75541366879;16319.59201019975;16333;16359.918200408982;14545.927270363632;14630.414783408678;14680.339384727686;14708.117512949231;14737.189454579993;653.8103949854536;674.6997586074199;803.5620586780219;808.3856269235393;836.2264904962915;823.2056065896409;829.838181554594;833.1918039501704;835.3859912963967;839.0351096239312;886.3839631456141;889.2485849457198;890.7862113092843;891.1667590802588;893.0890491698464;881.9901213110952;883.4346018548166;884.4207044385937;885.1237275097607;885.4864178776294;517.4282417928173;533.2853975672617;631.2015300644642;653.3694984340087;662.8707402056601;15146.5456036318;15174.317155728018;15176.46882359123;15182;15190.848091519054;13761.862381376259;14054;14182.00725949184;14219.146851188962;14283.143011419348;10753.301035432673;12297.44661490235;12614.621561353175;12897.161684490478;13323.40044697991;4483.977580112111;4497.887552811173;4703.6942598730975;4707.058588282323;4766.356541866839;117305;118921;119630;119896;120504.39747801205;10782.568697252022;11164.60923867677;11212.719682007852;11252.099832013419;11297.887021129683;22576.0969561219;22609.75646339467;22699.092036318692;22741.43146421353;23148.884255578614;8048.557329346942;8099.797505062303;8125.06561745395;8145.95927020373;8197.46716463428;4135.793210339471;4278.700490965664;4379.802908869108;4498.122866041091;4554.339620754972;3493.179102910814;3639.5996440391536;3640.690541304019;3642.8724994625063;3650.178709790329;642.2581917884851;642.3223499208286;644.4039263681076;664.5248647217167;675.6790524500823;561.1498579651831;575.7840809696364;622.9283632382244;625.1591609285504;645.0968643898486;8842.513661748666;8891.822163556693;9193.402428842104;9323.160915517636;9349.485778282124;581.3285655068403;594.1651978969554;618.5051958433236;618.9969050154721;633.9714712837841;3774.9622503774613;4290.914181716348;4512.210363186429;4558.6581006423985;4593.954060459419;86678.56660716783;99768.00231997587;145566;159689;170969;102792;122428;123452;125365;128581.3570932158;86855.99999999873;107637.38543921847;109847;112635.43682281536;112974;9660.71017869465;10137.695869123938;10145.442000690033;10145.695629131138;10148.695539133838;48058.03883922372;48098;59314.11028834657;60127.79744405175;63433.365666344595;54930.45069549253;86254;89548;89700.10299896917;91224;12623.873761262637;12671.429785659482;12836.223392126265;12935;13246.940244780202;13837.654058648613;14276.500322488662;14534.563963081124;15017.849821501644;15606.531804045897;12725.490980360682;13537.187768733907;13794.65513362174;13830.930845345709;13960.2321872298;13384.732305354033;13859;14107.435702572193;14412.783808243095;14437.118340049205;12236.938815305866;12432.937835310766;12894.871051289367;13158.934205329295;13354.666133346744;8650.221480066824;11208.495617697386;11533.88466115328;11680.649580512598;11960.700982475508;11166.274192177483;11393.742462148562;11471.13966452536;11581.884181158417;11684.415779211175 04:11:28 INFO - PROCESS | 2252 | __end_tp_report 04:11:28 INFO - PROCESS | 2252 | __start_cc_report 04:11:28 INFO - PROCESS | 2252 | _x_x_mozilla_cycle_collect,1956 04:11:28 INFO - PROCESS | 2252 | __end_cc_report 04:11:28 INFO - PROCESS | 2252 | __startTimestamp1475752288175__endTimestamp 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - PROCESS | 2252 | ------- Summary: start ------- 04:11:28 INFO - PROCESS | 2252 | Number of tests: 6 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - PROCESS | 2252 | [#0] dojo.html Cycles:165 Average:5690.73 Median:5890.76 stddev:654.08 (11.1%) stddev-sans-first:615.36 04:11:28 INFO - PROCESS | 2252 | Values: 2794.5 3263.0 3275.0 3299.3 3337.8 5636.5 5677.5 5682.8 5711.6 5737.3 5575.5 5642.0 5656.5 5658.8 5677.7 5118.4 5144.7 5171.2 5185.3 5234.4 5152.5 5172.8 5174.0 5257.3 5299.2 5179.0 5220.3 5223.5 5228.9 5243.4 5220.2 5229.8 5269.7 5278.2 5328.1 5055.1 5137.4 5214.6 5220.7 5227.5 5553.5 5580.4 5592.2 5639.5 5666.0 6110.2 6169.8 6192.5 6226.4 6233.7 6188.2 6277.6 6303.3 6303.9 6319.3 5620.0 5667.7 5674.5 5699.1 5751.4 5176.0 6232.8 6245.7 6274.5 6276.3 4981.0 6072.0 6084.0 6098.6 6121.7 6097.9 6104.2 6145.1 6238.3 6260.0 6097.1 6123.1 6131.7 6132.2 6132.6 6162.2 6167.8 6220.7 6232.3 6259.3 4883.1 4883.8 4886.6 4897.7 4914.6 4360.7 4371.5 4423.1 4431.4 4455.4 5600.4 5636.9 5671.3 5677.4 5694.8 6247.9 6249.3 6255.2 6263.8 6280.8 5687.4 5707.5 5721.7 5722.3 5726.7 5278.9 5318.1 5342.4 5344.2 5352.1 6212.2 6261.4 6264.0 6266.0 6282.3 6269.0 6281.2 6287.1 6293.2 6293.8 6221.2 6222.2 6235.5 6249.5 6290.7 6062.8 6118.3 6122.2 6126.8 6130.8 6137.6 6158.1 6184.6 6191.0 6200.7 6049.9 6062.4 6077.8 6094.2 6101.3 4933.0 6019.3 6045.7 6049.5 6084.3 5717.1 5767.2 5869.2 5887.7 5890.8 5897.0 5993.9 6048.9 6111.5 6122.2 5937.7 5947.3 5966.3 5999.1 5999.2 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - PROCESS | 2252 | [#1] ext.html Cycles:180 Average:69987.58 Median:21205.24 stddev:153825.86 (725.4%) stddev-sans-first:154168.83 04:11:28 INFO - PROCESS | 2252 | Values: 467.3 509.5 518.4 520.7 551.8 40890.8 42735.6 42747.3 42782.8 44814.1 43243.4 43780.6 43850.8 43924.8 44059.3 8390.3 8820.9 10115.5 10122.7 10131.1 8778.1 12092.3 12329.9 12350.3 12609.2 12308.5 12377.4 12386.4 12405.1 12412.1 8839.6 9040.4 12369.3 12471.4 12474.8 8988.7 9055.1 9059.6 11926.2 12315.6 41973.2 42233.6 42338.0 42353.0 42356.9 3234.3 3333.0 3380.6 3555.4 3873.7 29225.4 30747.9 30799.9 31325.4 32328.8 3285.9 3313.0 3340.9 3348.9 3392.6 482357.0 484304.0 487700.0 487703.0 488044.0 63226.0 63509.7 63652.7 63808.0 63879.0 66577.3 66627.0 66705.0 66723.7 66736.0 16916.8 17171.8 17175.0 17175.7 17210.3 11857.5 12036.8 12976.7 13178.6 13275.1 17367.5 17956.0 18046.3 18092.5 18139.3 6375.3 6492.2 6541.3 6541.7 6558.8 871.9 877.5 917.3 962.2 1096.0 28891.9 29781.3 30178.0 30662.7 30803.0 1026.4 1038.7 1054.6 1055.4 1057.9 15028.6 15501.5 15601.7 15850.0 15893.5 661634.0 690212.5 694462.0 699016.0 915444.0 59502.7 60236.5 60567.0 60625.7 60700.7 1346.5 1369.8 1397.7 1398.7 1408.0 29900.6 30876.4 30918.8 31664.7 31903.4 51917.7 52325.3 52446.0 52457.5 52483.5 396485.0 467446.0 468617.0 472646.0 474205.0 26000.9 26272.3 26540.0 26588.6 26650.3 39257.0 40138.8 40408.8 46876.1 46921.5 38536.8 39141.6 39700.0 40820.0 41151.6 38876.4 39243.0 39314.8 40622.4 40762.8 32374.8 38069.0 38491.1 38902.4 39199.2 31328.7 34470.8 35176.9 35296.8 35732.8 25575.2 25704.2 25730.6 25988.5 26189.3 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - PROCESS | 2252 | [#2] jquery.html Cycles:180 Average:36051.02 Median:25172.24 stddev:105848.50 (420.5%) stddev-sans-first:106111.50 04:11:28 INFO - PROCESS | 2252 | Values: 355.6 371.3 377.0 388.2 406.7 12308.7 14996.2 16253.8 20181.3 20711.0 16085.5 20819.0 20953.8 20995.2 21243.5 5512.4 5975.9 6257.1 6258.0 6262.5 5381.3 6145.3 6208.5 6209.1 6219.0 5875.7 6058.4 6163.4 6174.0 6180.4 6075.7 6128.9 6130.0 6135.0 6145.7 5086.7 5271.1 5329.0 5336.7 5337.2 24615.9 25159.1 25185.4 25255.5 25486.7 2301.1 2444.1 2459.2 2519.0 3063.6 15595.7 15719.5 15813.8 15941.1 16178.5 1758.3 1816.9 1904.2 1932.7 1958.5 119227.0 121355.0 122444.0 123755.0 126334.4 9696.4 10412.7 10922.5 10925.1 11113.4 13626.7 13629.7 13631.3 13639.5 13646.7 7990.2 8730.4 8748.9 8851.2 8875.9 8869.4 8900.4 8919.4 9083.8 9085.6 6445.5 6581.4 6606.6 6619.0 6727.4 1558.3 1834.0 1844.2 1846.4 1880.9 838.0 927.1 996.1 1022.0 1077.9 21520.5 22486.3 22515.5 22518.3 22563.5 826.0 905.4 940.1 944.0 1011.6 9701.7 10613.7 10665.6 11819.4 11882.9 627234.0 632051.0 632649.0 645382.0 649610.0 86566.1 102391.5 110187.4 128850.0 135651.0 927.8 999.5 1009.3 1062.5 1074.7 16789.7 18070.3 18748.3 19197.5 19253.1 55908.0 57056.7 57561.7 57995.6 58782.4 76317.6 77350.6 78652.6 79633.6 81143.6 6570.8 6629.7 6746.5 7105.4 7253.5 9271.7 12322.4 12894.7 13219.7 13540.2 11155.1 11242.4 11293.6 11454.0 11631.4 11298.7 11314.6 11336.8 11695.1 11814.0 11318.3 11384.4 11524.1 11845.6 11864.0 7164.3 7245.4 7477.4 7543.2 7556.0 9951.8 11117.1 11147.3 11240.7 11360.3 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - PROCESS | 2252 | [#3] mootools.html Cycles:180 Average:5619.76 Median:5038.47 stddev:3129.98 (62.1%) stddev-sans-first:3123.50 04:11:28 INFO - PROCESS | 2252 | Values: 1507.5 1527.4 1696.6 1860.2 1875.1 8335.8 8813.0 8818.4 8832.4 8832.6 7756.7 7971.0 7980.2 8416.0 8601.9 2386.5 2430.4 2432.9 2433.2 2433.7 2385.9 2415.2 2422.6 2423.2 2429.7 2405.4 2416.0 2418.8 2419.0 2420.4 2395.8 2403.1 2404.4 2404.5 2405.2 2366.5 2396.9 2399.0 2399.9 2400.7 7336.7 8700.1 8730.2 8792.4 8808.8 5148.1 5324.4 5326.2 5332.7 5334.7 3439.4 3526.8 3590.1 3727.0 3732.9 962.9 1095.9 1107.6 1127.7 1129.8 11405.2 11554.1 11578.8 11585.6 11594.5 4595.4 4652.9 4820.5 4838.5 4843.7 8325.7 9875.4 9886.4 9886.7 9893.3 5320.9 5323.9 5325.7 5329.7 5332.2 4692.8 4809.3 4865.7 4867.6 4875.9 3799.1 3808.6 3810.7 3883.3 3893.8 989.6 1168.4 1187.4 1189.6 1193.7 780.0 905.3 909.0 910.6 926.6 5655.3 5655.4 5794.4 5918.5 6079.4 795.6 857.9 950.3 958.9 993.4 3689.4 3691.3 3691.9 3702.3 3957.6 9052.4 10645.9 10648.8 10648.9 10677.6 10571.0 10591.0 10612.0 10687.7 10708.1 8106.6 8223.5 8261.6 8269.8 8273.9 5435.2 5588.6 5647.1 5827.8 5853.6 9590.6 9920.9 9932.0 10054.5 10109.7 8882.9 9250.2 10175.0 10226.6 10230.3 6880.6 6930.4 7481.4 7555.1 7641.6 8353.1 8359.4 8418.0 8439.3 8452.2 6726.9 7186.0 7463.6 7557.2 7596.3 5947.5 7316.4 7320.0 7438.5 7499.9 6719.3 6886.2 6890.4 6892.1 6896.6 3920.0 4086.9 4097.5 4912.5 4915.5 4917.9 4943.0 4958.9 5025.4 5051.5 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - PROCESS | 2252 | [#4] prototype.html Cycles:180 Average:4249.18 Median:4679.97 stddev:1294.21 (27.7%) stddev-sans-first:1263.41 04:11:28 INFO - PROCESS | 2252 | Values: 298.3 300.6 307.3 309.7 311.5 4392.5 5551.5 5556.6 5573.8 5585.8 5170.6 5319.1 5332.4 5334.4 5376.4 3486.8 3915.9 4099.0 4108.4 4168.7 3790.3 4142.5 4143.6 4148.4 4165.8 3527.8 3663.3 3957.9 4133.2 4152.6 3389.9 4102.1 4122.7 4133.0 4135.4 3598.4 3598.7 3601.7 3614.7 3619.5 4957.6 5291.6 5295.5 5299.9 5310.7 4669.9 4693.9 4702.7 4711.1 4716.6 5126.2 5689.7 5750.7 5754.1 5759.7 3140.7 3805.6 3885.3 3885.7 3902.5 5983.2 5993.4 6037.5 6037.7 6042.5 3892.0 3901.5 3909.2 3920.2 3927.5 3072.7 3446.6 3865.8 3883.9 4025.0 4382.7 4682.6 4683.2 4692.6 4750.2 4828.7 4850.2 5591.5 5764.0 5839.4 1107.0 1320.9 1336.6 1364.3 1365.2 709.5 772.7 800.7 803.3 806.9 4005.8 4018.5 4503.3 4549.5 4578.9 4279.7 4922.4 4935.9 4983.9 4999.8 3844.6 3917.3 3960.9 4363.5 4530.5 2327.0 2489.5 2609.5 2614.7 2632.9 4156.3 5065.5 5132.2 5159.4 5249.6 4763.5 4932.6 5032.5 5071.5 5102.5 4446.5 5016.6 5062.5 5064.8 5146.9 4257.7 4707.9 4904.8 4907.4 4994.6 4211.0 4239.6 4613.7 4895.3 4899.5 4844.3 4955.0 5068.9 5130.6 5138.8 3033.5 3121.8 3361.7 3411.6 3412.6 3757.2 4548.5 4628.7 4725.6 5011.9 3885.8 4314.0 4338.9 4776.5 4857.5 4139.9 4681.5 4814.5 4845.3 4867.6 4435.9 4663.8 4675.7 4678.4 5304.4 4814.6 5223.4 5340.2 5408.1 5683.3 5539.0 5576.4 5579.7 5580.9 5592.8 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - PROCESS | 2252 | [#5] yui.html Cycles:180 Average:23998.93 Median:3566.39 stddev:37904.47 (1062.8%) stddev-sans-first:37970.42 04:11:28 INFO - PROCESS | 2252 | Values: 695.7 705.6 742.2 778.3 791.8 15092.8 16305.8 16319.6 16333.0 16359.9 14545.9 14630.4 14680.3 14708.1 14737.2 653.8 674.7 803.6 808.4 836.2 823.2 829.8 833.2 835.4 839.0 886.4 889.2 890.8 891.2 893.1 882.0 883.4 884.4 885.1 885.5 517.4 533.3 631.2 653.4 662.9 15146.5 15174.3 15176.5 15182.0 15190.8 13761.9 14054.0 14182.0 14219.1 14283.1 10753.3 12297.4 12614.6 12897.2 13323.4 4484.0 4497.9 4703.7 4707.1 4766.4 117305.0 118921.0 119630.0 119896.0 120504.4 10782.6 11164.6 11212.7 11252.1 11297.9 22576.1 22609.8 22699.1 22741.4 23148.9 8048.6 8099.8 8125.1 8146.0 8197.5 4135.8 4278.7 4379.8 4498.1 4554.3 3493.2 3639.6 3640.7 3642.9 3650.2 642.3 642.3 644.4 664.5 675.7 561.1 575.8 622.9 625.2 645.1 8842.5 8891.8 9193.4 9323.2 9349.5 581.3 594.2 618.5 619.0 634.0 3775.0 4290.9 4512.2 4558.7 4594.0 86678.6 99768.0 145566.0 159689.0 170969.0 102792.0 122428.0 123452.0 125365.0 128581.4 86856.0 107637.4 109847.0 112635.4 112974.0 9660.7 10137.7 10145.4 10145.7 10148.7 48058.0 48098.0 59314.1 60127.8 63433.4 54930.5 86254.0 89548.0 89700.1 91224.0 12623.9 12671.4 12836.2 12935.0 13246.9 13837.7 14276.5 14534.6 15017.8 15606.5 12725.5 13537.2 13794.7 13830.9 13960.2 13384.7 13859.0 14107.4 14412.8 14437.1 12236.9 12432.9 12894.9 13158.9 13354.7 8650.2 11208.5 11533.9 11680.6 11960.7 11166.3 11393.7 11471.1 11581.9 11684.4 04:11:28 INFO - PROCESS | 2252 | -------- Summary: end -------- 04:11:28 INFO - PROCESS | 2252 | 04:11:28 INFO - TEST-INFO | 2252: exit 0 04:11:28 INFO - TEST-OK | dromaeo_css | took 1117516ms 04:11:28 INFO - TEST-START | kraken 04:11:28 INFO - operating with platform_type : mac_ 04:11:28 INFO - Initialising browser for kraken test... 04:11:28 INFO - TEST-INFO | started process 2254 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmp7Us5m2/profile http://localhost:51696/getInfo.html) 04:11:31 INFO - PROCESS | 2254 | __metrics Screen width/height:1600/1200 04:11:31 INFO - PROCESS | 2254 | colorDepth:24 04:11:31 INFO - PROCESS | 2254 | Browser inner width/height: 1024/689 04:11:31 INFO - PROCESS | 2254 | __metrics 04:11:31 INFO - PROCESS | 2254 | 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" 04:11:31 INFO - PROCESS | 2254 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:11:32 INFO - TEST-INFO | 2254: exit 0 04:11:32 INFO - Browser initialized. 04:11:32 INFO - Running cycle 1/1 for kraken test... 04:11:32 INFO - TEST-INFO | started process 2255 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmp7Us5m2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:44 INFO - PROCESS | 2255 | RSS: Main: 219938816 04:11:44 INFO - PROCESS | 2255 | 04:11:47 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51696/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:48 INFO - PROCESS | 2255 | RSS: Main: 270090240 04:11:48 INFO - PROCESS | 2255 | 04:11:50 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51696/tests/kraken/driver.html?testName=audio-dft) 04:11:51 INFO - PROCESS | 2255 | RSS: Main: 279863296 04:11:51 INFO - PROCESS | 2255 | 04:11:54 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51696/tests/kraken/driver.html?testName=audio-fft) 04:11:55 INFO - PROCESS | 2255 | RSS: Main: 376111104 04:11:55 INFO - PROCESS | 2255 | 04:11:57 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51696/tests/kraken/driver.html?testName=audio-oscillator) 04:11:57 INFO - PROCESS | 2255 | RSS: Main: 279040000 04:11:57 INFO - PROCESS | 2255 | 04:11:59 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51696/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:00 INFO - PROCESS | 2255 | RSS: Main: 279744512 04:12:00 INFO - PROCESS | 2255 | 04:12:03 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51696/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:03 INFO - PROCESS | 2255 | RSS: Main: 318099456 04:12:03 INFO - PROCESS | 2255 | 04:12:06 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51696/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:07 INFO - PROCESS | 2255 | RSS: Main: 319213568 04:12:07 INFO - PROCESS | 2255 | 04:12:10 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51696/tests/kraken/driver.html?testName=json-parse-financial) 04:12:10 INFO - PROCESS | 2255 | RSS: Main: 316133376 04:12:10 INFO - PROCESS | 2255 | 04:12:12 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51696/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:12 INFO - PROCESS | 2255 | RSS: Main: 295661568 04:12:12 INFO - PROCESS | 2255 | 04:12:14 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:15 INFO - PROCESS | 2255 | RSS: Main: 296247296 04:12:15 INFO - PROCESS | 2255 | 04:12:17 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:18 INFO - PROCESS | 2255 | RSS: Main: 305479680 04:12:18 INFO - PROCESS | 2255 | 04:12:21 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:21 INFO - PROCESS | 2255 | RSS: Main: 311033856 04:12:21 INFO - PROCESS | 2255 | 04:12:24 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:25 INFO - PROCESS | 2255 | RSS: Main: 310849536 04:12:25 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51696/tests/kraken/driver.html?testName=ai-astar) 04:12:27 INFO - PROCESS | 2255 | RSS: Main: 354693120 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | __start_tp_report 04:12:27 INFO - PROCESS | 2255 | _x_x_mozilla_page_load 04:12:27 INFO - PROCESS | 2255 | _x_x_mozilla_page_load_details 04:12:27 INFO - PROCESS | 2255 | |i|pagename|runs| 04:12:27 INFO - PROCESS | 2255 | |0;ai-astar;116;113;114;118;165;161;113;115;162;167 04:12:27 INFO - PROCESS | 2255 | |1;audio-beat-detection;146;110;108;142;110;131;141;107;139;107 04:12:27 INFO - PROCESS | 2255 | |2;audio-dft;183;184;183;186;183;183;184;186;182;187 04:12:27 INFO - PROCESS | 2255 | |3;audio-fft;82;58;59;91;63;60;58;58;83;58 04:12:27 INFO - PROCESS | 2255 | |4;audio-oscillator;85;69;93;69;67;70;92;67;68;90 04:12:27 INFO - PROCESS | 2255 | |5;imaging-gaussian-blur;89;85;87;85;89;85;89;101;135;85 04:12:27 INFO - PROCESS | 2255 | |6;imaging-darkroom;96;96;97;97;96;96;97;97;95;97 04:12:27 INFO - PROCESS | 2255 | |7;imaging-desaturate;94;131;131;86;85;84;84;84;84;85 04:12:27 INFO - PROCESS | 2255 | |8;json-parse-financial;55;53;55;54;56;57;57;56;57;56 04:12:27 INFO - PROCESS | 2255 | |9;json-stringify-tinderbox;65;72;82;74;72;69;70;70;71;74 04:12:27 INFO - PROCESS | 2255 | |10;stanford-crypto-aes;83;83;86;83;83;85;85;84;83;89 04:12:27 INFO - PROCESS | 2255 | |11;stanford-crypto-ccm;138;135;137;138;136;135;135;135;198;147 04:12:27 INFO - PROCESS | 2255 | |12;stanford-crypto-pbkdf2;163;165;164;165;165;162;212;231;151;211 04:12:27 INFO - PROCESS | 2255 | |13;stanford-crypto-sha256-iterative;66;64;65;59;64;87;84;87;78;66 04:12:27 INFO - PROCESS | 2255 | __end_tp_report 04:12:27 INFO - PROCESS | 2255 | __start_cc_report 04:12:27 INFO - PROCESS | 2255 | _x_x_mozilla_cycle_collect,1968 04:12:27 INFO - PROCESS | 2255 | __end_cc_report 04:12:27 INFO - PROCESS | 2255 | __startTimestamp1475752347438__endTimestamp 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | ------- Summary: start ------- 04:12:27 INFO - PROCESS | 2255 | Number of tests: 14 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#0] ai-astar Cycles:10 Average:134.40 Median:139.50 stddev:25.35 (18.2%) stddev-sans-first:26.00 04:12:27 INFO - PROCESS | 2255 | Values: 116.0 113.0 114.0 118.0 165.0 161.0 113.0 115.0 162.0 167.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:135.00 stddev:16.99 (12.6%) stddev-sans-first:16.06 04:12:27 INFO - PROCESS | 2255 | Values: 146.0 110.0 108.0 142.0 110.0 131.0 141.0 107.0 139.0 107.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.00 stddev:1.66 (0.9%) stddev-sans-first:1.72 04:12:27 INFO - PROCESS | 2255 | Values: 183.0 184.0 183.0 186.0 183.0 183.0 184.0 186.0 182.0 187.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.50 stddev:12.95 (21.1%) stddev-sans-first:12.55 04:12:27 INFO - PROCESS | 2255 | Values: 82.0 58.0 59.0 91.0 63.0 60.0 58.0 58.0 83.0 58.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.50 stddev:11.41 (14.7%) stddev-sans-first:11.73 04:12:27 INFO - PROCESS | 2255 | Values: 85.0 69.0 93.0 69.0 67.0 70.0 92.0 67.0 68.0 90.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#5] imaging-gaussian-blur Cycles:10 Average:93.00 Median:86.00 stddev:15.52 (18.0%) stddev-sans-first:16.39 04:12:27 INFO - PROCESS | 2255 | Values: 89.0 85.0 87.0 85.0 89.0 85.0 89.0 101.0 135.0 85.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:12:27 INFO - PROCESS | 2255 | Values: 96.0 96.0 97.0 97.0 96.0 96.0 97.0 97.0 95.0 97.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:84.50 stddev:19.31 (22.9%) stddev-sans-first:20.48 04:12:27 INFO - PROCESS | 2255 | Values: 94.0 131.0 131.0 86.0 85.0 84.0 84.0 84.0 84.0 85.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:1.41 04:12:27 INFO - PROCESS | 2255 | Values: 55.0 53.0 55.0 54.0 56.0 57.0 57.0 56.0 57.0 56.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:4.41 (6.1%) stddev-sans-first:3.91 04:12:27 INFO - PROCESS | 2255 | Values: 65.0 72.0 82.0 74.0 72.0 69.0 70.0 70.0 71.0 74.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.96 (2.3%) stddev-sans-first:2.01 04:12:27 INFO - PROCESS | 2255 | Values: 83.0 83.0 86.0 83.0 83.0 85.0 85.0 84.0 83.0 89.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:137.50 stddev:19.52 (14.2%) stddev-sans-first:20.61 04:12:27 INFO - PROCESS | 2255 | Values: 138.0 135.0 137.0 138.0 136.0 135.0 135.0 135.0 198.0 147.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:165.00 stddev:27.81 (16.9%) stddev-sans-first:28.89 04:12:27 INFO - PROCESS | 2255 | Values: 163.0 165.0 164.0 165.0 165.0 162.0 212.0 231.0 151.0 211.0 04:12:27 INFO - PROCESS | 2255 | 04:12:27 INFO - PROCESS | 2255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:10.79 (15.0%) stddev-sans-first:11.22 04:12:27 INFO - PROCESS | 2255 | Values: 66.0 64.0 65.0 59.0 64.0 87.0 84.0 87.0 78.0 66.0 04:12:27 INFO - PROCESS | 2255 | -------- Summary: end -------- 04:12:27 INFO - PROCESS | 2255 | 04:12:28 INFO - TEST-INFO | 2255: exit 0 04:12:28 INFO - TEST-OK | kraken | took 59487ms 04:12:28 INFO - SUITE-END | took 1177s 04:12:28 INFO - Completed test suite (00:19:37) 04:12:28 INFO - javascript benchmark 04:12:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2794.5249307617705, 3262.967370326297, 3274.967250327497, 3299.2741596848687, 3337.8331083445823, 5636.520895723863, 5677.460641239086, 5682.801101961432, 5711.628744131628, 5737.311522617287, 5575.498205161534, 5641.971790141054, 5656.519195868356, 5658.8019419320335, 5677.716114194294, 5118.360204974379, 5144.717040562787, 5171.224316352558, 5185.325907632003, 5234.42421333653, 5152.510511501401, 5172.818951336704, 5174.0, 5257.342832145981, 5299.205119232127, 5179.015986962465, 5220.347456567929, 5223.477652234765, 5228.92156617651, 5243.449437809032, 5220.216967454874, 5229.843104706865, 5269.736513174326, 5278.2082687596785, 5328.147496400596, 5055.115354812893, 5137.357830271216, 5214.556762675177, 5220.712860792655, 5227.47725227478, 5553.527950124244, 5580.441955804387, 5592.161175823659, 5639.492445679908, 5666.036773748431, 6110.236220472441, 6169.7532098716, 6192.473639740628, 6226.439620434183, 6233.719482623293, 6188.164597779287, 6277.591956522811, 6303.275123360826, 6303.936960630381, 6319.33646967071, 5620.0, 5667.744951477111, 5674.460926212003, 5699.145128230715, 5751.396103409165, 5175.9741201293755, 6232.844178895473, 6245.718942647592, 6274.498040156776, 6276.340984196685, 4981.0, 6072.0, 6083.996140636834, 6098.634081955008, 6121.663308518075, 6097.908531372033, 6104.2064531611495, 6145.064304744081, 6238.251409830849, 6260.0, 6097.085437184458, 6123.050927106306, 6131.748241976024, 6132.164921701071, 6132.640831002815, 6162.22972128484, 6167.753289868445, 6220.720067596969, 6232.25212974446, 6259.280182778948, 4883.096627123993, 4883.755812209375, 4886.60907127429, 4897.730624815669, 4914.557689807934, 4360.694751367374, 4371.540988196193, 4423.093265880487, 4431.401760762255, 4455.376247325377, 5600.383957764642, 5636.943630563724, 5671.262735844396, 5677.403872593401, 5694.772209111672, 6247.937520624827, 6249.281332646713, 6255.155554000243, 6263.812085637438, 6280.842978925563, 5687.431256874363, 5707.486326230659, 5721.685307308055, 5722.341930678025, 5726.742296596663, 5278.894422111536, 5318.069337865858, 5342.439043900412, 5344.198370244494, 5352.063388906926, 6212.223472065992, 6261.436470717657, 6263.96868015657, 6265.968670156803, 6282.308946016026, 6269.028300613412, 6281.246250449975, 6287.056941458818, 6293.244810622755, 6293.779717709858, 6221.191245138103, 6222.160008398808, 6235.501159907287, 6249.468795152463, 6290.748370065329, 6062.818115456544, 6118.296395914349, 6122.204113465221, 6126.846828829315, 6130.785422510191, 6137.570370074052, 6158.137860699416, 6184.567080304336, 6191.040388739752, 6200.658963756856, 6049.939500604937, 6062.393760624079, 6077.787277445445, 6094.2077529920825, 6101.298350689727, 4932.975335123301, 6019.307779605401, 6045.697715114315, 6049.455549000611, 6084.269887613515, 5717.113847353667, 5767.163761254511, 5869.207656966255, 5887.735051922759, 5890.764369425175, 5896.970515147397, 5993.940060599338, 6048.939510604838, 6111.54163437735, 6122.215193971541, 5937.703114844154, 5947.345791962967, 5966.284045914518, 5999.070144127667, 5999.1901093351835], "value": 5647.3285791414455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.3223825453094, 509.4701510429154, 518.3960685801039, 520.6771801483081, 551.8328734726056, 40890.795546022266, 42735.57264427359, 42747.290108395704, 42782.786086069565, 44814.103717925624, 43243.3513497297, 43780.56219437805, 43850.7807460963, 43924.780376098075, 44059.33910991329, 8390.328773698106, 8820.911790882074, 10115.494225288743, 10122.696319110439, 10131.088202061814, 8778.122187781202, 12092.33492157931, 12329.938350308235, 12350.320732359716, 12609.24344539326, 12308.507659693601, 12377.381130943462, 12386.380680965916, 12405.131640785148, 12412.06909481788, 8839.646414143426, 9040.367174297802, 12369.257844529357, 12471.43878525464, 12474.750504989941, 8988.685396011173, 9055.139761722627, 9059.637614495412, 11926.224795388272, 12315.630531083993, 41973.1605367894, 42233.577664223274, 42338.0, 42353.0, 42356.94107647333, 3234.256121092162, 3332.9833350833333, 3380.6112297085906, 3555.4133567961258, 3873.6707379872746, 29225.35908865775, 30747.923822666322, 30799.92200273002, 31325.37349253025, 32328.838355808304, 3285.917852053694, 3313.0, 3340.8997730068136, 3348.916277093068, 3392.5759280089987, 482357.0, 484304.0, 487700.0, 487703.0, 488044.0, 63226.0, 63509.68245158745, 63652.68173659102, 63808.04287935685, 63879.0, 66577.33422665809, 66627.0, 66705.0, 66723.66638166778, 66736.0, 16916.830831691772, 17171.828281717022, 17174.96950182993, 17175.65648687044, 17210.31158753661, 11857.466414011391, 12036.81944770829, 12976.740465190644, 13178.60464186076, 13275.137116087424, 17367.47897563075, 17956.0, 18046.2781488739, 18092.457226282968, 18139.27442902269, 6375.2668443128705, 6492.220933488012, 6541.34586541342, 6541.705623246965, 6558.80323590293, 871.8779370887954, 877.5349064995562, 917.27535247154, 962.2109869906749, 1095.950682219302, 28891.85554072216, 29781.255468613457, 30178.0, 30662.693373065984, 30803.0, 1026.440589878518, 1038.7403149212696, 1054.599252284127, 1055.3562326980536, 1057.8836328003913, 15028.624284392978, 15501.457448989231, 15601.687966240612, 15850.0, 15893.523194304189, 661634.0, 690212.5489372521, 694462.0, 699016.0, 915444.0, 59502.70248648729, 60236.49408764728, 60567.0, 60625.69687151536, 60700.69649651812, 1346.4681450826868, 1369.8082268482422, 1397.699494608664, 1398.6573289543924, 1408.0003197729727, 29900.622041585262, 30876.38247234998, 30918.845405773725, 31664.683353166172, 31903.36193276168, 51917.740411299215, 52325.29072383504, 52446.0, 52457.47542524526, 52483.47516524786, 396485.0, 467446.0, 468617.0, 472646.0, 474205.0, 26000.8699956499, 26272.34319142037, 26540.0, 26588.601170982838, 26650.333741656614, 39257.0, 40138.79930600328, 40408.79795601003, 46876.062478750915, 46921.53078469171, 38536.80731596324, 39141.60858391494, 39700.0, 40820.0, 41151.58848411478, 38876.41685374778, 39243.0, 39314.80342598269, 40622.39066413947, 40762.77711668655, 32374.83812580922, 38069.04827379338, 38491.10405439816, 38902.41646375363, 39199.2160156801, 31328.650351223292, 34470.82764586161, 35176.94469165929, 35296.82351588226, 35732.82133589315, 25575.23274301774, 25704.228873133838, 25730.614040789776, 25988.480230395664, 26189.345266368495], "value": 20429.382345188707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.55022896036536, 371.2537799023963, 376.998115009425, 388.20418142807245, 406.7478163538606, 12308.692282692926, 14996.175210363426, 16253.83746162538, 20181.29365472209, 20711.0, 16085.517434476955, 20819.0, 20953.790462095374, 20995.160193592237, 21243.468913277175, 5512.407652964565, 5975.850603734898, 6257.061440783873, 6258.0, 6262.467690246334, 5381.300430943972, 6145.293291271494, 6208.503319734433, 6209.130721698965, 6219.036049412326, 5875.7062146892695, 6058.363871793465, 6163.352847950968, 6174.043023331368, 6180.351063138373, 6075.726592303335, 6128.877422451526, 6130.019196928492, 6135.0, 6145.692715364236, 5086.745662716849, 5271.130263506517, 5328.987492376475, 5336.67979921206, 5337.172738225581, 24615.87692061546, 25159.119430819832, 25185.37036574082, 25255.49489010228, 25486.725663716927, 2301.0910690277415, 2444.083468699238, 2459.225344016647, 2519.017583142576, 3063.6170478690165, 15595.688086238326, 15719.528414147593, 15813.841861581352, 15941.123238221893, 16178.514644560682, 1758.2703178181039, 1816.9370918012978, 1904.2287873411153, 1932.6811076172414, 1958.5201625601676, 119227.0, 121355.0, 122444.0, 123755.0, 126334.36832815777, 9696.418214907128, 10412.739681507872, 10922.50848711794, 10925.07136893373, 11113.388763617917, 13626.727465450835, 13629.659258518617, 13631.318434078257, 13639.522616708566, 13646.727065458635, 7990.161033091558, 8730.432521886058, 8748.8687669685, 8851.159139881702, 8875.911240887508, 8869.423487473294, 8900.376973611785, 8919.420237684659, 9083.818323633623, 9085.636574537077, 6445.51658625605, 6581.407673309425, 6606.6036037837885, 6619.040239165391, 6727.428168605723, 1558.3299181351902, 1834.0, 1844.2346426233232, 1846.4057998511844, 1880.8965506896977, 838.0402597725819, 927.0590350793949, 996.14829320931, 1022.0392830739081, 1077.9299345542672, 21520.461988450414, 22486.325410237718, 22515.54968900613, 22518.32445026652, 22563.548729025326, 825.9710910118238, 905.4386280505996, 940.1256831147099, 944.0370821761765, 1011.5903059261011, 9701.690271813355, 10613.73465663349, 10665.573377064986, 11819.409029548488, 11882.940585297018, 627234.0, 632051.0, 632649.0, 645382.0, 649610.0, 86566.13433865707, 102391.4880425608, 110187.44906275417, 128850.0, 135651.0, 927.8190752803139, 999.5202302894651, 1009.2985375164337, 1062.4953147254992, 1074.747434352942, 16789.664206716043, 18070.277188912823, 18748.250069997048, 19197.520061998563, 19253.133608987908, 55908.0, 57056.714716426155, 57561.712191438775, 57995.550111247554, 58782.412175879406, 76317.61841190759, 77350.61324693341, 78652.60673696594, 79633.60183199047, 81143.5942820282, 6570.8357291068105, 6629.707207094763, 6746.494012949147, 7105.360517553238, 7253.492255542062, 9271.67549135777, 12322.383880805744, 12894.742105158031, 13219.735605288033, 13540.187588744708, 11155.05182059534, 11242.437878106226, 11293.604723834625, 11454.0, 11631.360275184947, 11298.717532061435, 11314.60398886035, 11336.829947550958, 11695.12286578527, 11814.0, 11318.26431281964, 11384.373859437479, 11524.13568982313, 11845.644630661094, 11864.0, 7164.283571642794, 7245.420366370783, 7477.40180785525, 7543.170251272465, 7555.997660619831, 9951.751206219902, 11117.055050320814, 11147.275427097213, 11240.662780116609, 11360.261582997078], "value": 9745.658349819543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.4648499782577, 1527.3814105287358, 1696.6437048219873, 1860.2001139510005, 1875.11869421372, 8335.791605209864, 8813.0, 8818.382713210078, 8832.425892316995, 8832.558372081403, 7756.689732410697, 7971.0, 7980.204453997848, 8415.990081190266, 8601.91398086019, 2386.53462574798, 2430.44099857033, 2432.927012189637, 2433.2335314376005, 2433.707955045388, 2385.940351491218, 2415.2150551070886, 2422.6366045093287, 2423.212455951814, 2429.6841410616594, 2405.398650337416, 2415.9516809663883, 2418.7944024757917, 2419.0444774314137, 2420.407000284924, 2395.808335333169, 2403.07481619576, 2404.422938494766, 2404.495056038234, 2405.194259922928, 2366.4675448024227, 2396.8681722505257, 2398.952020959571, 2399.8560086394873, 2400.7479214682558, 7336.669849856769, 8700.086490918426, 8730.214280714767, 8792.384533082686, 8808.823823523493, 5148.099082660557, 5324.440933701944, 5326.201069839555, 5332.733363331818, 5334.706591137486, 3439.4152993991083, 3526.806025668587, 3590.120420496995, 3726.962730372689, 3732.869349572779, 962.9037096290385, 1095.9452027398677, 1107.6012635451232, 1127.689885281546, 1129.7514546799691, 11405.20163588549, 11554.13343999195, 11578.768424631544, 11585.594504192397, 11594.47824847884, 4595.4025976622825, 4652.860414187579, 4820.493848145894, 4838.516148385133, 4843.660943733976, 8325.666973321, 9875.358101723365, 9886.357386769838, 9886.703398898044, 9893.258005649604, 5320.893582128413, 5323.920141197885, 5325.707086110301, 5329.706866122323, 5332.226827110125, 4692.835750748707, 4809.326694262806, 4865.70805751656, 4867.610591152699, 4875.878103047452, 3799.0882188274613, 3808.638179372955, 3810.6760925321105, 3883.3204189266767, 3893.785841778673, 989.5934040327321, 1168.415792103948, 1187.4181650991125, 1189.6431070678934, 1193.7433451807904, 779.980500487481, 905.3119629081814, 908.9955599063072, 910.5947853205392, 926.6293482607011, 5655.293088363955, 5655.377908430151, 5794.420557944256, 5918.526517878559, 6079.3920607939735, 795.5902710104301, 857.8627419612832, 950.292032435826, 958.9041095890356, 993.4188499727596, 3689.3543629864666, 3691.2617476504806, 3691.9446208306895, 3702.315071711742, 3957.6438120569287, 9052.411593246417, 10645.935406459446, 10648.78702425947, 10648.89351106479, 10677.626283080055, 10571.04860562553, 10591.046805787517, 10612.0, 10687.732806679895, 10708.089812366035, 8106.594670266463, 8223.465474744122, 8261.586920653943, 8269.793255168668, 8273.875891861628, 5435.211894275229, 5588.636738611977, 5647.096464565814, 5827.766889324549, 5853.64878107315, 9590.568424420779, 9920.900790992286, 9931.950340248253, 10054.547545360623, 10109.747256318651, 8882.88963879515, 9250.21373183287, 10175.033371829664, 10226.6420675276, 10230.28388012832, 6880.621565813928, 6930.44556435494, 7481.438892083224, 7555.13115991668, 7641.579713115832, 8353.081161072156, 8359.373047021376, 8417.989841218849, 8439.324854011787, 8452.239298463168, 6726.8654626908165, 7185.964070179615, 7463.589502577411, 7557.168711441627, 7596.278353556403, 5947.464728174485, 7316.4146868249345, 7320.048393708784, 7438.516496427715, 7499.850003000019, 6719.260881302955, 6886.208086069965, 6890.44876409876, 6892.138482689664, 6896.586204827727, 3920.0, 4086.9182616348103, 4097.549269580284, 4912.508749125059, 4915.508449155056, 4917.901641967069, 4943.0, 4958.876028099182, 5025.447200807981, 5051.494850514919], "value": 4532.575835032945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2841181165204, 300.5506767382762, 307.3085557495634, 309.6748414165126, 311.4502902377303, 4392.516823149455, 5551.472610102034, 5556.583256255782, 5573.804916827907, 5585.832425027255, 5170.612204084689, 5319.13830159444, 5332.386775520817, 5334.386545547263, 5376.435474275204, 3486.8256587170667, 3915.921681566367, 4098.97950510247, 4108.424820525114, 4168.7081904266715, 3790.3366910790637, 4142.482189726285, 4143.647789937859, 4148.3777433385085, 4165.770882601456, 3527.7706949048356, 3663.285659296438, 3957.9208415831667, 4133.1527036957505, 4152.6055024772595, 3389.86440542378, 4102.056526998807, 4122.690798190148, 4132.979335103335, 4135.400366946806, 3598.442241452579, 3598.6684926577072, 3601.7118630509494, 3614.7469677122613, 3619.49327094207, 4957.553820156168, 5291.603129765283, 5295.549878260353, 5299.933026119777, 5310.654807437504, 4669.875206780906, 4693.859184224479, 4702.694324868872, 4711.104890070876, 4716.551927566876, 5126.2054381570915, 5689.687067211302, 5750.683712395817, 5754.108113242454, 5759.732858771064, 3140.7173354397987, 3805.6384643459105, 3885.339492286318, 3885.669718073967, 3902.453656488094, 5983.222181116427, 5993.3706960768495, 6037.54718396122, 6037.667928263943, 6042.546808989299, 3892.0, 3901.5318161820765, 3909.198614284065, 3920.2355540669864, 3927.5286965564314, 3072.6927307269543, 3446.5691788526433, 3865.768053916774, 3883.922321553553, 4024.9736317239503, 4382.677181094025, 4682.648801339845, 4683.15703173432, 4692.577668009827, 4750.168720473972, 4828.706364476916, 4850.198303679332, 5591.496765291144, 5764.011416061452, 5839.445252700986, 1106.970517418792, 1320.9075364724376, 1336.5990202939079, 1364.2905689041643, 1365.2388418939456, 709.4749885085104, 772.6523064620943, 800.7117437722416, 803.2650125135435, 806.9152738962324, 4005.819738111792, 4018.477597912253, 4503.347014682919, 4549.476810166807, 4578.886357277017, 4279.726009602657, 4922.360093187935, 4935.90128197434, 4983.875403114878, 4999.800007999712, 3844.6026385481023, 3917.3144699678014, 3960.88117356474, 4363.52001279859, 4530.478994915561, 2326.964500797163, 2489.5020995800915, 2609.543329917257, 2614.7382514125143, 2632.8551929644054, 4156.3374650139585, 5065.468125846733, 5132.230165475134, 5159.406668233126, 5249.632525723239, 4763.476017638057, 4932.608252192943, 5032.496750324938, 5071.54356107952, 5102.515261050195, 4446.487734430037, 5016.6322035421745, 5062.506870259509, 5064.772085256172, 5146.948530514647, 4257.680673949404, 4707.929381059218, 4904.841869577374, 4907.435644900882, 4994.625403094709, 4210.9868740884785, 4239.59723826236, 4613.746243956614, 4895.314655948099, 4899.485554016919, 4844.346013288302, 4954.950450495593, 5068.873278168076, 5130.640855140105, 5138.820141295037, 3033.529802880557, 3121.8282994435526, 3361.7478689097925, 3411.6247212806074, 3412.641672624438, 3757.210985693035, 4548.52038190791, 4628.652851036119, 4725.574698277172, 5011.874703132451, 3885.7668539887695, 4313.956860431355, 4338.9132217354845, 4776.47458779527, 4857.546938795886, 4139.855105071308, 4681.545998911366, 4814.518548145157, 4845.3350657139135, 4867.561919427127, 4435.8891027723275, 4663.813447462064, 4675.742834144155, 4678.391809064936, 5304.389995150453, 4814.566688998007, 5223.399309079505, 5340.225667278145, 5408.053590621704, 5683.261176047087, 5538.97230513861, 5576.442355764391, 5579.74891129892, 5580.888382232251, 5592.7762889483965], "value": 3840.4341668296747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.6973716433351, 705.5519744961945, 742.1650643026593, 778.256764789626, 791.8020494876281, 15092.849071509281, 16305.75541366879, 16319.59201019975, 16333.0, 16359.918200408982, 14545.927270363632, 14630.414783408678, 14680.339384727686, 14708.117512949231, 14737.189454579993, 653.8103949854536, 674.6997586074199, 803.5620586780219, 808.3856269235393, 836.2264904962915, 823.2056065896409, 829.838181554594, 833.1918039501704, 835.3859912963967, 839.0351096239312, 886.3839631456141, 889.2485849457198, 890.7862113092843, 891.1667590802588, 893.0890491698464, 881.9901213110952, 883.4346018548166, 884.4207044385937, 885.1237275097607, 885.4864178776294, 517.4282417928173, 533.2853975672617, 631.2015300644642, 653.3694984340087, 662.8707402056601, 15146.5456036318, 15174.317155728018, 15176.46882359123, 15182.0, 15190.848091519054, 13761.862381376259, 14054.0, 14182.00725949184, 14219.146851188962, 14283.143011419348, 10753.301035432673, 12297.44661490235, 12614.621561353175, 12897.161684490478, 13323.40044697991, 4483.977580112111, 4497.887552811173, 4703.6942598730975, 4707.058588282323, 4766.356541866839, 117305.0, 118921.0, 119630.0, 119896.0, 120504.39747801205, 10782.568697252022, 11164.60923867677, 11212.719682007852, 11252.099832013419, 11297.887021129683, 22576.0969561219, 22609.75646339467, 22699.092036318692, 22741.43146421353, 23148.884255578614, 8048.557329346942, 8099.797505062303, 8125.06561745395, 8145.95927020373, 8197.46716463428, 4135.793210339471, 4278.700490965664, 4379.802908869108, 4498.122866041091, 4554.339620754972, 3493.179102910814, 3639.5996440391536, 3640.690541304019, 3642.8724994625063, 3650.178709790329, 642.2581917884851, 642.3223499208286, 644.4039263681076, 664.5248647217167, 675.6790524500823, 561.1498579651831, 575.7840809696364, 622.9283632382244, 625.1591609285504, 645.0968643898486, 8842.513661748666, 8891.822163556693, 9193.402428842104, 9323.160915517636, 9349.485778282124, 581.3285655068403, 594.1651978969554, 618.5051958433236, 618.9969050154721, 633.9714712837841, 3774.9622503774613, 4290.914181716348, 4512.210363186429, 4558.6581006423985, 4593.954060459419, 86678.56660716783, 99768.00231997587, 145566.0, 159689.0, 170969.0, 102792.0, 122428.0, 123452.0, 125365.0, 128581.3570932158, 86855.99999999873, 107637.38543921847, 109847.0, 112635.43682281536, 112974.0, 9660.71017869465, 10137.695869123938, 10145.442000690033, 10145.695629131138, 10148.695539133838, 48058.03883922372, 48098.0, 59314.11028834657, 60127.79744405175, 63433.365666344595, 54930.45069549253, 86254.0, 89548.0, 89700.10299896917, 91224.0, 12623.873761262637, 12671.429785659482, 12836.223392126265, 12935.0, 13246.940244780202, 13837.654058648613, 14276.500322488662, 14534.563963081124, 15017.849821501644, 15606.531804045897, 12725.490980360682, 13537.187768733907, 13794.65513362174, 13830.930845345709, 13960.2321872298, 13384.732305354033, 13859.0, 14107.435702572193, 14412.783808243095, 14437.118340049205, 12236.938815305866, 12432.937835310766, 12894.871051289367, 13158.934205329295, 13354.666133346744, 8650.221480066824, 11208.495617697386, 11533.88466115328, 11680.649580512598, 11960.700982475508, 11166.274192177483, 11393.742462148562, 11471.13966452536, 11581.884181158417, 11684.415779211175], "value": 7759.974896595206, "unit": "score"}], "name": "dromaeo_css", "value": 7304.508629212533, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 114.0, 118.0, 165.0, 161.0, 113.0, 115.0, 162.0, 167.0], "value": 134.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 108.0, 142.0, 110.0, 131.0, 141.0, 107.0, 139.0, 107.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 186.0, 183.0, 183.0, 184.0, 186.0, 182.0, 187.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 91.0, 63.0, 60.0, 58.0, 58.0, 83.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 93.0, 69.0, 67.0, 70.0, 92.0, 67.0, 68.0, 90.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 87.0, 85.0, 89.0, 85.0, 89.0, 101.0, 135.0, 85.0], "value": 93.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 95.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 131.0, 131.0, 86.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 54.0, 56.0, 57.0, 57.0, 56.0, 57.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 82.0, 74.0, 72.0, 69.0, 70.0, 70.0, 71.0, 74.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 83.0, 83.0, 85.0, 85.0, 84.0, 83.0, 89.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 137.0, 138.0, 136.0, 135.0, 135.0, 135.0, 198.0, 147.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 165.0, 165.0, 162.0, 212.0, 231.0, 151.0, 211.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 59.0, 64.0, 87.0, 84.0, 87.0, 78.0, 66.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1477.0000000000002, "alertThreshold": 2.0}]} 04:12:28 INFO - Return code: 0 04:12:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:12:28 INFO - # TBPL SUCCESS # 04:12:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:12:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:12:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:12:28 INFO - 2016-10-06 04:12:28.789 screenresolution[2259:21460] starting screenresolution argv=screenresolution get 04:12:28 INFO - 2016-10-06 04:12:28.791 screenresolution[2259:21460] Display 0: 1600x1200x32@60 04:12:28 INFO - 2016-10-06 04:12:28.798 screenresolution[2260:21463] starting screenresolution argv=screenresolution list 04:12:28 INFO - Available Modes on Display 0 04:12:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:12:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:12:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:12:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:12:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:12:29 INFO - Intel Iris: 04:12:29 INFO - Chipset Model: Intel Iris 04:12:29 INFO - Type: GPU 04:12:29 INFO - Bus: Built-In 04:12:29 INFO - VRAM (Dynamic, Max): 1536 MB 04:12:29 INFO - Vendor: Intel (0x8086) 04:12:29 INFO - Device ID: 0x0a2e 04:12:29 INFO - Revision ID: 0x0009 04:12:29 INFO - Displays: 04:12:29 INFO - Display: 04:12:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:12:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:12:29 INFO - Display Serial Number: 1600x1200 60 04:12:29 INFO - Main Display: Yes 04:12:29 INFO - Mirror: Off 04:12:29 INFO - Online: Yes 04:12:29 INFO - Rotation: Supported 04:12:29 INFO - Return code: 0 04:12:29 INFO - Running post-action listener: _resource_record_post_action 04:12:29 INFO - [mozharness: 2016-10-06 11:12:29.033275Z] Finished run-tests step (success) 04:12:29 INFO - Running post-run listener: _resource_record_post_run 04:12:29 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 929792; Write bytes: 661925376; Read time: 7; Write time: 1878 04:12:29 INFO - TinderboxPrint: CPU usage
53.6% 04:12:29 INFO - TinderboxPrint: I/O read bytes / time
929,792 / 7 04:12:29 INFO - TinderboxPrint: I/O write bytes / time
661,925,376 / 1,878 04:12:29 INFO - TinderboxPrint: CPU idle
2,245.1 (46.4%) 04:12:29 INFO - TinderboxPrint: CPU system
973.2 (20.1%) 04:12:29 INFO - TinderboxPrint: CPU user
1,623.4 (33.5%) 04:12:29 INFO - TinderboxPrint: Swap in / out
363,225,088 / 0 04:12:29 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355875328; Write bytes: 355751424; Read time: 27338; Write time: 734 04:12:29 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 929792; Write bytes: 295991296; Read time: 7; Write time: 1108 04:12:29 INFO - Running post-run listener: _upload_blobber_files 04:12:29 INFO - Blob upload gear active. 04:12:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:29 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 04:12:29 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'] 04:12:29 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 04:12:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:12:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:12:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:31 INFO - (blobuploader) - INFO - Done attempting. 04:12:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:12:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:12:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:32 INFO - (blobuploader) - INFO - Done attempting. 04:12:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:34 INFO - (blobuploader) - INFO - Done attempting. 04:12:34 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:34 INFO - Return code: 0 04:12:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6577c4c0d0a20cca7abaf48f193c6068db4ec4ab7d2057821c51563bcd5934ff44e7e4aa7d2ca876159387e6261743ee656185dc36c43670c8d59734d06cefbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03b79c1a8bb6cd0f01714c570e9ae69536e1f096326b046e35f93da5cc2a5b874563d4ca5e6644082610ba1737d47740f4fbfcd9c27a63293c5f5de8c9d5c013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/234669891a502e2628c883ee4e4d161ce8efa7924e0d658740fb199f51dca54eeafe5b546138a201a1068b43ae2683e18b91adf0c7dd4eac85b47cd882998e22"} 04:12:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:34 INFO - Contents: 04:12:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6577c4c0d0a20cca7abaf48f193c6068db4ec4ab7d2057821c51563bcd5934ff44e7e4aa7d2ca876159387e6261743ee656185dc36c43670c8d59734d06cefbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03b79c1a8bb6cd0f01714c570e9ae69536e1f096326b046e35f93da5cc2a5b874563d4ca5e6644082610ba1737d47740f4fbfcd9c27a63293c5f5de8c9d5c013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/234669891a502e2628c883ee4e4d161ce8efa7924e0d658740fb199f51dca54eeafe5b546138a201a1068b43ae2683e18b91adf0c7dd4eac85b47cd882998e22"} 04:12:34 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:34 INFO - Copying logs to upload dir... 04:12:34 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.758871 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-06 04:12:34.673822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:12:34.677207) ========= 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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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/6577c4c0d0a20cca7abaf48f193c6068db4ec4ab7d2057821c51563bcd5934ff44e7e4aa7d2ca876159387e6261743ee656185dc36c43670c8d59734d06cefbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03b79c1a8bb6cd0f01714c570e9ae69536e1f096326b046e35f93da5cc2a5b874563d4ca5e6644082610ba1737d47740f4fbfcd9c27a63293c5f5de8c9d5c013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/234669891a502e2628c883ee4e4d161ce8efa7924e0d658740fb199f51dca54eeafe5b546138a201a1068b43ae2683e18b91adf0c7dd4eac85b47cd882998e22"} build_url:https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/EhpiFnX_QCG9c9s6lQD5Gw/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/6577c4c0d0a20cca7abaf48f193c6068db4ec4ab7d2057821c51563bcd5934ff44e7e4aa7d2ca876159387e6261743ee656185dc36c43670c8d59734d06cefbc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03b79c1a8bb6cd0f01714c570e9ae69536e1f096326b046e35f93da5cc2a5b874563d4ca5e6644082610ba1737d47740f4fbfcd9c27a63293c5f5de8c9d5c013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/234669891a502e2628c883ee4e4d161ce8efa7924e0d658740fb199f51dca54eeafe5b546138a201a1068b43ae2683e18b91adf0c7dd4eac85b47cd882998e22"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:12:34.709911) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:12:34.710264) ========= 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.ccOeTbLB8u/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.lNQ5qETXR1/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.005137 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:12:34.759826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:12:34.760452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:12:34.761095) ========= ========= Total master_lag: 1.06 =========