builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1480807006.46 results: success (0) buildid: 20161203133838 builduid: 007af99f81c14ab89a2e6ca6d59353ca revision: 11d06cafe634dfa7981cfdca62c0b34d04a22a84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:46.461296) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:46.461961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:46.462255) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:46.548275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:46.548596) ========= 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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-12-03 15:16:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2016-12-03 15:16:47 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.641130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:47.213704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:47.214010) ========= 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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.024942 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:47.261790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-03 15:16:47.262107) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 11d06cafe634dfa7981cfdca62c0b34d04a22a84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 11d06cafe634dfa7981cfdca62c0b34d04a22a84 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qq4w25c3ue/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.N8pWo3ylGj/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-12-03 15:16:47,357 truncating revision to first 12 chars 2016-12-03 15:16:47,358 Setting DEBUG logging. 2016-12-03 15:16:47,358 attempt 1/10 2016-12-03 15:16:47,358 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/11d06cafe634?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-03 15:16:48,436 unpacking tar archive at: mozilla-central-11d06cafe634/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-03 15:16:48.636536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:48.636838) ========= script_repo_revision: 11d06cafe634dfa7981cfdca62c0b34d04a22a84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:48.637240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:48.637526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 15:16:48.657134) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-03 15:16:48.657445) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qq4w25c3ue/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.N8pWo3ylGj/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:16:48 INFO - MultiFileLogger online at 20161203 15:16:48 in /builds/slave/test 15:16:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:16:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:16:48 INFO - {'append_to_log': False, 15:16:48 INFO - 'base_work_dir': '/builds/slave/test', 15:16:48 INFO - 'blob_upload_branch': 'Firefox', 15:16:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:16:48 INFO - 'branch': 'Firefox', 15:16:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:16:48 INFO - 'config_files': ('talos/mac_config.py',), 15:16:48 INFO - 'default_actions': ('clobber', 15:16:48 INFO - 'read-buildbot-config', 15:16:48 INFO - 'download-and-extract', 15:16:48 INFO - 'populate-webroot', 15:16:48 INFO - 'create-virtualenv', 15:16:48 INFO - 'install', 15:16:48 INFO - 'run-tests'), 15:16:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:16:48 INFO - 'download_minidump_stackwalk': True, 15:16:48 INFO - 'download_symbols': 'ondemand', 15:16:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:16:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:16:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:16:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:16:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:16:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:16:48 INFO - 'installer_path': 'installer.exe', 15:16:48 INFO - 'log_level': 'info', 15:16:48 INFO - 'log_name': 'talos', 15:16:48 INFO - 'log_to_console': True, 15:16:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:16:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:16:48 INFO - 'opt_config_files': (), 15:16:48 INFO - 'pip_index': False, 15:16:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:16:48 INFO - 'cmd': ('bash', 15:16:48 INFO - '-c', 15:16:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:16:48 INFO - 'enabled': True, 15:16:48 INFO - 'halt_on_failure': False, 15:16:48 INFO - 'name': 'check_screen_resolution'},), 15:16:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:16:48 INFO - 'cmd': ('bash', 15:16:48 INFO - '-c', 15:16:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:16:48 INFO - 'enabled': True, 15:16:48 INFO - 'halt_on_failure': False, 15:16:48 INFO - 'name': 'check_screen_resolution'},), 15:16:48 INFO - 'run_cmd_checks_enabled': True, 15:16:48 INFO - 'sps_profile': False, 15:16:48 INFO - 'sps_profile_interval': 0, 15:16:48 INFO - 'suite': 'dromaeojs', 15:16:48 INFO - 'system_bits': '32', 15:16:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:16:48 INFO - 'title': 't-yosemite-r7-0321', 15:16:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:16:48 INFO - 'use_talos_json': True, 15:16:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:16:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:16:48 INFO - 'work_dir': 'build'} 15:16:48 INFO - [mozharness: 2016-12-03 23:16:48.858606Z] Running clobber step. 15:16:48 INFO - Running pre-action listener: _resource_record_pre_action 15:16:48 INFO - Running main action method: clobber 15:16:48 INFO - rmtree: /builds/slave/test/build 15:16:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:16:51 INFO - Running post-action listener: _resource_record_post_action 15:16:51 INFO - [mozharness: 2016-12-03 23:16:51.244976Z] Finished clobber step (success) 15:16:51 INFO - [mozharness: 2016-12-03 23:16:51.245124Z] Running read-buildbot-config step. 15:16:51 INFO - Running pre-action listener: _resource_record_pre_action 15:16:51 INFO - Running main action method: read_buildbot_config 15:16:51 INFO - Using buildbot properties: 15:16:51 INFO - { 15:16:51 INFO - "project": "", 15:16:51 INFO - "product": "firefox", 15:16:51 INFO - "script_repo_revision": "production", 15:16:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:16:51 INFO - "repository": "", 15:16:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:16:51 INFO - "buildid": "20161203133838", 15:16:51 INFO - "pgo_build": "False", 15:16:51 INFO - "basedir": "/builds/slave/test", 15:16:51 INFO - "buildnumber": 14, 15:16:51 INFO - "slavename": "t-yosemite-r7-0321", 15:16:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:16:51 INFO - "platform": "yosemite_r7", 15:16:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:16:51 INFO - "branch": "mozilla-central", 15:16:51 INFO - "repo_path": "mozilla-central", 15:16:51 INFO - "revision": "11d06cafe634dfa7981cfdca62c0b34d04a22a84", 15:16:51 INFO - "stage_platform": "macosx64", 15:16:51 INFO - "builduid": "007af99f81c14ab89a2e6ca6d59353ca", 15:16:51 INFO - "slavebuilddir": "test" 15:16:51 INFO - } 15:16:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 15:16:51 INFO - Running post-action listener: _resource_record_post_action 15:16:51 INFO - [mozharness: 2016-12-03 23:16:51.248372Z] Finished read-buildbot-config step (success) 15:16:51 INFO - [mozharness: 2016-12-03 23:16:51.248492Z] Running download-and-extract step. 15:16:51 INFO - Running pre-action listener: _resource_record_pre_action 15:16:51 INFO - Running main action method: download_and_extract 15:16:51 INFO - mkdir: /builds/slave/test/build/tests 15:16: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')]} 15:16:51 INFO - trying https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 15:16:51 INFO - Downloading https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 15:16:52 INFO - Downloaded 1199 bytes. 15:16:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:16:52 INFO - Using the following test package requirements: 15:16:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:16:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:16:52 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 15:16:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:16:52 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 15:16:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:16:52 INFO - u'jsshell-mac.zip'], 15:16:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:16:52 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 15:16:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:16:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:16:52 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 15:16:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:16:52 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 15:16:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:16:52 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 15:16:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:16:52 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 15:16:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:16:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:16:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:16:52 INFO - Fetch https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:16:53 INFO - Expected file size: 16283757 15:16:53 INFO - Obtained file size: 16283757 15:16:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:16:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:16:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:16:59 INFO - Fetch https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:17:00 INFO - Expected file size: 16283757 15:17:00 INFO - Obtained file size: 16283757 15:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 15:17:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:17:06 INFO - Fetch https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 15:17:07 INFO - Expected file size: 14409734 15:17:07 INFO - Obtained file size: 14409734 15:17:08 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')]} 15:17:08 INFO - trying https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:17:08 INFO - Downloading https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 15:17:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 15:17:11 INFO - Downloaded 107603955 bytes. 15:17:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:17:11 INFO - mkdir: /builds/slave/test/properties 15:17:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:11 INFO - Contents: 15:17:11 INFO - build_url:https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:17:11 INFO - Running post-action listener: _resource_record_post_action 15:17:11 INFO - Running post-action listener: set_extra_try_arguments 15:17:11 INFO - [mozharness: 2016-12-03 23:17:11.765791Z] Finished download-and-extract step (success) 15:17:11 INFO - [mozharness: 2016-12-03 23:17:11.765910Z] Running populate-webroot step. 15:17:11 INFO - Running pre-action listener: _resource_record_pre_action 15:17:11 INFO - Running main action method: populate_webroot 15:17:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:11 INFO - '--tppagecycles', 15:17:11 INFO - '7'], 15:17:11 INFO - 'tests': ['tsvgm']}}, 15:17:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:17:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:17:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:17:11 INFO - 'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:17:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:17:11 INFO - 'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['damp', 'tps']}, 15:17:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:17:11 INFO - 'tests': ['damp', 'tps']}, 15:17:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['dromaeo_dom']}, 15:17:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['basic_compositor_video']}, 15:17:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:17:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore', 15:17:11 INFO - 'tabpaint']}, 15:17:11 INFO - 'other-e10s': {'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore', 15:17:11 INFO - 'tabpaint']}, 15:17:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore', 15:17:11 INFO - 'tabpaint']}, 15:17:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore', 15:17:11 INFO - 'tabpaint']}, 15:17:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore', 15:17:11 INFO - 'tabpaint']}, 15:17:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore', 15:17:11 INFO - 'tabpaint']}, 15:17:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['tsvgx', 15:17:11 INFO - 'tsvgr_opacity', 15:17:11 INFO - 'tart', 15:17:11 INFO - 'tscrollx', 15:17:11 INFO - 'cart', 15:17:11 INFO - 'tsvg_static']}, 15:17:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:17:11 INFO - 'tsvgr_opacity', 15:17:11 INFO - 'tart', 15:17:11 INFO - 'tscrollx', 15:17:11 INFO - 'cart', 15:17:11 INFO - 'tsvg_static']}, 15:17:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:17:11 INFO - 'talos_options': ['--disable-e10s'], 15:17:11 INFO - 'tests': ['tp5o']}, 15:17:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:17:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:17:11 INFO - 'talos_options': ['--disable-e10s', 15:17:11 INFO - '--xperf_path', 15:17:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:11 INFO - 'tests': ['tp5n']}, 15:17:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:17:11 INFO - 'talos_options': ['--xperf_path', 15:17:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:11 INFO - 'tests': ['tp5n']}}, 15:17:11 INFO - 'talos.zip': {'path': '', 15:17:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:11 INFO - Running post-action listener: _resource_record_post_action 15:17:11 INFO - [mozharness: 2016-12-03 23:17:11.784468Z] Finished populate-webroot step (success) 15:17:11 INFO - [mozharness: 2016-12-03 23:17:11.784603Z] Running create-virtualenv step. 15:17:11 INFO - Running pre-action listener: _resource_record_pre_action 15:17:11 INFO - Running main action method: create_virtualenv 15:17:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:11 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 15:17:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:11 INFO - Using real prefix '/tools/python27' 15:17:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:15 INFO - Installing pip.................done. 15:17:15 INFO - Return code: 0 15:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:17:15 INFO - Reading from file tmpfile_stdout 15:17:15 INFO - Output received: 15:17:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:17:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:15 INFO - 'HOME': '/Users/cltbld', 15:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:15 INFO - 'LOGNAME': 'cltbld', 15:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:15 INFO - 'MOZ_NO_REMOTE': '1', 15:17:15 INFO - 'NO_EM_RESTART': '1', 15:17:15 INFO - 'PAGER': '/bin/cat', 15:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:15 INFO - 'PWD': '/builds/slave/test', 15:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:15 INFO - 'SHELL': '/bin/bash', 15:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:15 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:15 INFO - 'USER': 'cltbld', 15:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:15 INFO - 'XPC_FLAGS': '0x0', 15:17:15 INFO - 'XPC_SERVICE_NAME': '0', 15:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:16 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 15:17:16 INFO - Cleaning up... 15:17:16 INFO - Return code: 0 15:17:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:17:16 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')]} 15:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:16 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')]} 15:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:16 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 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:16 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 15:17:16 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 15:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:16 INFO - 'HOME': '/Users/cltbld', 15:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:16 INFO - 'LOGNAME': 'cltbld', 15:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:16 INFO - 'MOZ_NO_REMOTE': '1', 15:17:16 INFO - 'NO_EM_RESTART': '1', 15:17:16 INFO - 'PAGER': '/bin/cat', 15:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:16 INFO - 'PWD': '/builds/slave/test', 15:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:16 INFO - 'SHELL': '/bin/bash', 15:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:16 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:16 INFO - 'USER': 'cltbld', 15:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:16 INFO - 'XPC_FLAGS': '0x0', 15:17:16 INFO - 'XPC_SERVICE_NAME': '0', 15:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:16 INFO - Downloading/unpacking psutil>=3.1.1 15:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:20 INFO - Installing collected packages: psutil 15:17:20 INFO - Running setup.py install for psutil 15:17:20 INFO - building 'psutil._psutil_osx' extension 15:17:20 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 15:17:20 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 15:17:20 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 15:17:21 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 15:17:21 INFO - building 'psutil._psutil_posix' extension 15:17:21 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 15:17:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:17:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:17:21 INFO - ^ 15:17:21 INFO - 1 warning generated. 15:17:21 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 15:17:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:21 INFO - Successfully installed psutil 15:17:21 INFO - Cleaning up... 15:17:21 INFO - Return code: 0 15:17:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:17:21 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')]} 15:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:21 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')]} 15:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:21 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 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:21 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 15:17:21 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 15:17:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:21 INFO - 'HOME': '/Users/cltbld', 15:17:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:21 INFO - 'LOGNAME': 'cltbld', 15:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:21 INFO - 'MOZ_NO_REMOTE': '1', 15:17:21 INFO - 'NO_EM_RESTART': '1', 15:17:21 INFO - 'PAGER': '/bin/cat', 15:17:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:21 INFO - 'PWD': '/builds/slave/test', 15:17:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:21 INFO - 'SHELL': '/bin/bash', 15:17:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:21 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:21 INFO - 'USER': 'cltbld', 15:17:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:21 INFO - 'XPC_FLAGS': '0x0', 15:17:21 INFO - 'XPC_SERVICE_NAME': '0', 15:17:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:17:24 INFO - Installing collected packages: mozsystemmonitor 15:17:24 INFO - Running setup.py install for mozsystemmonitor 15:17:24 INFO - Successfully installed mozsystemmonitor 15:17:24 INFO - Cleaning up... 15:17:24 INFO - Return code: 0 15:17:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:24 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 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:24 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 15:17:24 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 15:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:24 INFO - 'HOME': '/Users/cltbld', 15:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:24 INFO - 'LOGNAME': 'cltbld', 15:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:24 INFO - 'MOZ_NO_REMOTE': '1', 15:17:24 INFO - 'NO_EM_RESTART': '1', 15:17:24 INFO - 'PAGER': '/bin/cat', 15:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:24 INFO - 'PWD': '/builds/slave/test', 15:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:24 INFO - 'SHELL': '/bin/bash', 15:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:24 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:24 INFO - 'USER': 'cltbld', 15:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:24 INFO - 'XPC_FLAGS': '0x0', 15:17:24 INFO - 'XPC_SERVICE_NAME': '0', 15:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:24 INFO - Downloading/unpacking jsonschema==2.5.1 15:17:24 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 15:17:24 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 15:17:24 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 15:17:24 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 15:17:24 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 15:17:24 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 15:17:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:17:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:17:27 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 15:17:27 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 15:17:27 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 15:17:27 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 15:17:27 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 15:17:27 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 15:17:27 INFO - Downloading functools32-3.2.3-2.tar.gz 15:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:17:27 INFO - warning: no files found matching '*.txt' 15:17:27 INFO - no previously-included directories found matching 'build' 15:17:27 INFO - no previously-included directories found matching 'dist' 15:17:27 INFO - no previously-included directories found matching '.git*' 15:17:27 INFO - Installing collected packages: jsonschema, functools32 15:17:27 INFO - Running setup.py install for functools32 15:17:28 INFO - warning: no files found matching '*.txt' 15:17:28 INFO - no previously-included directories found matching 'build' 15:17:28 INFO - no previously-included directories found matching 'dist' 15:17:28 INFO - no previously-included directories found matching '.git*' 15:17:28 INFO - Successfully installed jsonschema functools32 15:17:28 INFO - Cleaning up... 15:17:28 INFO - Return code: 0 15:17:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:28 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 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:28 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 15:17:28 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 15:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:28 INFO - 'HOME': '/Users/cltbld', 15:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:28 INFO - 'LOGNAME': 'cltbld', 15:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:28 INFO - 'MOZ_NO_REMOTE': '1', 15:17:28 INFO - 'NO_EM_RESTART': '1', 15:17:28 INFO - 'PAGER': '/bin/cat', 15:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:28 INFO - 'PWD': '/builds/slave/test', 15:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:28 INFO - 'SHELL': '/bin/bash', 15:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:28 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:28 INFO - 'USER': 'cltbld', 15:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:28 INFO - 'XPC_FLAGS': '0x0', 15:17:28 INFO - 'XPC_SERVICE_NAME': '0', 15:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:17:28 INFO - Cleaning up... 15:17:28 INFO - Return code: 0 15:17:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:28 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 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:28 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 15:17:28 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 15:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:28 INFO - 'HOME': '/Users/cltbld', 15:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:28 INFO - 'LOGNAME': 'cltbld', 15:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:28 INFO - 'MOZ_NO_REMOTE': '1', 15:17:28 INFO - 'NO_EM_RESTART': '1', 15:17:28 INFO - 'PAGER': '/bin/cat', 15:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:28 INFO - 'PWD': '/builds/slave/test', 15:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:28 INFO - 'SHELL': '/bin/bash', 15:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:28 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:28 INFO - 'USER': 'cltbld', 15:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:28 INFO - 'XPC_FLAGS': '0x0', 15:17:28 INFO - 'XPC_SERVICE_NAME': '0', 15:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:31 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17:32 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 15:17:32 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 15:17:32 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 15:17:32 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 15:17:32 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 15:17:32 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 15:17:32 INFO - Downloading docopt-0.6.1.tar.gz 15:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:32 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:32 INFO - Running setup.py install for blobuploader 15:17:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:32 INFO - Running setup.py install for requests 15:17:33 INFO - Running setup.py install for docopt 15:17:33 INFO - Successfully installed blobuploader requests docopt 15:17:33 INFO - Cleaning up... 15:17:33 INFO - Return code: 0 15:17:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:33 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 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:33 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 15:17:33 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 15:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:33 INFO - 'HOME': '/Users/cltbld', 15:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:33 INFO - 'LOGNAME': 'cltbld', 15:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:33 INFO - 'MOZ_NO_REMOTE': '1', 15:17:33 INFO - 'NO_EM_RESTART': '1', 15:17:33 INFO - 'PAGER': '/bin/cat', 15:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:33 INFO - 'PWD': '/builds/slave/test', 15:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:33 INFO - 'SHELL': '/bin/bash', 15:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:33 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:33 INFO - 'USER': 'cltbld', 15:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:33 INFO - 'XPC_FLAGS': '0x0', 15:17:33 INFO - 'XPC_SERVICE_NAME': '0', 15:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:33 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-W3qfFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:33 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-_SMXc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:33 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-8VHNqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-HpLwcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-vh4nsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-9ICsdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-5qXB4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-RysYE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-fvMOSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wiVrbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-nJ7Itd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-KK6jkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-dQztLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-HowPPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-SB4p54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-q9daw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-pp07gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:35 INFO - Running setup.py install for manifestparser 15:17:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:35 INFO - Running setup.py install for mozcrash 15:17:35 INFO - Running setup.py install for mozdebug 15:17:35 INFO - Running setup.py install for mozdevice 15:17:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:36 INFO - Running setup.py install for mozfile 15:17:36 INFO - Running setup.py install for mozhttpd 15:17:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:36 INFO - Running setup.py install for mozinfo 15:17:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:36 INFO - Running setup.py install for mozInstall 15:17:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:36 INFO - Running setup.py install for mozleak 15:17:36 INFO - Running setup.py install for mozlog 15:17:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:37 INFO - Running setup.py install for moznetwork 15:17:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:37 INFO - Running setup.py install for mozprocess 15:17:37 INFO - Running setup.py install for mozprofile 15:17:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:37 INFO - Running setup.py install for mozrunner 15:17:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:37 INFO - Running setup.py install for mozscreenshot 15:17:37 INFO - Running setup.py install for moztest 15:17:37 INFO - Running setup.py install for mozversion 15:17:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:38 INFO - Cleaning up... 15:17:38 INFO - Return code: 0 15:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:38 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 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:38 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 15:17:38 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 15:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:38 INFO - 'HOME': '/Users/cltbld', 15:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:38 INFO - 'LOGNAME': 'cltbld', 15:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:38 INFO - 'MOZ_NO_REMOTE': '1', 15:17:38 INFO - 'NO_EM_RESTART': '1', 15:17:38 INFO - 'PAGER': '/bin/cat', 15:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:38 INFO - 'PWD': '/builds/slave/test', 15:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:38 INFO - 'SHELL': '/bin/bash', 15:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:38 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:38 INFO - 'USER': 'cltbld', 15:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:38 INFO - 'XPC_FLAGS': '0x0', 15:17:38 INFO - 'XPC_SERVICE_NAME': '0', 15:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:38 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-hhngUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:38 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)) 15:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:38 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wZL8W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:38 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-OISIKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:38 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)) 15:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:38 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-3hDZnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:38 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-rELqwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:38 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)) 15:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:38 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wLduuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-NySaSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-iJzQ5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-3qKLls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-5iqX9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-UnGRwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-jOTTAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-GdDrvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-HbCZKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-40kFLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:39 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)) 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:39 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-TXaoaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:40 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)) 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:40 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-2x7TXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:40 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)) 15:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:40 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)) 15:17:40 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:17:40 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:17:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:40 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 15:17:40 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 15:17:40 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 15:17:40 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 15:17:40 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 15:17:40 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 15:17:42 INFO - Downloading blessings-1.6.tar.gz 15:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:42 INFO - Installing collected packages: blessings 15:17:42 INFO - Running setup.py install for blessings 15:17:43 INFO - Successfully installed blessings 15:17:43 INFO - Cleaning up... 15:17:43 INFO - Return code: 0 15:17:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:43 INFO - Reading from file tmpfile_stdout 15:17:43 INFO - Current package versions: 15:17:43 INFO - blessings == 1.6 15:17:43 INFO - blobuploader == 1.2.4 15:17:43 INFO - docopt == 0.6.1 15:17:43 INFO - functools32 == 3.2.3-2 15:17:43 INFO - jsonschema == 2.5.1 15:17:43 INFO - manifestparser == 1.1 15:17:43 INFO - mozInstall == 1.12 15:17:43 INFO - mozcrash == 1.0 15:17:43 INFO - mozdebug == 0.1 15:17:43 INFO - mozdevice == 0.49 15:17:43 INFO - mozfile == 1.2 15:17:43 INFO - mozhttpd == 0.7 15:17:43 INFO - mozinfo == 0.9 15:17:43 INFO - mozleak == 0.1 15:17:43 INFO - mozlog == 3.4 15:17:43 INFO - moznetwork == 0.27 15:17:43 INFO - mozprocess == 0.23 15:17:43 INFO - mozprofile == 0.28 15:17:43 INFO - mozrunner == 6.13 15:17:43 INFO - mozscreenshot == 0.1 15:17:43 INFO - mozsystemmonitor == 0.3 15:17:43 INFO - moztest == 0.7 15:17:43 INFO - mozversion == 1.4 15:17:43 INFO - psutil == 3.1.1 15:17:43 INFO - requests == 1.2.3 15:17:43 INFO - wsgiref == 0.1.2 15:17:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:43 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 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:43 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 15:17:43 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 15:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:43 INFO - 'HOME': '/Users/cltbld', 15:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:43 INFO - 'LOGNAME': 'cltbld', 15:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:43 INFO - 'MOZ_NO_REMOTE': '1', 15:17:43 INFO - 'NO_EM_RESTART': '1', 15:17:43 INFO - 'PAGER': '/bin/cat', 15:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:43 INFO - 'PWD': '/builds/slave/test', 15:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:43 INFO - 'SHELL': '/bin/bash', 15:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:43 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:43 INFO - 'USER': 'cltbld', 15:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:43 INFO - 'XPC_FLAGS': '0x0', 15:17:43 INFO - 'XPC_SERVICE_NAME': '0', 15:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 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)) 15:17:43 INFO - Cleaning up... 15:17:43 INFO - Return code: 0 15:17:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070733f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff411dae8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, '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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 15:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:43 INFO - 'HOME': '/Users/cltbld', 15:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:43 INFO - 'LOGNAME': 'cltbld', 15:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:43 INFO - 'MOZ_NO_REMOTE': '1', 15:17:43 INFO - 'NO_EM_RESTART': '1', 15:17:43 INFO - 'PAGER': '/bin/cat', 15:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:43 INFO - 'PWD': '/builds/slave/test', 15:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:43 INFO - 'SHELL': '/bin/bash', 15:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:17:43 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:43 INFO - 'USER': 'cltbld', 15:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:43 INFO - 'XPC_FLAGS': '0x0', 15:17:43 INFO - 'XPC_SERVICE_NAME': '0', 15:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:17:43 INFO - Cleaning up... 15:17:43 INFO - Return code: 0 15:17:43 INFO - Running post-action listener: _resource_record_post_action 15:17:43 INFO - Running post-action listener: _start_resource_monitoring 15:17:43 INFO - Starting resource monitoring. 15:17:43 INFO - [mozharness: 2016-12-03 23:17:43.995978Z] Finished create-virtualenv step (success) 15:17:43 INFO - [mozharness: 2016-12-03 23:17:43.996956Z] Running install step. 15:17:43 INFO - Running pre-action listener: _resource_record_pre_action 15:17:43 INFO - Running main action method: install 15:17:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:44 INFO - Reading from file tmpfile_stdout 15:17:44 INFO - Detecting whether we're running mozinstall >=1.0... 15:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:17:44 INFO - Reading from file tmpfile_stdout 15:17:44 INFO - Output received: 15:17:44 INFO - Usage: mozinstall [options] installer 15:17:44 INFO - Options: 15:17:44 INFO - -h, --help show this help message and exit 15:17:44 INFO - -d DEST, --destination=DEST 15:17:44 INFO - Directory to install application into. [default: 15:17:44 INFO - "/builds/slave/test"] 15:17:44 INFO - --app=APP Application being installed. [default: firefox] 15:17:44 INFO - mkdir: /builds/slave/test/build/application 15:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:18:16 INFO - Reading from file tmpfile_stdout 15:18:16 INFO - Output received: 15:18:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:18:16 INFO - Running post-action listener: _resource_record_post_action 15:18:16 INFO - [mozharness: 2016-12-03 23:18:16.764081Z] Finished install step (success) 15:18:16 INFO - [mozharness: 2016-12-03 23:18:16.764209Z] Running run-tests step. 15:18:16 INFO - Running pre-action listener: _resource_record_pre_action 15:18:16 INFO - Running main action method: run_tests 15:18:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:18:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:18:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:18:16 INFO - 2016-12-03 15:18:16.779 screenresolution[1633:8037] starting screenresolution argv=screenresolution get 15:18:16 INFO - 2016-12-03 15:18:16.782 screenresolution[1633:8037] Display 0: 1600x1200x32@60 15:18:16 INFO - 2016-12-03 15:18:16.787 screenresolution[1634:8039] starting screenresolution argv=screenresolution list 15:18:16 INFO - Available Modes on Display 0 15:18:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:18:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:18:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:18:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:18:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:18:17 INFO - Intel Iris: 15:18:17 INFO - Chipset Model: Intel Iris 15:18:17 INFO - Type: GPU 15:18:17 INFO - Bus: Built-In 15:18:17 INFO - VRAM (Dynamic, Max): 1536 MB 15:18:17 INFO - Vendor: Intel (0x8086) 15:18:17 INFO - Device ID: 0x0a2e 15:18:17 INFO - Revision ID: 0x0009 15:18:17 INFO - Displays: 15:18:17 INFO - Display: 15:18:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:18:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:18:17 INFO - Display Serial Number: 1600x1200 60 15:18:17 INFO - Main Display: Yes 15:18:17 INFO - Mirror: Off 15:18:17 INFO - Online: Yes 15:18:17 INFO - Rotation: Supported 15:18:17 INFO - Return code: 0 15:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:17 INFO - Python 2.7.3 15:18:17 INFO - Return code: 0 15:18:17 INFO - grabbing minidump binary from tooltool 15:18: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')]} 15:18:17 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 0x106e88d30>, '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 0x106cefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e80b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:17 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 15:18:17 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 15:18:17 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 15:18:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:17 INFO - Return code: 0 15:18:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:18:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:18:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 15:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 15:18:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq4w25c3ue/Render', 15:18:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:18:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:18:17 INFO - 'HOME': '/Users/cltbld', 15:18:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:18:17 INFO - 'LOGNAME': 'cltbld', 15:18:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:17 INFO - 'MOZ_NO_REMOTE': '1', 15:18:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:17 INFO - 'NO_EM_RESTART': '1', 15:18:17 INFO - 'PAGER': '/bin/cat', 15:18:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:17 INFO - 'PWD': '/builds/slave/test', 15:18:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:18:17 INFO - 'SHELL': '/bin/bash', 15:18:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8pWo3ylGj/Listeners', 15:18:17 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 15:18:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:18:17 INFO - 'USER': 'cltbld', 15:18:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:18:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:17 INFO - 'XPC_FLAGS': '0x0', 15:18:17 INFO - 'XPC_SERVICE_NAME': '0', 15:18:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:18:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 15:18:17 INFO - mozversion application_buildid: 20161203133838 15:18:17 INFO - mozversion application_changeset: 11d06cafe634dfa7981cfdca62c0b34d04a22a84 15:18:17 INFO - mozversion application_display_name: Nightly 15:18:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:17 INFO - mozversion application_name: Firefox 15:18:17 INFO - mozversion application_remotingname: firefox 15:18:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:18:17 INFO - mozversion application_vendor: Mozilla 15:18:17 INFO - mozversion application_version: 53.0a1 15:18:17 INFO - mozversion platform_buildid: 20161203133838 15:18:17 INFO - mozversion platform_changeset: 11d06cafe634dfa7981cfdca62c0b34d04a22a84 15:18:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:18:17 INFO - mozversion platform_version: 53.0a1 15:18:17 INFO - using testdate: 1480807097 15:18:17 INFO - actual date: 1480807097 15:18:17 INFO - starting webserver on 'localhost:49235' 15:18:17 INFO - SUITE-START | Running 2 tests 15:18:17 INFO - TEST-START | dromaeo_css 15:18:17 INFO - operating with platform_type : mac_ 15:18:17 INFO - Initialising browser for dromaeo_css test... 15:18:17 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpqUYvHD/profile http://localhost:49235/getInfo.html) 15:18:20 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 15:18:20 INFO - PROCESS | 1644 | colorDepth:24 15:18:20 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 15:18:20 INFO - PROCESS | 1644 | __metrics 15:18:20 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:18:20 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:20 INFO - TEST-INFO | 1644: exit 0 15:18:20 INFO - Browser initialized. 15:18:20 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:20 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpqUYvHD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:33 INFO - PROCESS | 1647 | RSS: Main: 242249728 15:18:33 INFO - PROCESS | 1647 | 15:19:25 INFO - PROCESS | 1647 | 1480807165237 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] 15:21:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 15:21:39 INFO - PROCESS | 1647 | RSS: Main: 391536640 15:21:39 INFO - PROCESS | 1647 | 15:24:42 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 15:24:43 INFO - PROCESS | 1647 | RSS: Main: 374018048 15:24:43 INFO - PROCESS | 1647 | 15:27:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 15:27:46 INFO - PROCESS | 1647 | RSS: Main: 344723456 15:27:46 INFO - PROCESS | 1647 | 15:30:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 15:30:49 INFO - PROCESS | 1647 | RSS: Main: 348975104 15:30:49 INFO - PROCESS | 1647 | 15:33:52 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 15:33:53 INFO - PROCESS | 1647 | RSS: Main: 337907712 15:33:53 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 15:36:56 INFO - PROCESS | 1647 | RSS: Main: 544739328 15:36:56 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | __start_tp_report 15:36:56 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 15:36:56 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 15:36:56 INFO - PROCESS | 1647 | |i|pagename|runs| 15:36:56 INFO - PROCESS | 1647 | |0;dojo.html;3254.641989381168;3274.9508757368644;3285.622153452354;3294.225856923621;3302.6036875574937;5407.161889907061;5465.9180112298345;5473.2063850741615;5534.75093620787;5542.362628297747;5444.972775136119;5492.835214943558;5557.833265002047;5582.27430434043;5596.804111856086;4955.851324460272;4995.200767877141;5007.824726134586;5047.293378926953;5067.746612669352;4864.075825593126;5097.821576244833;5103.744812759366;5147.665401748893;5177.171652535595;4939.160342741707;5085.516875896784;5090.465501122366;5112.386513618371;5176.7929282828645;4987.301777751118;5024.2212457068845;5035.093683137034;5047.823326183603;5063.0380227756605;4982.676126051795;4998.300237966688;5020.824271150492;5031.421386540558;5037.068142393632;5427.0773968425065;5519.724013799294;5529.557635389159;5532.612717109804;5583.3300003999375;5933.643981361089;5947.137665038588;5961.403859614047;5963.761449542013;5985.042393217064;5895.823125306248;6075.574709770318;6079.756809727605;6097.268327800648;6107.389261073901;5515.779368825242;5519.889602207973;5578.191162281447;5589.133684278943;5589.832305030855;6110.052941793941;6129.295131059896;6130.8377647633215;6139.293981192131;6139.308154112039;5747.568932330092;5780.277465316835;5781.103928891029;5782.872339893765;5783.4794868461195;5888.793892213752;5891.970540147272;5916.349201587822;5919.911201331984;5942.7920022799;5830.2129212555765;5844.766209351578;5852.092925596539;5857.7656893724625;5859.472647461664;5867.266591676041;5877.882442351129;5885.852853678607;5894.056950887923;5895.263092113486;4750.572448479654;4751.619870410359;4760.857174284708;4783.995360974234;4812.446568644651;4221.767802770877;4243.405923170759;4248.553901840324;4304.870853874389;4326.156399502067;5289.603279754034;5375.5162035417;5443.047466693313;5503.504684578407;5549;6030.155778191057;6059.848503787441;6068.271807383142;6071.0286354184;6100.084987251859;5570.693611851387;5571.804986825442;5584.91622625661;5600.411956744565;5603.915941260884;5099.694018358836;5177.430482646906;5226.738663066832;5233.110371236823;5266.631335806534;6107.401224262794;6132.600268413442;6140.565599444613;6149.323574406902;6150.7539698411565;5914.763409463745;6014.0678194879865;6032.245969253843;6048.0625503047095;6070.18052562916;6180.536459765625;6191.659458729813;6210.78548169328;6232.065190221503;6240.594361366679;5646.209530665628;5856.736446859987;5861.0915308127305;5869.6771677558145;5869.882602348014;5081.796728130834;5746.109353050284;5747.36778954323;5786.855328616818;5920.526357891445;5685.687287199244;5701.372848986525;5703.600747947604;5724.398938111438;5725;5646.0683987141665;5675.290588676416;5685.289338832646;5697.059985102412;5704.828855134353;5597.3003374578175;5608.775648973995;5619.213310136666;5645.40723224072;5653.095504719226;5761.711914404347;5771.480566749013;5773.711314434346;5800.738966746422;5809.24479817621;5628.802991895264;5635.154726791015;5636.323641163087;5639.859003524781;5660.349059858169 15:36:56 INFO - PROCESS | 1647 | |1;ext.html;470.75285475125554;524.0305434945352;524.0933185588931;532.3691425660593;554.967759966462;29991.10026699197;38722;39738.602613973926;39818.00454988627;42013.789931050305;41376.79311603445;41741.79129104358;41769.16461670765;41796;41838.95402614936;9355.485448300324;9521.619135234618;9531.80936381272;9542.952285238563;9553.426794392324;8443.620037098346;8678.52268125256;10979.451027448597;11381.487833047533;11399.886001140007;9654.710358689215;11515.36665483398;11523.769524609503;11524.596639117633;11546.36494992775;8474.067852536216;11378.487968041416;11448.427578621036;11453.942730286379;11463.999999999958;8557.614907329185;10483.108935740394;10723.410212438313;10756.031957123896;10758.139348852073;39190.216195676214;39488.21023579512;39505.80247098746;39527.40708889369;39584.40623390651;3185.3151572412044;3277.393682168806;3316.9040247678017;3828.1386687994977;3873.2447172801317;29632.407351852842;30114.698853011407;30402.847985760152;30428.239294017607;30781.23046923845;3129.2333378322455;3150.921226969344;3178.1419016865316;3234.9324722841643;3270.5584746059217;412558;476212;493907;494606;494814;49295.260571091465;57506;59403.702981484814;59776;59818;60978.69510652418;61170.694146528986;63253;63470.36529634737;63536.682316589046;15319.846801532065;15847.603809904844;15853.52439426819;15888.285027173804;15916.283767230503;10951.83572246417;11202.887971120348;12229.3273869938;12296.877031229753;12312.384380780924;12407.44166512509;12991.350432478339;15187.240637968058;15305.693886122215;16618;5645.5201307888465;6097.725602347905;6189.885820552344;6344.397282258178;6408.743650253938;819.9467034642729;820.4379999700225;903.4940433357209;906.4835867029354;930.1442672741094;29269.780324164323;29404.558931616044;29477.85261073681;29656.555151672743;29693.66378512972;1046.9895301046893;1077.5851297250458;1090.650991682654;1100.9724756881142;1127.21095233337;14773.33519991603;15070.924645376703;15281.847181528265;15451.61370965735;15574.922125389301;638871;644762;646844;648437;656575;45697;48335.54993350205;55697.721511392185;57139.71430142823;57223.42776572264;1297.9026573007063;1316.4207748590588;1342.2416334770824;1350.034725171507;1353.5736243083397;29994.00719137001;30723.385532288783;30835.537466937567;31185.53221701722;31511.369772604878;50615;50880.236796447345;50902.236466453774;51012.74493627508;51026.23460648019;588394;589431;589595;590060.0496997487;593719;38555.42166867555;38904.41643375295;39119;39737;39879;45397.09205815931;46229.76885115553;46504.53495465002;46676.7666161667;47335.52664473311;34633.65366346304;34791;37940.62059379371;38147.237055258185;39128.608713912494;37759.86720398392;37945;38443;38454.80772596119;38935.80532097322;37054.6294537062;37537.06157346088;38095.04762380962;38116;38169.618303816605;31572.684273157894;33109.83445082855;33262.16844578905;33287;33313.83343083269;24701.752982469945;24878.004879804605;24982.250532484053;25263.36841578975;25613.359666007753 15:36:56 INFO - PROCESS | 1647 | |2;jquery.html;352.36750033689526;361.2558130251681;363.2372018760602;372.2090557565174;401.3277759752414;14641.780373294396;14825.77761333581;15716.921415392908;19782;20335.796642033612;19079.14143863526;19355.709664355047;19477.805221947776;20145.899270503665;20360.59278814423;5558.027345214581;5821.126830975345;5823.67969761663;5829.242198514208;5835.920354734367;4576.816927322903;6384.5211609129265;6449.838754031163;6493.805185844432;6537.2482164550975;6194.225721784777;6319.17850679411;6437.613743175424;6453.612783233021;6472.223333200022;6368.554201205918;6410.455111315544;6419.775307864225;6420.101185833941;6446.129772480702;5324.361076670785;5507.228987941651;5561.110222364402;5563.276774019351;5569.888602227933;24624.753752462424;25251;25300.240992770247;25334;25576.616350754754;2277.1688333758225;2302.6776251324827;2310.688057112285;2331.9805998218285;2865.9426811463863;14522.564323070324;15232.390704371812;15546.61133471661;15977.840221597751;16103;1473.8452462491498;1513.395800451525;1517.4613012380667;1544.9487262656276;1545.0575149159004;109198;114975.85024149735;115308.54074377782;115430;115486.42256788746;8464.534450605275;10071.129728027478;10076.244281678903;10328.680729424352;10826.512806923707;12209.69475763113;13334.333283335794;13337.73324533504;13343.933280333536;13361.732765344834;7657.272559106876;7941.682332706742;8298.958505207556;8391.496510209407;8397.664093436317;7463.290987356192;8145.51126932386;8179.059408168017;8213.38399620031;8322.543554877871;5755.194272801811;5949.226600541989;6283.8114856554375;6422.74309027643;6548.607083575001;1793.8564914806784;1831.7801863776433;1847.2887938143642;1856.8421684156997;1876;642.2838535033404;717.2827172827173;925.8009527951523;937.4609599480326;957.0094951724931;19712.21151153938;21248.468788280108;21255.893720531607;21586.353901987084;21726.87548779351;906.8231694819578;926.8738482743499;932.4265576670299;953.6423841059602;977.6969139566758;9193.908060919439;10873.184511161695;11415.42922853854;11420.257683250562;11476.598319058792;529720;536851;538034;541495;551384;106184.9381506175;108983.45508272407;109136.4543177279;109242;111346;980.1276863591266;991.6479649724388;1027.671145233518;1029.351508549624;1030.99484502577;17117.05856177922;18599.53501162482;18674.439766807016;19139.947302898476;19183.752861553483;47765.283520747915;48550.271745923135;49910.50089499058;52243.216351753996;53292;50555;75014;77046.61476692805;80205.19794801978;81023;6634.701438435379;7128.215896251305;7428.33145016951;7583.336248207423;7715.884261736191;9805;10538.998795114452;11760.530643460028;11959.76080478403;12203.69490762738;5210.53105220532;5277.313949186581;10411.791764164524;10454.856754365488;10627.89372106269;10071.546780394754;10310.32982856112;10400.323978941344;10739.194560408157;10906.34561926287;10518.842217366899;10979.451027448755;11143;11281;11345.546178153112;5942.970285148546;7024.454619983596;7171.928280717126;7257.0565826442225;7412.221716719667;8980.955095224483;10491.580336786748;10734.355938643706;10735.302205356627;10742.946285268523 15:36:56 INFO - PROCESS | 1647 | |3;mootools.html;1486.5466032859977;1512.387483069357;1688.3921788156263;1846.4460661801456;1864.1145455908445;8099.473534220271;8498.1501849815;8511.191436813508;8517.488950662964;8529.530875801836;7317.6707048182825;7590;7614.543127412346;7687.154413014564;8318.667253309875;2082.9583408331823;2123.91504339827;2211.436083798629;2297.287840769367;2304.158981971577;2317.536492701458;2348.0276567683145;2348.8825558721996;2349.6710460535455;2357.705286839145;2278.851874628152;2290.141197051106;2312.9653055204185;2321.872297023663;2327.1273272522803;1903.7620297462818;2274.306336567346;2289.5535370602825;2292.2206449807145;2298.092253559851;2290.541891621666;2296.6899468571696;2310.3992961829877;2310.3992961829877;2319.5940710375617;8279.54462504562;8291.875621865616;8345.4575452596;8432.747017589481;8433.367497437655;4396.252637051677;4991.725455099968;5158.92261616076;5161.974190129063;5175;3320.6015278166774;3422.4866270059442;3452.2577645806273;3472.5312082868995;3515.156362473014;1004.1966426858484;1016.2327442780727;1035.1046344911672;1074.4305518075432;1077.0898590690854;10734.463276836204;10799.190060745475;10883.83674244879;10889.237753357269;10905.073068789163;4211.831526738957;4338.674599405057;4431.889202769892;4441.244988351988;4448.888777780581;8646.048934617187;8653.524056176971;8663.48019118855;8668.78328041804;8673.132686731402;5072.51811077947;5080.872978175576;5086.262491938648;5086.77109530072;5093.286939828427;4655.02244528646;4658.971668415489;4740.478547359788;4776.880577985578;4780.856574302777;2960.3191266008507;3357.6306606273292;3469.7397695172963;3473.7394695397443;3475.827607745159;1130.22014809781;1132.9660110196708;1134.3647557367901;1141.7830612183825;1152.7002979225463;833.2084519706182;860.7632900952163;871.5555066915919;874.5758307220992;921.9032001639731;5358.4373640767935;5473.562115030788;5497.004132747662;5572.888542229132;5598.104303311532;829.5810615639184;875.6803766625263;908.6410867707351;943.8065196634674;956.8756061711933;3653.707703383723;3672.8163591820835;3684.5210122684416;3740.6259374062374;3789.3368660484307;9767.658131965347;10072.294939354175;10148.797024059477;10160.441175735257;10168.237382196365;10091.747706307255;10101.19190464761;10104.848427273597;10106.494675266207;10113.393196408239;7359.59522226272;7705.8844117338285;7767.922320776833;7812.960935195288;7817.413693972975;5693.345265294379;5868.178455016387;5893.145493903446;5902.1441890926435;5927.525797936241;8850.468971861452;8966.596503157503;9335.393199442015;9416.764580885532;9434.716958491255;7906.486078404885;9280.071992800666;9289.16397524226;9494.955554889095;9534.85697714521;5894.793682221101;7125.35871771543;7199.71201151948;7204.9279507204255;7214.639268036683;7643.541387516767;7750.379969602531;7832.921670783448;7838.451308408356;7841.372690184886;6939.965300173467;6975.755848545276;7030.543014704028;7072.469564782559;7162.856742865218;5835.533157347487;6906.79279621592;6927.445804335742;6942.652867356713;6958.965205173941;6490.772822951174;6549.934500654933;6601.801945941629;6637.037629543593;6644.202695676549;4099.85650502231;4732.73969931657;4819.855404337735;4832.275158726219;4937.382827146606;4698.859034228979;4835.879103022312;4866.610671146371;4896.681715688469;4988.5260900214425 15:36:56 INFO - PROCESS | 1647 | |4;prototype.html;280.54271537394044;300.45017617759487;307.54944007029707;310.35755985110814;313.7631088528161;5132.43543210247;5144.122395325708;5158.716270605115;5181.766820493078;5184.859330947195;3867.65191132798;3877.1664092220167;4722.315264286676;4768.807798050488;5123.515095178845;3268.885589004385;3914.6476817086455;3945.7040721945827;3953.565107838143;4015.8795236142964;3208.8235147066903;3251.4147453458368;3431.605365382988;3715.368387374153;3985.3623420252766;3420.6237313895454;3547;3946.3685810270363;3963.5243770747406;3966.9008274793073;3595.5505561804775;3924.4701965234613;3958.5051868516434;3971.1263522024965;3979.4030895365636;2885.54280088556;3454.11919960411;3466.9306613867834;3467.4798780183173;3495.283466889307;4710.246360582325;4988.82539111133;5017.946231291433;5063.620228482841;5073.340465739467;4312.402024901905;4432.024954510002;4482.260427029536;4504.932426013613;4540.432445944257;4466.731996080213;5376.059189641797;5396.379416367129;5407.270018547485;5424;3513.6135025147214;3818.2554401891643;3825.215830754689;3827.6363745444137;3831.1571454280015;5391.975524650343;5577.776888924479;5633.605647604711;5640.746166422521;5650.717464126818;3555.7510974232073;3873.302805495038;3876.7673939563715;3877.2245550889934;3885.339492286318;3925.9792453962177;3934;3950.4074388841327;3954.980225098856;3955.248502784462;3745.569259535134;4103.507579090528;4480.260756975063;4519.276915693474;4555.749433781108;5247.868803279948;5349.812756553502;5449.700266485302;5465.754041068161;5483.945160548423;1144.8969592736694;1193.0515240383743;1247.2454165230088;1257.0013678251623;1257.220523275575;704.7772115379812;804.8350088231898;827.59447870543;862.1206369503197;872.2324354568067;4223.535411104776;4405.493368262627;4591.127685739699;4724.952750472451;5210.426853046162;5620.91568626471;5621.486570893192;5641.26663533738;5642.971785141131;5710.514606258432;4624.219675424985;4859.829905953275;5011.649184557119;5167.752027867889;5171.456997015334;2304.953900921972;2675.986620066926;2797.2587264374956;2797.762190213814;2800.493558265341;4553.61294289989;4951.5048495150195;5504.981578408007;5559.27729395176;5562.360328562187;5077.771500282496;5456.863578410492;5515.787580736166;5519.144532597454;5520;4952.950470495321;5482.533984611273;5534.889302213933;5562.582806289544;5570.855220739963;4390.934135988026;4613.538646135359;5016.749162541785;5132.897342053064;5296.602754793483;4244.8514301999285;4976.755811047238;5195.922061169161;5256.185291279858;5260.86847828792;4791.760411979457;4819.879503012453;4836.082772953919;4838.830640927691;5383.300170977748;3126.484130118596;3167.7983801258824;3172.476541370648;3462.4806279058344;3618.511500947444;4928.408590969107;5271.71005594696;5359;5393.1370980642905;5399.541039011728;4399.2521271384585;4566.648176189199;4947.3073769671555;5054.368203974504;5146.8970620588125;4601.148787474328;5116.079105760999;5155.639105262596;5169.81905633301;5169.974150129226;4279.422277992556;4886.53577910098;4962.727050012139;5048.5203905628905;5359.866003349947;4546.568076032771;5324.574034077342;5399.352077750695;5405.567554595702;5489.039418101896;4743.525647435367;5311.521963023347;5350.725941474935;5379.569634429158;5393.649412788156 15:36:56 INFO - PROCESS | 1647 | |5;yui.html;683.0437387657277;694.6283738200061;704.2851505721691;720.4668545276495;741.3365038290732;14288.428462861486;14859.885508586858;14879.479218227365;14912;14916.776248356284;13273.269970151638;13439.462421503153;13463.326833658302;13466.596002119928;13469.461221551152;658.2364457229614;678.3013496099002;681.536555142503;684.5276759036274;822.4530687093076;683.0232767142984;687.1239170058191;809.2797410304834;839.4879123734516;845.5391811462737;884.2174675412242;888.6090120347059;892.651865772346;899.8200359928007;901.085398320705;887.1483375959087;888.342626456424;889.4663202078766;891.6433426629335;892.3129190523325;522.5584381197882;670.7719375412335;671.0370618162902;672.7847088931544;672.9938741581318;11618.825717614243;13318.267495287755;13777.380017899219;13843.030987830856;14185.361658725278;13495.66260843477;14109.365078571387;14148.434062637481;14231.78652320216;14247.857521424861;10807.297525660886;10846.240763146583;10889.564417423293;10918.454077296103;11121.55513779448;3472.3576138414223;3495.475678648223;3511.701505372021;3539.150603855082;3595.982020089909;98107.0189298105;101601;102029.489852551;113248;113612.86387136189;9616.663416780379;10691.679249622524;10776.028611906486;10785.13718902486;11240.606578769704;20374.694379584318;21149;21418.464538386666;21495.247666331605;21514;7417.888731669029;7443.292887175709;7492.662830172655;7598.240175982468;7705.653245603961;3757.1922036762226;3867.903302417462;3881.7476864003747;3929.096307849211;3959.1289916218384;3463.5497385339745;3546.2021045265124;3572.3212589607892;3581.3374525712825;3583.4624806279267;503.8362532177057;536.8765184007622;537.1325309624928;643.1028714942629;646.9805905822833;561.5423429904615;595.4462350014528;606.8331208917583;626.9843253918598;644.5842431631665;8139.129742267538;8880.289576833839;8887.466751994902;8928.285737141014;9037.277017838556;524.8609118583579;532.3212903548007;597.9641221526722;631.8515148939996;639.2137670665107;3470.8893154190923;4215.59951804578;4307.8276868924895;4336.635441295307;4402.471703395549;95366.09267814744;106097;111967;117270;118629.62740745136;83133;89917.55041224752;89951.55024224837;95140;97840.51079744556;82457.51738550024;84313.57843210745;85078.57460712657;85416.14583854206;87010;9112.498812565107;9375.953120234355;9428.62285508572;9620.807583848424;9760.658376956773;41403;44637.553624464636;48212.276815847086;49279.50720492749;50478.73880529975;53715.582798773365;68492.657536712;69127.65436172989;70444;72843.27156728365;10033.799324013626;12076;12226.633201003984;12434.813477798021;12763.234205947672;14231.857681423468;14317.284135793378;14445.49440769568;14626.341814618156;14656.267186640838;13328;13421.842050550858;13492.190468571916;13580;14102.647433814236;12591.004712007758;12603.432845521791;12793.87206127964;12961.287129207607;13386.732265354443;11967.461464234304;13326.466941322238;13367.866321336662;13374.732505349644;13562.694341961693;9764.9023509764;10508.94910508943;10535;10641.680749577525;11323.943380283046;9201.677742022428;9667.758306042406;10534;11142.27575207609;11449.942750286194 15:36:56 INFO - PROCESS | 1647 | __end_tp_report 15:36:56 INFO - PROCESS | 1647 | __start_cc_report 15:36:56 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1567 15:36:56 INFO - PROCESS | 1647 | __end_cc_report 15:36:56 INFO - PROCESS | 1647 | __startTimestamp1480808216744__endTimestamp 15:36:56 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | ------- Summary: start ------- 15:36:56 INFO - PROCESS | 1647 | Number of tests: 6 15:36:56 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5507.93 Median:5639.86 stddev:592.28 (10.5%) stddev-sans-first:567.10 15:36:56 INFO - PROCESS | 1647 | Values: 3254.6 3275.0 3285.6 3294.2 3302.6 5407.2 5465.9 5473.2 5534.8 5542.4 5445.0 5492.8 5557.8 5582.3 5596.8 4955.9 4995.2 5007.8 5047.3 5067.7 4864.1 5097.8 5103.7 5147.7 5177.2 4939.2 5085.5 5090.5 5112.4 5176.8 4987.3 5024.2 5035.1 5047.8 5063.0 4982.7 4998.3 5020.8 5031.4 5037.1 5427.1 5519.7 5529.6 5532.6 5583.3 5933.6 5947.1 5961.4 5963.8 5985.0 5895.8 6075.6 6079.8 6097.3 6107.4 5515.8 5519.9 5578.2 5589.1 5589.8 6110.1 6129.3 6130.8 6139.3 6139.3 5747.6 5780.3 5781.1 5782.9 5783.5 5888.8 5892.0 5916.3 5919.9 5942.8 5830.2 5844.8 5852.1 5857.8 5859.5 5867.3 5877.9 5885.9 5894.1 5895.3 4750.6 4751.6 4760.9 4784.0 4812.4 4221.8 4243.4 4248.6 4304.9 4326.2 5289.6 5375.5 5443.0 5503.5 5549.0 6030.2 6059.8 6068.3 6071.0 6100.1 5570.7 5571.8 5584.9 5600.4 5603.9 5099.7 5177.4 5226.7 5233.1 5266.6 6107.4 6132.6 6140.6 6149.3 6150.8 5914.8 6014.1 6032.2 6048.1 6070.2 6180.5 6191.7 6210.8 6232.1 6240.6 5646.2 5856.7 5861.1 5869.7 5869.9 5081.8 5746.1 5747.4 5786.9 5920.5 5685.7 5701.4 5703.6 5724.4 5725.0 5646.1 5675.3 5685.3 5697.1 5704.8 5597.3 5608.8 5619.2 5645.4 5653.1 5761.7 5771.5 5773.7 5800.7 5809.2 5628.8 5635.2 5636.3 5639.9 5660.3 15:36:56 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:70208.69 Median:21135.57 stddev:153814.56 (727.8%) stddev-sans-first:154156.93 15:36:56 INFO - PROCESS | 1647 | Values: 470.8 524.0 524.1 532.4 555.0 29991.1 38722.0 39738.6 39818.0 42013.8 41376.8 41741.8 41769.2 41796.0 41839.0 9355.5 9521.6 9531.8 9543.0 9553.4 8443.6 8678.5 10979.5 11381.5 11399.9 9654.7 11515.4 11523.8 11524.6 11546.4 8474.1 11378.5 11448.4 11453.9 11464.0 8557.6 10483.1 10723.4 10756.0 10758.1 39190.2 39488.2 39505.8 39527.4 39584.4 3185.3 3277.4 3316.9 3828.1 3873.2 29632.4 30114.7 30402.8 30428.2 30781.2 3129.2 3150.9 3178.1 3234.9 3270.6 412558.0 476212.0 493907.0 494606.0 494814.0 49295.3 57506.0 59403.7 59776.0 59818.0 60978.7 61170.7 63253.0 63470.4 63536.7 15319.8 15847.6 15853.5 15888.3 15916.3 10951.8 11202.9 12229.3 12296.9 12312.4 12407.4 12991.4 15187.2 15305.7 16618.0 5645.5 6097.7 6189.9 6344.4 6408.7 819.9 820.4 903.5 906.5 930.1 29269.8 29404.6 29477.9 29656.6 29693.7 1047.0 1077.6 1090.7 1101.0 1127.2 14773.3 15070.9 15281.8 15451.6 15574.9 638871.0 644762.0 646844.0 648437.0 656575.0 45697.0 48335.5 55697.7 57139.7 57223.4 1297.9 1316.4 1342.2 1350.0 1353.6 29994.0 30723.4 30835.5 31185.5 31511.4 50615.0 50880.2 50902.2 51012.7 51026.2 588394.0 589431.0 589595.0 590060.0 593719.0 38555.4 38904.4 39119.0 39737.0 39879.0 45397.1 46229.8 46504.5 46676.8 47335.5 34633.7 34791.0 37940.6 38147.2 39128.6 37759.9 37945.0 38443.0 38454.8 38935.8 37054.6 37537.1 38095.0 38116.0 38169.6 31572.7 33109.8 33262.2 33287.0 33313.8 24701.8 24878.0 24982.3 25263.4 25613.4 15:36:56 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:32332.80 Median:14221.28 stddev:90017.11 (633.0%) stddev-sans-first:90237.61 15:36:56 INFO - PROCESS | 1647 | Values: 352.4 361.3 363.2 372.2 401.3 14641.8 14825.8 15716.9 19782.0 20335.8 19079.1 19355.7 19477.8 20145.9 20360.6 5558.0 5821.1 5823.7 5829.2 5835.9 4576.8 6384.5 6449.8 6493.8 6537.2 6194.2 6319.2 6437.6 6453.6 6472.2 6368.6 6410.5 6419.8 6420.1 6446.1 5324.4 5507.2 5561.1 5563.3 5569.9 24624.8 25251.0 25300.2 25334.0 25576.6 2277.2 2302.7 2310.7 2332.0 2865.9 14522.6 15232.4 15546.6 15977.8 16103.0 1473.8 1513.4 1517.5 1544.9 1545.1 109198.0 114975.9 115308.5 115430.0 115486.4 8464.5 10071.1 10076.2 10328.7 10826.5 12209.7 13334.3 13337.7 13343.9 13361.7 7657.3 7941.7 8299.0 8391.5 8397.7 7463.3 8145.5 8179.1 8213.4 8322.5 5755.2 5949.2 6283.8 6422.7 6548.6 1793.9 1831.8 1847.3 1856.8 1876.0 642.3 717.3 925.8 937.5 957.0 19712.2 21248.5 21255.9 21586.4 21726.9 906.8 926.9 932.4 953.6 977.7 9193.9 10873.2 11415.4 11420.3 11476.6 529720.0 536851.0 538034.0 541495.0 551384.0 106184.9 108983.5 109136.5 109242.0 111346.0 980.1 991.6 1027.7 1029.4 1031.0 17117.1 18599.5 18674.4 19139.9 19183.8 47765.3 48550.3 49910.5 52243.2 53292.0 50555.0 75014.0 77046.6 80205.2 81023.0 6634.7 7128.2 7428.3 7583.3 7715.9 9805.0 10539.0 11760.5 11959.8 12203.7 5210.5 5277.3 10411.8 10454.9 10627.9 10071.5 10310.3 10400.3 10739.2 10906.3 10518.8 10979.5 11143.0 11281.0 11345.5 5943.0 7024.5 7171.9 7257.1 7412.2 8981.0 10491.6 10734.4 10735.3 10742.9 15:36:56 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5354.38 Median:5032.12 stddev:2943.91 (58.5%) stddev-sans-first:2937.82 15:36:56 INFO - PROCESS | 1647 | Values: 1486.5 1512.4 1688.4 1846.4 1864.1 8099.5 8498.2 8511.2 8517.5 8529.5 7317.7 7590.0 7614.5 7687.2 8318.7 2083.0 2123.9 2211.4 2297.3 2304.2 2317.5 2348.0 2348.9 2349.7 2357.7 2278.9 2290.1 2313.0 2321.9 2327.1 1903.8 2274.3 2289.6 2292.2 2298.1 2290.5 2296.7 2310.4 2310.4 2319.6 8279.5 8291.9 8345.5 8432.7 8433.4 4396.3 4991.7 5158.9 5162.0 5175.0 3320.6 3422.5 3452.3 3472.5 3515.2 1004.2 1016.2 1035.1 1074.4 1077.1 10734.5 10799.2 10883.8 10889.2 10905.1 4211.8 4338.7 4431.9 4441.2 4448.9 8646.0 8653.5 8663.5 8668.8 8673.1 5072.5 5080.9 5086.3 5086.8 5093.3 4655.0 4659.0 4740.5 4776.9 4780.9 2960.3 3357.6 3469.7 3473.7 3475.8 1130.2 1133.0 1134.4 1141.8 1152.7 833.2 860.8 871.6 874.6 921.9 5358.4 5473.6 5497.0 5572.9 5598.1 829.6 875.7 908.6 943.8 956.9 3653.7 3672.8 3684.5 3740.6 3789.3 9767.7 10072.3 10148.8 10160.4 10168.2 10091.7 10101.2 10104.8 10106.5 10113.4 7359.6 7705.9 7767.9 7813.0 7817.4 5693.3 5868.2 5893.1 5902.1 5927.5 8850.5 8966.6 9335.4 9416.8 9434.7 7906.5 9280.1 9289.2 9495.0 9534.9 5894.8 7125.4 7199.7 7204.9 7214.6 7643.5 7750.4 7832.9 7838.5 7841.4 6940.0 6975.8 7030.5 7072.5 7162.9 5835.5 6906.8 6927.4 6942.7 6959.0 6490.8 6549.9 6601.8 6637.0 6644.2 4099.9 4732.7 4819.9 4832.3 4937.4 4698.9 4835.9 4866.6 4896.7 4988.5 15:36:56 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4287.60 Median:4780.28 stddev:1315.70 (27.5%) stddev-sans-first:1284.56 15:36:56 INFO - PROCESS | 1647 | Values: 280.5 300.5 307.5 310.4 313.8 5132.4 5144.1 5158.7 5181.8 5184.9 3867.7 3877.2 4722.3 4768.8 5123.5 3268.9 3914.6 3945.7 3953.6 4015.9 3208.8 3251.4 3431.6 3715.4 3985.4 3420.6 3547.0 3946.4 3963.5 3966.9 3595.6 3924.5 3958.5 3971.1 3979.4 2885.5 3454.1 3466.9 3467.5 3495.3 4710.2 4988.8 5017.9 5063.6 5073.3 4312.4 4432.0 4482.3 4504.9 4540.4 4466.7 5376.1 5396.4 5407.3 5424.0 3513.6 3818.3 3825.2 3827.6 3831.2 5392.0 5577.8 5633.6 5640.7 5650.7 3555.8 3873.3 3876.8 3877.2 3885.3 3926.0 3934.0 3950.4 3955.0 3955.2 3745.6 4103.5 4480.3 4519.3 4555.7 5247.9 5349.8 5449.7 5465.8 5483.9 1144.9 1193.1 1247.2 1257.0 1257.2 704.8 804.8 827.6 862.1 872.2 4223.5 4405.5 4591.1 4725.0 5210.4 5620.9 5621.5 5641.3 5643.0 5710.5 4624.2 4859.8 5011.6 5167.8 5171.5 2305.0 2676.0 2797.3 2797.8 2800.5 4553.6 4951.5 5505.0 5559.3 5562.4 5077.8 5456.9 5515.8 5519.1 5520.0 4953.0 5482.5 5534.9 5562.6 5570.9 4390.9 4613.5 5016.7 5132.9 5296.6 4244.9 4976.8 5195.9 5256.2 5260.9 4791.8 4819.9 4836.1 4838.8 5383.3 3126.5 3167.8 3172.5 3462.5 3618.5 4928.4 5271.7 5359.0 5393.1 5399.5 4399.3 4566.6 4947.3 5054.4 5146.9 4601.1 5116.1 5155.6 5169.8 5170.0 4279.4 4886.5 4962.7 5048.5 5359.9 4546.6 5324.6 5399.4 5405.6 5489.0 4743.5 5311.5 5350.7 5379.6 5393.6 15:36:56 INFO - PROCESS | 1647 | 15:36:56 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:20494.77 Median:22809.30 stddev:30520.38 (133.8%) stddev-sans-first:30569.74 15:36:56 INFO - PROCESS | 1647 | Values: 683.0 694.6 704.3 720.5 741.3 14288.4 14859.9 14879.5 14912.0 14916.8 13273.3 13439.5 13463.3 13466.6 13469.5 658.2 678.3 681.5 684.5 822.5 683.0 687.1 809.3 839.5 845.5 884.2 888.6 892.7 899.8 901.1 887.1 888.3 889.5 891.6 892.3 522.6 670.8 671.0 672.8 673.0 11618.8 13318.3 13777.4 13843.0 14185.4 13495.7 14109.4 14148.4 14231.8 14247.9 10807.3 10846.2 10889.6 10918.5 11121.6 3472.4 3495.5 3511.7 3539.2 3596.0 98107.0 101601.0 102029.5 113248.0 113612.9 9616.7 10691.7 10776.0 10785.1 11240.6 20374.7 21149.0 21418.5 21495.2 21514.0 7417.9 7443.3 7492.7 7598.2 7705.7 3757.2 3867.9 3881.7 3929.1 3959.1 3463.5 3546.2 3572.3 3581.3 3583.5 503.8 536.9 537.1 643.1 647.0 561.5 595.4 606.8 627.0 644.6 8139.1 8880.3 8887.5 8928.3 9037.3 524.9 532.3 598.0 631.9 639.2 3470.9 4215.6 4307.8 4336.6 4402.5 95366.1 106097.0 111967.0 117270.0 118629.6 83133.0 89917.6 89951.6 95140.0 97840.5 82457.5 84313.6 85078.6 85416.1 87010.0 9112.5 9376.0 9428.6 9620.8 9760.7 41403.0 44637.6 48212.3 49279.5 50478.7 53715.6 68492.7 69127.7 70444.0 72843.3 10033.8 12076.0 12226.6 12434.8 12763.2 14231.9 14317.3 14445.5 14626.3 14656.3 13328.0 13421.8 13492.2 13580.0 14102.6 12591.0 12603.4 12793.9 12961.3 13386.7 11967.5 13326.5 13367.9 13374.7 13562.7 9764.9 10508.9 10535.0 10641.7 11323.9 9201.7 9667.8 10534.0 11142.3 11449.9 15:36:56 INFO - PROCESS | 1647 | -------- Summary: end -------- 15:36:56 INFO - PROCESS | 1647 | 15:36:57 INFO - TEST-INFO | 1647: exit 0 15:36:57 INFO - TEST-OK | dromaeo_css | took 1120068ms 15:36:57 INFO - TEST-START | kraken 15:36:57 INFO - operating with platform_type : mac_ 15:36:57 INFO - Initialising browser for kraken test... 15:36:57 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpe4t_K8/profile http://localhost:49235/getInfo.html) 15:37:00 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 15:37:00 INFO - PROCESS | 1653 | colorDepth:24 15:37:00 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 15:37:00 INFO - PROCESS | 1653 | __metrics 15:37:00 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:37:00 INFO - PROCESS | 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:37:01 INFO - TEST-INFO | 1653: exit 0 15:37:01 INFO - Browser initialized. 15:37:01 INFO - Running cycle 1/1 for kraken test... 15:37:01 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpe4t_K8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:13 INFO - PROCESS | 1654 | RSS: Main: 234987520 15:37:13 INFO - PROCESS | 1654 | 15:37:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:17 INFO - PROCESS | 1654 | RSS: Main: 294510592 15:37:17 INFO - PROCESS | 1654 | 15:37:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 15:37:20 INFO - PROCESS | 1654 | RSS: Main: 297132032 15:37:20 INFO - PROCESS | 1654 | 15:37:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 15:37:24 INFO - PROCESS | 1654 | RSS: Main: 392224768 15:37:24 INFO - PROCESS | 1654 | 15:37:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 15:37:27 INFO - PROCESS | 1654 | RSS: Main: 292012032 15:37:27 INFO - PROCESS | 1654 | 15:37:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:29 INFO - PROCESS | 1654 | RSS: Main: 295555072 15:37:29 INFO - PROCESS | 1654 | 15:37:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:33 INFO - PROCESS | 1654 | RSS: Main: 337944576 15:37:33 INFO - PROCESS | 1654 | 15:37:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:36 INFO - PROCESS | 1654 | RSS: Main: 338915328 15:37:36 INFO - PROCESS | 1654 | 15:37:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 15:37:40 INFO - PROCESS | 1654 | RSS: Main: 335917056 15:37:40 INFO - PROCESS | 1654 | 15:37:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:37:42 INFO - PROCESS | 1654 | RSS: Main: 310009856 15:37:42 INFO - PROCESS | 1654 | 15:37:44 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:37:44 INFO - PROCESS | 1654 | RSS: Main: 313053184 15:37:44 INFO - PROCESS | 1654 | 15:37:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:37:47 INFO - PROCESS | 1654 | RSS: Main: 314638336 15:37:47 INFO - PROCESS | 1654 | 15:37:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:37:51 INFO - PROCESS | 1654 | RSS: Main: 331423744 15:37:51 INFO - PROCESS | 1654 | 15:37:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:55 INFO - PROCESS | 1654 | RSS: Main: 325255168 15:37:55 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 15:37:56 INFO - PROCESS | 1654 | RSS: Main: 369233920 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | __start_tp_report 15:37:56 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 15:37:56 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 15:37:56 INFO - PROCESS | 1654 | |i|pagename|runs| 15:37:56 INFO - PROCESS | 1654 | |0;ai-astar;103;113;114;113;113;114;113;112;115;112 15:37:56 INFO - PROCESS | 1654 | |1;audio-beat-detection;150;116;114;152;114;115;117;139;138;115 15:37:56 INFO - PROCESS | 1654 | |2;audio-dft;257;264;207;184;179;182;181;219;265;184 15:37:56 INFO - PROCESS | 1654 | |3;audio-fft;77;59;61;86;62;59;59;74;97;77 15:37:56 INFO - PROCESS | 1654 | |4;audio-oscillator;89;70;84;69;69;70;81;68;69;86 15:37:56 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;87;84;88;83;87;84;86;83;87;83 15:37:56 INFO - PROCESS | 1654 | |6;imaging-darkroom;94;93;93;93;93;93;93;94;95;92 15:37:56 INFO - PROCESS | 1654 | |7;imaging-desaturate;124;131;92;85;85;85;85;90;86;86 15:37:56 INFO - PROCESS | 1654 | |8;json-parse-financial;56;57;53;53;54;55;55;55;55;54 15:37:56 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;66;72;67;78;73;68;69;69;69;70 15:37:56 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;89;87;89;86;88;88;86;86;87;90 15:37:56 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;152;152;145;150;147;145;149;148;187;161 15:37:56 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;175;179;175;173;175;175;172;171;174;173 15:37:56 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;71;68;70;69;68;68;69;70;69;68 15:37:56 INFO - PROCESS | 1654 | __end_tp_report 15:37:56 INFO - PROCESS | 1654 | __start_cc_report 15:37:56 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1970 15:37:56 INFO - PROCESS | 1654 | __end_cc_report 15:37:56 INFO - PROCESS | 1654 | __startTimestamp1480808276985__endTimestamp 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | ------- Summary: start ------- 15:37:56 INFO - PROCESS | 1654 | Number of tests: 14 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.36 (3.0%) stddev-sans-first:0.97 15:37:56 INFO - PROCESS | 1654 | Values: 103.0 113.0 114.0 113.0 113.0 114.0 113.0 112.0 115.0 112.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:127.00 Median:127.50 stddev:15.87 (12.4%) stddev-sans-first:14.48 15:37:56 INFO - PROCESS | 1654 | Values: 150.0 116.0 114.0 152.0 114.0 115.0 117.0 139.0 138.0 115.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:212.20 Median:213.00 stddev:36.71 (17.2%) stddev-sans-first:35.18 15:37:56 INFO - PROCESS | 1654 | Values: 257.0 264.0 207.0 184.0 179.0 182.0 181.0 219.0 265.0 184.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:71.10 Median:75.50 stddev:13.31 (17.6%) stddev-sans-first:13.95 15:37:56 INFO - PROCESS | 1654 | Values: 77.0 59.0 61.0 86.0 62.0 59.0 59.0 74.0 97.0 77.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:75.50 stddev:8.42 (11.2%) stddev-sans-first:7.38 15:37:56 INFO - PROCESS | 1654 | Values: 89.0 70.0 84.0 69.0 69.0 70.0 81.0 68.0 69.0 86.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.50 stddev:1.99 (2.3%) stddev-sans-first:2.00 15:37:56 INFO - PROCESS | 1654 | Values: 87.0 84.0 88.0 83.0 87.0 84.0 86.0 83.0 87.0 83.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 15:37:56 INFO - PROCESS | 1654 | Values: 94.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 95.0 92.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:85.50 stddev:17.43 (20.4%) stddev-sans-first:14.97 15:37:56 INFO - PROCESS | 1654 | Values: 124.0 131.0 92.0 85.0 85.0 85.0 85.0 90.0 86.0 86.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.24 15:37:56 INFO - PROCESS | 1654 | Values: 56.0 57.0 53.0 53.0 54.0 55.0 55.0 55.0 55.0 54.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:69.50 stddev:3.48 (5.0%) stddev-sans-first:3.36 15:37:56 INFO - PROCESS | 1654 | Values: 66.0 72.0 67.0 78.0 73.0 68.0 69.0 69.0 69.0 70.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.00 stddev:1.43 (1.6%) stddev-sans-first:1.42 15:37:56 INFO - PROCESS | 1654 | Values: 89.0 87.0 89.0 86.0 88.0 88.0 86.0 86.0 87.0 90.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:151.00 stddev:12.62 (8.4%) stddev-sans-first:13.37 15:37:56 INFO - PROCESS | 1654 | Values: 152.0 152.0 145.0 150.0 147.0 145.0 149.0 148.0 187.0 161.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:175.00 stddev:2.20 (1.3%) stddev-sans-first:2.32 15:37:56 INFO - PROCESS | 1654 | Values: 175.0 179.0 175.0 173.0 175.0 175.0 172.0 171.0 174.0 173.0 15:37:56 INFO - PROCESS | 1654 | 15:37:56 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.05 (1.5%) stddev-sans-first:0.83 15:37:56 INFO - PROCESS | 1654 | Values: 71.0 68.0 70.0 69.0 68.0 68.0 69.0 70.0 69.0 68.0 15:37:56 INFO - PROCESS | 1654 | -------- Summary: end -------- 15:37:56 INFO - PROCESS | 1654 | 15:37:58 INFO - TEST-INFO | 1654: exit 0 15:37:58 INFO - TEST-OK | kraken | took 60621ms 15:37:58 INFO - SUITE-END | took 1180s 15:37:58 INFO - Completed test suite (00:19:40) 15:37:58 INFO - javascript benchmark 15:37:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.641989381168, 3274.9508757368644, 3285.622153452354, 3294.225856923621, 3302.6036875574937, 5407.161889907061, 5465.9180112298345, 5473.2063850741615, 5534.75093620787, 5542.362628297747, 5444.972775136119, 5492.835214943558, 5557.833265002047, 5582.27430434043, 5596.804111856086, 4955.851324460272, 4995.200767877141, 5007.824726134586, 5047.293378926953, 5067.746612669352, 4864.075825593126, 5097.821576244833, 5103.744812759366, 5147.665401748893, 5177.171652535595, 4939.160342741707, 5085.516875896784, 5090.465501122366, 5112.386513618371, 5176.7929282828645, 4987.301777751118, 5024.2212457068845, 5035.093683137034, 5047.823326183603, 5063.0380227756605, 4982.676126051795, 4998.300237966688, 5020.824271150492, 5031.421386540558, 5037.068142393632, 5427.0773968425065, 5519.724013799294, 5529.557635389159, 5532.612717109804, 5583.3300003999375, 5933.643981361089, 5947.137665038588, 5961.403859614047, 5963.761449542013, 5985.042393217064, 5895.823125306248, 6075.574709770318, 6079.756809727605, 6097.268327800648, 6107.389261073901, 5515.779368825242, 5519.889602207973, 5578.191162281447, 5589.133684278943, 5589.832305030855, 6110.052941793941, 6129.295131059896, 6130.8377647633215, 6139.293981192131, 6139.308154112039, 5747.568932330092, 5780.277465316835, 5781.103928891029, 5782.872339893765, 5783.4794868461195, 5888.793892213752, 5891.970540147272, 5916.349201587822, 5919.911201331984, 5942.7920022799, 5830.2129212555765, 5844.766209351578, 5852.092925596539, 5857.7656893724625, 5859.472647461664, 5867.266591676041, 5877.882442351129, 5885.852853678607, 5894.056950887923, 5895.263092113486, 4750.572448479654, 4751.619870410359, 4760.857174284708, 4783.995360974234, 4812.446568644651, 4221.767802770877, 4243.405923170759, 4248.553901840324, 4304.870853874389, 4326.156399502067, 5289.603279754034, 5375.5162035417, 5443.047466693313, 5503.504684578407, 5549.0, 6030.155778191057, 6059.848503787441, 6068.271807383142, 6071.0286354184, 6100.084987251859, 5570.693611851387, 5571.804986825442, 5584.91622625661, 5600.411956744565, 5603.915941260884, 5099.694018358836, 5177.430482646906, 5226.738663066832, 5233.110371236823, 5266.631335806534, 6107.401224262794, 6132.600268413442, 6140.565599444613, 6149.323574406902, 6150.7539698411565, 5914.763409463745, 6014.0678194879865, 6032.245969253843, 6048.0625503047095, 6070.18052562916, 6180.536459765625, 6191.659458729813, 6210.78548169328, 6232.065190221503, 6240.594361366679, 5646.209530665628, 5856.736446859987, 5861.0915308127305, 5869.6771677558145, 5869.882602348014, 5081.796728130834, 5746.109353050284, 5747.36778954323, 5786.855328616818, 5920.526357891445, 5685.687287199244, 5701.372848986525, 5703.600747947604, 5724.398938111438, 5725.0, 5646.0683987141665, 5675.290588676416, 5685.289338832646, 5697.059985102412, 5704.828855134353, 5597.3003374578175, 5608.775648973995, 5619.213310136666, 5645.40723224072, 5653.095504719226, 5761.711914404347, 5771.480566749013, 5773.711314434346, 5800.738966746422, 5809.24479817621, 5628.802991895264, 5635.154726791015, 5636.323641163087, 5639.859003524781, 5660.349059858169], "value": 5470.909440253171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.75285475125554, 524.0305434945352, 524.0933185588931, 532.3691425660593, 554.967759966462, 29991.10026699197, 38722.0, 39738.602613973926, 39818.00454988627, 42013.789931050305, 41376.79311603445, 41741.79129104358, 41769.16461670765, 41796.0, 41838.95402614936, 9355.485448300324, 9521.619135234618, 9531.80936381272, 9542.952285238563, 9553.426794392324, 8443.620037098346, 8678.52268125256, 10979.451027448597, 11381.487833047533, 11399.886001140007, 9654.710358689215, 11515.36665483398, 11523.769524609503, 11524.596639117633, 11546.36494992775, 8474.067852536216, 11378.487968041416, 11448.427578621036, 11453.942730286379, 11463.999999999958, 8557.614907329185, 10483.108935740394, 10723.410212438313, 10756.031957123896, 10758.139348852073, 39190.216195676214, 39488.21023579512, 39505.80247098746, 39527.40708889369, 39584.40623390651, 3185.3151572412044, 3277.393682168806, 3316.9040247678017, 3828.1386687994977, 3873.2447172801317, 29632.407351852842, 30114.698853011407, 30402.847985760152, 30428.239294017607, 30781.23046923845, 3129.2333378322455, 3150.921226969344, 3178.1419016865316, 3234.9324722841643, 3270.5584746059217, 412558.0, 476212.0, 493907.0, 494606.0, 494814.0, 49295.260571091465, 57506.0, 59403.702981484814, 59776.0, 59818.0, 60978.69510652418, 61170.694146528986, 63253.0, 63470.36529634737, 63536.682316589046, 15319.846801532065, 15847.603809904844, 15853.52439426819, 15888.285027173804, 15916.283767230503, 10951.83572246417, 11202.887971120348, 12229.3273869938, 12296.877031229753, 12312.384380780924, 12407.44166512509, 12991.350432478339, 15187.240637968058, 15305.693886122215, 16618.0, 5645.5201307888465, 6097.725602347905, 6189.885820552344, 6344.397282258178, 6408.743650253938, 819.9467034642729, 820.4379999700225, 903.4940433357209, 906.4835867029354, 930.1442672741094, 29269.780324164323, 29404.558931616044, 29477.85261073681, 29656.555151672743, 29693.66378512972, 1046.9895301046893, 1077.5851297250458, 1090.650991682654, 1100.9724756881142, 1127.21095233337, 14773.33519991603, 15070.924645376703, 15281.847181528265, 15451.61370965735, 15574.922125389301, 638871.0, 644762.0, 646844.0, 648437.0, 656575.0, 45697.0, 48335.54993350205, 55697.721511392185, 57139.71430142823, 57223.42776572264, 1297.9026573007063, 1316.4207748590588, 1342.2416334770824, 1350.034725171507, 1353.5736243083397, 29994.00719137001, 30723.385532288783, 30835.537466937567, 31185.53221701722, 31511.369772604878, 50615.0, 50880.236796447345, 50902.236466453774, 51012.74493627508, 51026.23460648019, 588394.0, 589431.0, 589595.0, 590060.0496997487, 593719.0, 38555.42166867555, 38904.41643375295, 39119.0, 39737.0, 39879.0, 45397.09205815931, 46229.76885115553, 46504.53495465002, 46676.7666161667, 47335.52664473311, 34633.65366346304, 34791.0, 37940.62059379371, 38147.237055258185, 39128.608713912494, 37759.86720398392, 37945.0, 38443.0, 38454.80772596119, 38935.80532097322, 37054.6294537062, 37537.06157346088, 38095.04762380962, 38116.0, 38169.618303816605, 31572.684273157894, 33109.83445082855, 33262.16844578905, 33287.0, 33313.83343083269, 24701.752982469945, 24878.004879804605, 24982.250532484053, 25263.36841578975, 25613.359666007753], "value": 19868.69331743585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.36750033689526, 361.2558130251681, 363.2372018760602, 372.2090557565174, 401.3277759752414, 14641.780373294396, 14825.77761333581, 15716.921415392908, 19782.0, 20335.796642033612, 19079.14143863526, 19355.709664355047, 19477.805221947776, 20145.899270503665, 20360.59278814423, 5558.027345214581, 5821.126830975345, 5823.67969761663, 5829.242198514208, 5835.920354734367, 4576.816927322903, 6384.5211609129265, 6449.838754031163, 6493.805185844432, 6537.2482164550975, 6194.225721784777, 6319.17850679411, 6437.613743175424, 6453.612783233021, 6472.223333200022, 6368.554201205918, 6410.455111315544, 6419.775307864225, 6420.101185833941, 6446.129772480702, 5324.361076670785, 5507.228987941651, 5561.110222364402, 5563.276774019351, 5569.888602227933, 24624.753752462424, 25251.0, 25300.240992770247, 25334.0, 25576.616350754754, 2277.1688333758225, 2302.6776251324827, 2310.688057112285, 2331.9805998218285, 2865.9426811463863, 14522.564323070324, 15232.390704371812, 15546.61133471661, 15977.840221597751, 16103.0, 1473.8452462491498, 1513.395800451525, 1517.4613012380667, 1544.9487262656276, 1545.0575149159004, 109198.0, 114975.85024149735, 115308.54074377782, 115430.0, 115486.42256788746, 8464.534450605275, 10071.129728027478, 10076.244281678903, 10328.680729424352, 10826.512806923707, 12209.69475763113, 13334.333283335794, 13337.73324533504, 13343.933280333536, 13361.732765344834, 7657.272559106876, 7941.682332706742, 8298.958505207556, 8391.496510209407, 8397.664093436317, 7463.290987356192, 8145.51126932386, 8179.059408168017, 8213.38399620031, 8322.543554877871, 5755.194272801811, 5949.226600541989, 6283.8114856554375, 6422.74309027643, 6548.607083575001, 1793.8564914806784, 1831.7801863776433, 1847.2887938143642, 1856.8421684156997, 1876.0, 642.2838535033404, 717.2827172827173, 925.8009527951523, 937.4609599480326, 957.0094951724931, 19712.21151153938, 21248.468788280108, 21255.893720531607, 21586.353901987084, 21726.87548779351, 906.8231694819578, 926.8738482743499, 932.4265576670299, 953.6423841059602, 977.6969139566758, 9193.908060919439, 10873.184511161695, 11415.42922853854, 11420.257683250562, 11476.598319058792, 529720.0, 536851.0, 538034.0, 541495.0, 551384.0, 106184.9381506175, 108983.45508272407, 109136.4543177279, 109242.0, 111346.0, 980.1276863591266, 991.6479649724388, 1027.671145233518, 1029.351508549624, 1030.99484502577, 17117.05856177922, 18599.53501162482, 18674.439766807016, 19139.947302898476, 19183.752861553483, 47765.283520747915, 48550.271745923135, 49910.50089499058, 52243.216351753996, 53292.0, 50555.0, 75014.0, 77046.61476692805, 80205.19794801978, 81023.0, 6634.701438435379, 7128.215896251305, 7428.33145016951, 7583.336248207423, 7715.884261736191, 9805.0, 10538.998795114452, 11760.530643460028, 11959.76080478403, 12203.69490762738, 5210.53105220532, 5277.313949186581, 10411.791764164524, 10454.856754365488, 10627.89372106269, 10071.546780394754, 10310.32982856112, 10400.323978941344, 10739.194560408157, 10906.34561926287, 10518.842217366899, 10979.451027448755, 11143.0, 11281.0, 11345.546178153112, 5942.970285148546, 7024.454619983596, 7171.928280717126, 7257.0565826442225, 7412.221716719667, 8980.955095224483, 10491.580336786748, 10734.355938643706, 10735.302205356627, 10742.946285268523], "value": 9273.731861147164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.5466032859977, 1512.387483069357, 1688.3921788156263, 1846.4460661801456, 1864.1145455908445, 8099.473534220271, 8498.1501849815, 8511.191436813508, 8517.488950662964, 8529.530875801836, 7317.6707048182825, 7590.0, 7614.543127412346, 7687.154413014564, 8318.667253309875, 2082.9583408331823, 2123.91504339827, 2211.436083798629, 2297.287840769367, 2304.158981971577, 2317.536492701458, 2348.0276567683145, 2348.8825558721996, 2349.6710460535455, 2357.705286839145, 2278.851874628152, 2290.141197051106, 2312.9653055204185, 2321.872297023663, 2327.1273272522803, 1903.7620297462818, 2274.306336567346, 2289.5535370602825, 2292.2206449807145, 2298.092253559851, 2290.541891621666, 2296.6899468571696, 2310.3992961829877, 2310.3992961829877, 2319.5940710375617, 8279.54462504562, 8291.875621865616, 8345.4575452596, 8432.747017589481, 8433.367497437655, 4396.252637051677, 4991.725455099968, 5158.92261616076, 5161.974190129063, 5175.0, 3320.6015278166774, 3422.4866270059442, 3452.2577645806273, 3472.5312082868995, 3515.156362473014, 1004.1966426858484, 1016.2327442780727, 1035.1046344911672, 1074.4305518075432, 1077.0898590690854, 10734.463276836204, 10799.190060745475, 10883.83674244879, 10889.237753357269, 10905.073068789163, 4211.831526738957, 4338.674599405057, 4431.889202769892, 4441.244988351988, 4448.888777780581, 8646.048934617187, 8653.524056176971, 8663.48019118855, 8668.78328041804, 8673.132686731402, 5072.51811077947, 5080.872978175576, 5086.262491938648, 5086.77109530072, 5093.286939828427, 4655.02244528646, 4658.971668415489, 4740.478547359788, 4776.880577985578, 4780.856574302777, 2960.3191266008507, 3357.6306606273292, 3469.7397695172963, 3473.7394695397443, 3475.827607745159, 1130.22014809781, 1132.9660110196708, 1134.3647557367901, 1141.7830612183825, 1152.7002979225463, 833.2084519706182, 860.7632900952163, 871.5555066915919, 874.5758307220992, 921.9032001639731, 5358.4373640767935, 5473.562115030788, 5497.004132747662, 5572.888542229132, 5598.104303311532, 829.5810615639184, 875.6803766625263, 908.6410867707351, 943.8065196634674, 956.8756061711933, 3653.707703383723, 3672.8163591820835, 3684.5210122684416, 3740.6259374062374, 3789.3368660484307, 9767.658131965347, 10072.294939354175, 10148.797024059477, 10160.441175735257, 10168.237382196365, 10091.747706307255, 10101.19190464761, 10104.848427273597, 10106.494675266207, 10113.393196408239, 7359.59522226272, 7705.8844117338285, 7767.922320776833, 7812.960935195288, 7817.413693972975, 5693.345265294379, 5868.178455016387, 5893.145493903446, 5902.1441890926435, 5927.525797936241, 8850.468971861452, 8966.596503157503, 9335.393199442015, 9416.764580885532, 9434.716958491255, 7906.486078404885, 9280.071992800666, 9289.16397524226, 9494.955554889095, 9534.85697714521, 5894.793682221101, 7125.35871771543, 7199.71201151948, 7204.9279507204255, 7214.639268036683, 7643.541387516767, 7750.379969602531, 7832.921670783448, 7838.451308408356, 7841.372690184886, 6939.965300173467, 6975.755848545276, 7030.543014704028, 7072.469564782559, 7162.856742865218, 5835.533157347487, 6906.79279621592, 6927.445804335742, 6942.652867356713, 6958.965205173941, 6490.772822951174, 6549.934500654933, 6601.801945941629, 6637.037629543593, 6644.202695676549, 4099.85650502231, 4732.73969931657, 4819.855404337735, 4832.275158726219, 4937.382827146606, 4698.859034228979, 4835.879103022312, 4866.610671146371, 4896.681715688469, 4988.5260900214425], "value": 4337.83973041916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.54271537394044, 300.45017617759487, 307.54944007029707, 310.35755985110814, 313.7631088528161, 5132.43543210247, 5144.122395325708, 5158.716270605115, 5181.766820493078, 5184.859330947195, 3867.65191132798, 3877.1664092220167, 4722.315264286676, 4768.807798050488, 5123.515095178845, 3268.885589004385, 3914.6476817086455, 3945.7040721945827, 3953.565107838143, 4015.8795236142964, 3208.8235147066903, 3251.4147453458368, 3431.605365382988, 3715.368387374153, 3985.3623420252766, 3420.6237313895454, 3547.0, 3946.3685810270363, 3963.5243770747406, 3966.9008274793073, 3595.5505561804775, 3924.4701965234613, 3958.5051868516434, 3971.1263522024965, 3979.4030895365636, 2885.54280088556, 3454.11919960411, 3466.9306613867834, 3467.4798780183173, 3495.283466889307, 4710.246360582325, 4988.82539111133, 5017.946231291433, 5063.620228482841, 5073.340465739467, 4312.402024901905, 4432.024954510002, 4482.260427029536, 4504.932426013613, 4540.432445944257, 4466.731996080213, 5376.059189641797, 5396.379416367129, 5407.270018547485, 5424.0, 3513.6135025147214, 3818.2554401891643, 3825.215830754689, 3827.6363745444137, 3831.1571454280015, 5391.975524650343, 5577.776888924479, 5633.605647604711, 5640.746166422521, 5650.717464126818, 3555.7510974232073, 3873.302805495038, 3876.7673939563715, 3877.2245550889934, 3885.339492286318, 3925.9792453962177, 3934.0, 3950.4074388841327, 3954.980225098856, 3955.248502784462, 3745.569259535134, 4103.507579090528, 4480.260756975063, 4519.276915693474, 4555.749433781108, 5247.868803279948, 5349.812756553502, 5449.700266485302, 5465.754041068161, 5483.945160548423, 1144.8969592736694, 1193.0515240383743, 1247.2454165230088, 1257.0013678251623, 1257.220523275575, 704.7772115379812, 804.8350088231898, 827.59447870543, 862.1206369503197, 872.2324354568067, 4223.535411104776, 4405.493368262627, 4591.127685739699, 4724.952750472451, 5210.426853046162, 5620.91568626471, 5621.486570893192, 5641.26663533738, 5642.971785141131, 5710.514606258432, 4624.219675424985, 4859.829905953275, 5011.649184557119, 5167.752027867889, 5171.456997015334, 2304.953900921972, 2675.986620066926, 2797.2587264374956, 2797.762190213814, 2800.493558265341, 4553.61294289989, 4951.5048495150195, 5504.981578408007, 5559.27729395176, 5562.360328562187, 5077.771500282496, 5456.863578410492, 5515.787580736166, 5519.144532597454, 5520.0, 4952.950470495321, 5482.533984611273, 5534.889302213933, 5562.582806289544, 5570.855220739963, 4390.934135988026, 4613.538646135359, 5016.749162541785, 5132.897342053064, 5296.602754793483, 4244.8514301999285, 4976.755811047238, 5195.922061169161, 5256.185291279858, 5260.86847828792, 4791.760411979457, 4819.879503012453, 4836.082772953919, 4838.830640927691, 5383.300170977748, 3126.484130118596, 3167.7983801258824, 3172.476541370648, 3462.4806279058344, 3618.511500947444, 4928.408590969107, 5271.71005594696, 5359.0, 5393.1370980642905, 5399.541039011728, 4399.2521271384585, 4566.648176189199, 4947.3073769671555, 5054.368203974504, 5146.8970620588125, 4601.148787474328, 5116.079105760999, 5155.639105262596, 5169.81905633301, 5169.974150129226, 4279.422277992556, 4886.53577910098, 4962.727050012139, 5048.5203905628905, 5359.866003349947, 4546.568076032771, 5324.574034077342, 5399.352077750695, 5405.567554595702, 5489.039418101896, 4743.525647435367, 5311.521963023347, 5350.725941474935, 5379.569634429158, 5393.649412788156], "value": 3868.4799772622005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.0437387657277, 694.6283738200061, 704.2851505721691, 720.4668545276495, 741.3365038290732, 14288.428462861486, 14859.885508586858, 14879.479218227365, 14912.0, 14916.776248356284, 13273.269970151638, 13439.462421503153, 13463.326833658302, 13466.596002119928, 13469.461221551152, 658.2364457229614, 678.3013496099002, 681.536555142503, 684.5276759036274, 822.4530687093076, 683.0232767142984, 687.1239170058191, 809.2797410304834, 839.4879123734516, 845.5391811462737, 884.2174675412242, 888.6090120347059, 892.651865772346, 899.8200359928007, 901.085398320705, 887.1483375959087, 888.342626456424, 889.4663202078766, 891.6433426629335, 892.3129190523325, 522.5584381197882, 670.7719375412335, 671.0370618162902, 672.7847088931544, 672.9938741581318, 11618.825717614243, 13318.267495287755, 13777.380017899219, 13843.030987830856, 14185.361658725278, 13495.66260843477, 14109.365078571387, 14148.434062637481, 14231.78652320216, 14247.857521424861, 10807.297525660886, 10846.240763146583, 10889.564417423293, 10918.454077296103, 11121.55513779448, 3472.3576138414223, 3495.475678648223, 3511.701505372021, 3539.150603855082, 3595.982020089909, 98107.0189298105, 101601.0, 102029.489852551, 113248.0, 113612.86387136189, 9616.663416780379, 10691.679249622524, 10776.028611906486, 10785.13718902486, 11240.606578769704, 20374.694379584318, 21149.0, 21418.464538386666, 21495.247666331605, 21514.0, 7417.888731669029, 7443.292887175709, 7492.662830172655, 7598.240175982468, 7705.653245603961, 3757.1922036762226, 3867.903302417462, 3881.7476864003747, 3929.096307849211, 3959.1289916218384, 3463.5497385339745, 3546.2021045265124, 3572.3212589607892, 3581.3374525712825, 3583.4624806279267, 503.8362532177057, 536.8765184007622, 537.1325309624928, 643.1028714942629, 646.9805905822833, 561.5423429904615, 595.4462350014528, 606.8331208917583, 626.9843253918598, 644.5842431631665, 8139.129742267538, 8880.289576833839, 8887.466751994902, 8928.285737141014, 9037.277017838556, 524.8609118583579, 532.3212903548007, 597.9641221526722, 631.8515148939996, 639.2137670665107, 3470.8893154190923, 4215.59951804578, 4307.8276868924895, 4336.635441295307, 4402.471703395549, 95366.09267814744, 106097.0, 111967.0, 117270.0, 118629.62740745136, 83133.0, 89917.55041224752, 89951.55024224837, 95140.0, 97840.51079744556, 82457.51738550024, 84313.57843210745, 85078.57460712657, 85416.14583854206, 87010.0, 9112.498812565107, 9375.953120234355, 9428.62285508572, 9620.807583848424, 9760.658376956773, 41403.0, 44637.553624464636, 48212.276815847086, 49279.50720492749, 50478.73880529975, 53715.582798773365, 68492.657536712, 69127.65436172989, 70444.0, 72843.27156728365, 10033.799324013626, 12076.0, 12226.633201003984, 12434.813477798021, 12763.234205947672, 14231.857681423468, 14317.284135793378, 14445.49440769568, 14626.341814618156, 14656.267186640838, 13328.0, 13421.842050550858, 13492.190468571916, 13580.0, 14102.647433814236, 12591.004712007758, 12603.432845521791, 12793.87206127964, 12961.287129207607, 13386.732265354443, 11967.461464234304, 13326.466941322238, 13367.866321336662, 13374.732505349644, 13562.694341961693, 9764.9023509764, 10508.94910508943, 10535.0, 10641.680749577525, 11323.943380283046, 9201.677742022428, 9667.758306042406, 10534.0, 11142.27575207609, 11449.942750286194], "value": 7149.915965343773, "unit": "score"}], "name": "dromaeo_css", "value": 7032.4739894028135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 112.0, 115.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 114.0, 152.0, 114.0, 115.0, 117.0, 139.0, 138.0, 115.0], "value": 127.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [257.0, 264.0, 207.0, 184.0, 179.0, 182.0, 181.0, 219.0, 265.0, 184.0], "value": 212.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 61.0, 86.0, 62.0, 59.0, 59.0, 74.0, 97.0, 77.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 84.0, 69.0, 69.0, 70.0, 81.0, 68.0, 69.0, 86.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 83.0, 87.0, 84.0, 86.0, 83.0, 87.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 95.0, 92.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 92.0, 85.0, 85.0, 85.0, 85.0, 90.0, 86.0, 86.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 53.0, 53.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 67.0, 78.0, 73.0, 68.0, 69.0, 69.0, 69.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 86.0, 88.0, 88.0, 86.0, 86.0, 87.0, 90.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 145.0, 150.0, 147.0, 145.0, 149.0, 148.0, 187.0, 161.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 175.0, 173.0, 175.0, 175.0, 172.0, 171.0, 174.0, 173.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 69.0, 68.0, 68.0, 69.0, 70.0, 69.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1480.6, "alertThreshold": 2.0}]} 15:37:58 INFO - Return code: 0 15:37:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:37:58 INFO - # TBPL SUCCESS # 15:37:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:37:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:37:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:37:58 INFO - 2016-12-03 15:37:58.328 screenresolution[1658:10320] starting screenresolution argv=screenresolution get 15:37:58 INFO - 2016-12-03 15:37:58.331 screenresolution[1658:10320] Display 0: 1600x1200x32@60 15:37:58 INFO - 2016-12-03 15:37:58.337 screenresolution[1659:10323] starting screenresolution argv=screenresolution list 15:37:58 INFO - Available Modes on Display 0 15:37:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:37:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:37:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:37:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:37:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:37:58 INFO - Intel Iris: 15:37:58 INFO - Chipset Model: Intel Iris 15:37:58 INFO - Type: GPU 15:37:58 INFO - Bus: Built-In 15:37:58 INFO - VRAM (Dynamic, Max): 1536 MB 15:37:58 INFO - Vendor: Intel (0x8086) 15:37:58 INFO - Device ID: 0x0a2e 15:37:58 INFO - Revision ID: 0x0009 15:37:58 INFO - Displays: 15:37:58 INFO - Display: 15:37:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:37:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:37:58 INFO - Display Serial Number: 1600x1200 60 15:37:58 INFO - Main Display: Yes 15:37:58 INFO - Mirror: Off 15:37:58 INFO - Online: Yes 15:37:58 INFO - Rotation: Supported 15:37:58 INFO - Return code: 0 15:37:58 INFO - Running post-action listener: _resource_record_post_action 15:37:58 INFO - [mozharness: 2016-12-03 23:37:58.586710Z] Finished run-tests step (success) 15:37:58 INFO - Running post-run listener: _resource_record_post_run 15:37:58 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 31263744; Write bytes: 696241152; Read time: 192; Write time: 1967 15:37:58 INFO - TinderboxPrint: CPU usage
53.7% 15:37:58 INFO - TinderboxPrint: I/O read bytes / time
31,263,744 / 192 15:37:58 INFO - TinderboxPrint: I/O write bytes / time
696,241,152 / 1,967 15:37:58 INFO - TinderboxPrint: CPU idle
2,247.9 (46.3%) 15:37:58 INFO - TinderboxPrint: CPU system
972.0 (20.0%) 15:37:58 INFO - TinderboxPrint: CPU user
1,637.8 (33.7%) 15:37:58 INFO - TinderboxPrint: Swap in / out
410,783,744 / 0 15:37:58 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 368527872; Write bytes: 369349632; Read time: 27646; Write time: 763 15:37:58 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 30338048; Write bytes: 308410368; Read time: 179; Write time: 1154 15:37:59 INFO - Running post-run listener: _upload_blobber_files 15:37:59 INFO - Blob upload gear active. 15:37:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:37:59 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 15:37:59 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:37:59 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:37:59 INFO - (blobuploader) - INFO - Open directory for files ... 15:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:00 INFO - (blobuploader) - INFO - Done attempting. 15:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:38:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:02 INFO - (blobuploader) - INFO - Done attempting. 15:38:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:38:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:38:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:04 INFO - (blobuploader) - INFO - Done attempting. 15:38:04 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:04 INFO - Return code: 0 15:38:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b12cd1cd2e8d99dce4690084331bc396343da0235330cda93461d69aaddabe985dd0e2cf42351c1388794fd45d4a0392f5ebeec84be3400e5fcac2d982ee47c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d869f035e7f99b526c18b82df486e4cb884ca2d50bd9c426f58c1d58dc167855f52b22b5c5256059346b95743bb6ce18ff44c2c227c622df2d2182cf8d9ce7f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f0c02a035cab42fa990e436e62e493cdf870405071d29535860a3b7a5385cd4cc25c471e8642464f29ea2554bc450d32cd5c5ee9da1cd8a6954b888f5a539d1"} 15:38:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:04 INFO - Contents: 15:38:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b12cd1cd2e8d99dce4690084331bc396343da0235330cda93461d69aaddabe985dd0e2cf42351c1388794fd45d4a0392f5ebeec84be3400e5fcac2d982ee47c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d869f035e7f99b526c18b82df486e4cb884ca2d50bd9c426f58c1d58dc167855f52b22b5c5256059346b95743bb6ce18ff44c2c227c622df2d2182cf8d9ce7f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f0c02a035cab42fa990e436e62e493cdf870405071d29535860a3b7a5385cd4cc25c471e8642464f29ea2554bc450d32cd5c5ee9da1cd8a6954b888f5a539d1"} 15:38:04 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:04 INFO - Copying logs to upload dir... 15:38:04 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.003728 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-03 15:38:04.701069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 15:38:04.704778) ========= 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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/Firefox/sha512/5b12cd1cd2e8d99dce4690084331bc396343da0235330cda93461d69aaddabe985dd0e2cf42351c1388794fd45d4a0392f5ebeec84be3400e5fcac2d982ee47c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d869f035e7f99b526c18b82df486e4cb884ca2d50bd9c426f58c1d58dc167855f52b22b5c5256059346b95743bb6ce18ff44c2c227c622df2d2182cf8d9ce7f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f0c02a035cab42fa990e436e62e493cdf870405071d29535860a3b7a5385cd4cc25c471e8642464f29ea2554bc450d32cd5c5ee9da1cd8a6954b888f5a539d1"} build_url:https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/HDqVzYzkT9qaZAloxs6rlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b12cd1cd2e8d99dce4690084331bc396343da0235330cda93461d69aaddabe985dd0e2cf42351c1388794fd45d4a0392f5ebeec84be3400e5fcac2d982ee47c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d869f035e7f99b526c18b82df486e4cb884ca2d50bd9c426f58c1d58dc167855f52b22b5c5256059346b95743bb6ce18ff44c2c227c622df2d2182cf8d9ce7f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f0c02a035cab42fa990e436e62e493cdf870405071d29535860a3b7a5385cd4cc25c471e8642464f29ea2554bc450d32cd5c5ee9da1cd8a6954b888f5a539d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 15:38:04.739050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:38:04.739392) ========= 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.Qq4w25c3ue/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.N8pWo3ylGj/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005449 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:38:04.787844) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 15:38:04.788143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 15:38:04.788447) ========= ========= Total master_lag: 0.18 =========