builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0338 starttime: 1473030555.04 results: success (0) buildid: 20160904132748 builduid: fe22b1257ac6496590914a4b168c6158 revision: b57551bae673035cc9d3134f44d765b5c94a8b40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:15.038110) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:15.038560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:15.038855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:15.248306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:15.248738) ========= 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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-04 16:09:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2016-09-04 16:09:16 (18.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.849322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:16.121601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:16.121898) ========= 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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.040006 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:16.185480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-04 16:09:16.186324) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b57551bae673035cc9d3134f44d765b5c94a8b40 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b57551bae673035cc9d3134f44d765b5c94a8b40 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-04 16:09:16,269 truncating revision to first 12 chars 2016-09-04 16:09:16,269 Setting DEBUG logging. 2016-09-04 16:09:16,269 attempt 1/10 2016-09-04 16:09:16,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b57551bae673?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-04 16:09:17,385 unpacking tar archive at: autoland-b57551bae673/testing/mozharness/ program finished with exit code 0 elapsedTime=1.458473 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-04 16:09:17.672427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:17.673177) ========= script_repo_revision: b57551bae673035cc9d3134f44d765b5c94a8b40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:17.674169) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:17.674895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-04 16:09:17.694524) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-04 16:09:17.695238) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:09:17 INFO - MultiFileLogger online at 20160904 16:09:17 in /builds/slave/test 16:09:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 16:09:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:09:17 INFO - {'append_to_log': False, 16:09:17 INFO - 'base_work_dir': '/builds/slave/test', 16:09:17 INFO - 'blob_upload_branch': 'Autoland', 16:09:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:09:17 INFO - 'branch': 'Autoland', 16:09:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:17 INFO - 'config_files': ('talos/mac_config.py',), 16:09:17 INFO - 'default_actions': ('clobber', 16:09:17 INFO - 'read-buildbot-config', 16:09:17 INFO - 'download-and-extract', 16:09:17 INFO - 'populate-webroot', 16:09:17 INFO - 'create-virtualenv', 16:09:17 INFO - 'install', 16:09:17 INFO - 'run-tests'), 16:09:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:17 INFO - 'download_minidump_stackwalk': True, 16:09:17 INFO - 'download_symbols': 'ondemand', 16:09:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:17 INFO - 'installer_path': 'installer.exe', 16:09:17 INFO - 'log_level': 'info', 16:09:17 INFO - 'log_name': 'talos', 16:09:17 INFO - 'log_to_console': True, 16:09:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:09:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:09:17 INFO - 'opt_config_files': (), 16:09:17 INFO - 'pip_index': False, 16:09:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:09:17 INFO - 'cmd': ('bash', 16:09:17 INFO - '-c', 16:09:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:09:17 INFO - 'enabled': True, 16:09:17 INFO - 'halt_on_failure': False, 16:09:17 INFO - 'name': 'check_screen_resolution'},), 16:09:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:09:17 INFO - 'cmd': ('bash', 16:09:17 INFO - '-c', 16:09:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:09:17 INFO - 'enabled': True, 16:09:17 INFO - 'halt_on_failure': False, 16:09:17 INFO - 'name': 'check_screen_resolution'},), 16:09:17 INFO - 'run_cmd_checks_enabled': True, 16:09:17 INFO - 'sps_profile': False, 16:09:17 INFO - 'sps_profile_interval': 0, 16:09:17 INFO - 'suite': 'dromaeojs', 16:09:17 INFO - 'system_bits': '32', 16:09:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:17 INFO - 'title': 't-yosemite-r7-0338', 16:09:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:17 INFO - 'use_talos_json': True, 16:09:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:09:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:17 INFO - 'work_dir': 'build'} 16:09:17 INFO - [mozharness: 2016-09-04 23:09:17.894077Z] Running clobber step. 16:09:17 INFO - Running pre-action listener: _resource_record_pre_action 16:09:17 INFO - Running main action method: clobber 16:09:17 INFO - rmtree: /builds/slave/test/build 16:09:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:09:19 INFO - Running post-action listener: _resource_record_post_action 16:09:19 INFO - [mozharness: 2016-09-04 23:09:19.995807Z] Finished clobber step (success) 16:09:19 INFO - [mozharness: 2016-09-04 23:09:19.995936Z] Running read-buildbot-config step. 16:09:19 INFO - Running pre-action listener: _resource_record_pre_action 16:09:19 INFO - Running main action method: read_buildbot_config 16:09:19 INFO - Using buildbot properties: 16:09:19 INFO - { 16:09:19 INFO - "project": "", 16:09:19 INFO - "product": "firefox", 16:09:19 INFO - "script_repo_revision": "production", 16:09:19 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 16:09:19 INFO - "repository": "", 16:09:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 16:09:19 INFO - "buildid": "20160904132748", 16:09:19 INFO - "pgo_build": "False", 16:09:19 INFO - "basedir": "/builds/slave/test", 16:09:19 INFO - "buildnumber": 172, 16:09:19 INFO - "slavename": "t-yosemite-r7-0338", 16:09:19 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:09:19 INFO - "platform": "yosemite_r7", 16:09:19 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 16:09:19 INFO - "branch": "autoland", 16:09:19 INFO - "repo_path": "integration/autoland", 16:09:19 INFO - "revision": "b57551bae673035cc9d3134f44d765b5c94a8b40", 16:09:19 INFO - "stage_platform": "macosx64", 16:09:19 INFO - "builduid": "fe22b1257ac6496590914a4b168c6158", 16:09:19 INFO - "slavebuilddir": "test" 16:09:19 INFO - } 16:09:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:09:19 INFO - Running post-action listener: _resource_record_post_action 16:09:19 INFO - [mozharness: 2016-09-04 23:09:19.999387Z] Finished read-buildbot-config step (success) 16:09:19 INFO - [mozharness: 2016-09-04 23:09:19.999512Z] Running download-and-extract step. 16:09:19 INFO - Running pre-action listener: _resource_record_pre_action 16:09:19 INFO - Running main action method: download_and_extract 16:09:19 INFO - mkdir: /builds/slave/test/build/tests 16:09:20 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')]} 16:09:20 INFO - trying https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:09:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 16:09:21 INFO - Downloaded 1199 bytes. 16:09:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:09:21 INFO - Using the following test package requirements: 16:09:21 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:09:21 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:09:21 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:09:21 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:09:21 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:09:21 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:09:21 INFO - u'jsshell-mac.zip'], 16:09:21 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:09:21 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:09:21 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:09:21 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:09:21 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:09:21 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:09:21 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:09:21 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:09:21 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:09:21 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:09:21 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:09:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:09:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:09:21 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 16:09:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:09:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:09:28 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 16:09:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:09:36 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 16:09:36 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')]} 16:09:36 INFO - trying https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:09:36 INFO - Downloading https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 16:09:40 INFO - Downloaded 111510994 bytes. 16:09:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:09:40 INFO - mkdir: /builds/slave/test/properties 16:09:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:09:40 INFO - Writing to file /builds/slave/test/properties/build_url 16:09:40 INFO - Contents: 16:09:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:09:41 INFO - Running post-action listener: _resource_record_post_action 16:09:41 INFO - Running post-action listener: set_extra_try_arguments 16:09:41 INFO - [mozharness: 2016-09-04 23:09:41.418875Z] Finished download-and-extract step (success) 16:09:41 INFO - [mozharness: 2016-09-04 23:09:41.419034Z] Running populate-webroot step. 16:09:41 INFO - Running pre-action listener: _resource_record_pre_action 16:09:41 INFO - Running main action method: populate_webroot 16:09:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:09:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:09:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:09:41 INFO - '--tppagecycles', 16:09:41 INFO - '7'], 16:09:41 INFO - 'tests': ['tsvgm']}}, 16:09:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:09:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:09:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:09:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:09:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:41 INFO - 'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:09:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:09:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:41 INFO - 'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['damp', 'tps']}, 16:09:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:41 INFO - 'tests': ['damp', 'tps']}, 16:09:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['dromaeo_dom']}, 16:09:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:09:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['basic_compositor_video']}, 16:09:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:09:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['a11yr', 16:09:41 INFO - 'ts_paint', 16:09:41 INFO - 'tpaint', 16:09:41 INFO - 'sessionrestore', 16:09:41 INFO - 'sessionrestore_no_auto_restore', 16:09:41 INFO - 'tabpaint']}, 16:09:41 INFO - 'other-e10s': {'tests': ['a11yr', 16:09:41 INFO - 'ts_paint', 16:09:41 INFO - 'tpaint', 16:09:41 INFO - 'sessionrestore', 16:09:41 INFO - 'sessionrestore_no_auto_restore', 16:09:41 INFO - 'tabpaint']}, 16:09:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:09:41 INFO - 'ts_paint', 16:09:41 INFO - 'tpaint', 16:09:41 INFO - 'sessionrestore', 16:09:41 INFO - 'sessionrestore_no_auto_restore', 16:09:41 INFO - 'tabpaint']}, 16:09:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:09:41 INFO - 'ts_paint', 16:09:41 INFO - 'tpaint', 16:09:41 INFO - 'sessionrestore', 16:09:41 INFO - 'sessionrestore_no_auto_restore', 16:09:41 INFO - 'tabpaint']}, 16:09:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['a11yr', 16:09:41 INFO - 'ts_paint', 16:09:41 INFO - 'tpaint', 16:09:41 INFO - 'sessionrestore', 16:09:41 INFO - 'sessionrestore_no_auto_restore', 16:09:41 INFO - 'tabpaint']}, 16:09:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['a11yr', 16:09:41 INFO - 'ts_paint', 16:09:41 INFO - 'tpaint', 16:09:41 INFO - 'sessionrestore', 16:09:41 INFO - 'sessionrestore_no_auto_restore', 16:09:41 INFO - 'tabpaint']}, 16:09:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['tsvgx', 16:09:41 INFO - 'tsvgr_opacity', 16:09:41 INFO - 'tart', 16:09:41 INFO - 'tscrollx', 16:09:41 INFO - 'cart']}, 16:09:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:09:41 INFO - 'tsvgr_opacity', 16:09:41 INFO - 'tart', 16:09:41 INFO - 'tscrollx', 16:09:41 INFO - 'cart']}, 16:09:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:41 INFO - 'talos_options': ['--disable-e10s'], 16:09:41 INFO - 'tests': ['tp5o']}, 16:09:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:41 INFO - 'tests': ['tp5o']}, 16:09:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:41 INFO - 'talos_options': ['--disable-e10s', 16:09:41 INFO - '--xperf_path', 16:09:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:09:41 INFO - 'tests': ['tp5n']}, 16:09:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:41 INFO - 'talos_options': ['--xperf_path', 16:09:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:09:41 INFO - 'tests': ['tp5n']}}, 16:09:41 INFO - 'talos.zip': {'path': '', 16:09:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:09:41 INFO - Running post-action listener: _resource_record_post_action 16:09:41 INFO - [mozharness: 2016-09-04 23:09:41.438030Z] Finished populate-webroot step (success) 16:09:41 INFO - [mozharness: 2016-09-04 23:09:41.438168Z] Running create-virtualenv step. 16:09:41 INFO - Running pre-action listener: _resource_record_pre_action 16:09:41 INFO - Running main action method: create_virtualenv 16:09:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:09:41 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 16:09:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:09:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:09:41 INFO - Using real prefix '/tools/python27' 16:09:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:09:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:09:45 INFO - Installing pip.................done. 16:09:45 INFO - Return code: 0 16:09:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:09:45 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')]} 16:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:45 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')]} 16:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:45 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:09:45 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 16:09:45 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 16:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:45 INFO - 'HOME': '/Users/cltbld', 16:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:45 INFO - 'LOGNAME': 'cltbld', 16:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:45 INFO - 'MOZ_NO_REMOTE': '1', 16:09:45 INFO - 'NO_EM_RESTART': '1', 16:09:45 INFO - 'PAGER': '/bin/cat', 16:09:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:45 INFO - 'PWD': '/builds/slave/test', 16:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:45 INFO - 'SHELL': '/bin/bash', 16:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:09:45 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:45 INFO - 'USER': 'cltbld', 16:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:45 INFO - 'XPC_FLAGS': '0x0', 16:09:45 INFO - 'XPC_SERVICE_NAME': '0', 16:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:45 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 16:09:45 INFO - Cleaning up... 16:09:45 INFO - Return code: 0 16:09:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:09:45 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')]} 16:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:45 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')]} 16:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:45 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:09:45 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 16:09:45 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 16:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:45 INFO - 'HOME': '/Users/cltbld', 16:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:45 INFO - 'LOGNAME': 'cltbld', 16:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:45 INFO - 'MOZ_NO_REMOTE': '1', 16:09:45 INFO - 'NO_EM_RESTART': '1', 16:09:45 INFO - 'PAGER': '/bin/cat', 16:09:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:45 INFO - 'PWD': '/builds/slave/test', 16:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:45 INFO - 'SHELL': '/bin/bash', 16:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:09:45 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:45 INFO - 'USER': 'cltbld', 16:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:45 INFO - 'XPC_FLAGS': '0x0', 16:09:45 INFO - 'XPC_SERVICE_NAME': '0', 16:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:45 INFO - Downloading/unpacking psutil>=3.1.1 16:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:09:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:09:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:09:49 INFO - Installing collected packages: psutil 16:09:49 INFO - Running setup.py install for psutil 16:09:49 INFO - building 'psutil._psutil_osx' extension 16:09:49 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 16:09:50 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 16:09:50 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 16:09:50 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 16:09:50 INFO - building 'psutil._psutil_posix' extension 16:09:50 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 16:09:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:09:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:09:50 INFO - ^ 16:09:50 INFO - 1 warning generated. 16:09:50 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 16:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:09:50 INFO - Successfully installed psutil 16:09:50 INFO - Cleaning up... 16:09:50 INFO - Return code: 0 16:09:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:50 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:09:50 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 16:09:50 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 16:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:50 INFO - 'HOME': '/Users/cltbld', 16:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:50 INFO - 'LOGNAME': 'cltbld', 16:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:50 INFO - 'MOZ_NO_REMOTE': '1', 16:09:50 INFO - 'NO_EM_RESTART': '1', 16:09:50 INFO - 'PAGER': '/bin/cat', 16:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:50 INFO - 'PWD': '/builds/slave/test', 16:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:50 INFO - 'SHELL': '/bin/bash', 16:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:09:50 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:50 INFO - 'USER': 'cltbld', 16:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:50 INFO - 'XPC_FLAGS': '0x0', 16:09:50 INFO - 'XPC_SERVICE_NAME': '0', 16:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:09:53 INFO - Installing collected packages: mozsystemmonitor 16:09:53 INFO - Running setup.py install for mozsystemmonitor 16:09:53 INFO - Successfully installed mozsystemmonitor 16:09:53 INFO - Cleaning up... 16:09:53 INFO - Return code: 0 16:09:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:09:53 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')]} 16:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:53 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')]} 16:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:53 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:09:53 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 16:09:53 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 16:09:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:09:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:53 INFO - 'HOME': '/Users/cltbld', 16:09:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:53 INFO - 'LOGNAME': 'cltbld', 16:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:53 INFO - 'MOZ_NO_REMOTE': '1', 16:09:53 INFO - 'NO_EM_RESTART': '1', 16:09:53 INFO - 'PAGER': '/bin/cat', 16:09:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:53 INFO - 'PWD': '/builds/slave/test', 16:09:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:53 INFO - 'SHELL': '/bin/bash', 16:09:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:09:53 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:09:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:53 INFO - 'USER': 'cltbld', 16:09:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:53 INFO - 'XPC_FLAGS': '0x0', 16:09:53 INFO - 'XPC_SERVICE_NAME': '0', 16:09:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:54 INFO - Downloading/unpacking jsonschema==2.5.1 16:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:09:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:56 INFO - Downloading functools32-3.2.3-2.tar.gz 16:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:09:57 INFO - warning: no files found matching '*.txt' 16:09:57 INFO - no previously-included directories found matching 'build' 16:09:57 INFO - no previously-included directories found matching 'dist' 16:09:57 INFO - no previously-included directories found matching '.git*' 16:09:57 INFO - Installing collected packages: jsonschema, functools32 16:09:57 INFO - Running setup.py install for functools32 16:09:57 INFO - warning: no files found matching '*.txt' 16:09:57 INFO - no previously-included directories found matching 'build' 16:09:57 INFO - no previously-included directories found matching 'dist' 16:09:57 INFO - no previously-included directories found matching '.git*' 16:09:57 INFO - Successfully installed jsonschema functools32 16:09:57 INFO - Cleaning up... 16:09:57 INFO - Return code: 0 16:09:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:57 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:09:57 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 16:09:57 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 16:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:57 INFO - 'HOME': '/Users/cltbld', 16:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:57 INFO - 'LOGNAME': 'cltbld', 16:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:57 INFO - 'MOZ_NO_REMOTE': '1', 16:09:57 INFO - 'NO_EM_RESTART': '1', 16:09:57 INFO - 'PAGER': '/bin/cat', 16:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:57 INFO - 'PWD': '/builds/slave/test', 16:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:57 INFO - 'SHELL': '/bin/bash', 16:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:09:57 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:57 INFO - 'USER': 'cltbld', 16:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:57 INFO - 'XPC_FLAGS': '0x0', 16:09:57 INFO - 'XPC_SERVICE_NAME': '0', 16:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:09:57 INFO - Cleaning up... 16:09:57 INFO - Return code: 0 16:09:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:57 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:09:57 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 16:09:57 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 16:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:57 INFO - 'HOME': '/Users/cltbld', 16:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:57 INFO - 'LOGNAME': 'cltbld', 16:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:57 INFO - 'MOZ_NO_REMOTE': '1', 16:09:57 INFO - 'NO_EM_RESTART': '1', 16:09:57 INFO - 'PAGER': '/bin/cat', 16:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:57 INFO - 'PWD': '/builds/slave/test', 16:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:57 INFO - 'SHELL': '/bin/bash', 16:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:09:57 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:57 INFO - 'USER': 'cltbld', 16:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:57 INFO - 'XPC_FLAGS': '0x0', 16:09:57 INFO - 'XPC_SERVICE_NAME': '0', 16:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:09:57 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 16:09:57 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 16:09:57 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 16:09:57 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 16:09:57 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 16:09:57 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 16:10:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10:00 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 16:10:00 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 16:10:00 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 16:10:00 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 16:10:00 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 16:10:00 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 16:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:10:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:01 INFO - Downloading docopt-0.6.1.tar.gz 16:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:01 INFO - Running setup.py install for blobuploader 16:10:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:10:01 INFO - Running setup.py install for requests 16:10:02 INFO - Running setup.py install for docopt 16:10:02 INFO - Successfully installed blobuploader requests docopt 16:10:02 INFO - Cleaning up... 16:10:02 INFO - Return code: 0 16:10:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:02 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:10:02 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 16:10:02 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 16:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:02 INFO - 'HOME': '/Users/cltbld', 16:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:02 INFO - 'LOGNAME': 'cltbld', 16:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:02 INFO - 'MOZ_NO_REMOTE': '1', 16:10:02 INFO - 'NO_EM_RESTART': '1', 16:10:02 INFO - 'PAGER': '/bin/cat', 16:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:02 INFO - 'PWD': '/builds/slave/test', 16:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:02 INFO - 'SHELL': '/bin/bash', 16:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:10:02 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:02 INFO - 'USER': 'cltbld', 16:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:02 INFO - 'XPC_FLAGS': '0x0', 16:10:02 INFO - 'XPC_SERVICE_NAME': '0', 16:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:02 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-g_Vh8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:02 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-fXybC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:02 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-RAmr9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-iasXuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-QuIXaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-euF4iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-6RY2To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-F84_wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-sYB9DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-mlBqE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-g_V6tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-f7gAUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:03 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ZfRWtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-T2fivk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-B1llfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Z7QkBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:04 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-F4OG4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:10:04 INFO - Running setup.py install for manifestparser 16:10:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:10:04 INFO - Running setup.py install for mozcrash 16:10:04 INFO - Running setup.py install for mozdebug 16:10:04 INFO - Running setup.py install for mozdevice 16:10:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Running setup.py install for mozfile 16:10:05 INFO - Running setup.py install for mozhttpd 16:10:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Running setup.py install for mozinfo 16:10:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Running setup.py install for mozInstall 16:10:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Running setup.py install for mozleak 16:10:05 INFO - Running setup.py install for mozlog 16:10:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:10:05 INFO - Running setup.py install for moznetwork 16:10:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:10:06 INFO - Running setup.py install for mozprocess 16:10:06 INFO - Running setup.py install for mozprofile 16:10:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:10:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:10:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:10:06 INFO - Running setup.py install for mozrunner 16:10:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:10:06 INFO - Running setup.py install for mozscreenshot 16:10:06 INFO - Running setup.py install for moztest 16:10:06 INFO - Running setup.py install for mozversion 16:10:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:10:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:10:06 INFO - Cleaning up... 16:10:07 INFO - Return code: 0 16:10:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:07 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:10:07 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 16:10:07 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 16:10:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:10:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:07 INFO - 'HOME': '/Users/cltbld', 16:10:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:07 INFO - 'LOGNAME': 'cltbld', 16:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:07 INFO - 'MOZ_NO_REMOTE': '1', 16:10:07 INFO - 'NO_EM_RESTART': '1', 16:10:07 INFO - 'PAGER': '/bin/cat', 16:10:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:07 INFO - 'PWD': '/builds/slave/test', 16:10:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:07 INFO - 'SHELL': '/bin/bash', 16:10:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:10:07 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:10:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:07 INFO - 'USER': 'cltbld', 16:10:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:07 INFO - 'XPC_FLAGS': '0x0', 16:10:07 INFO - 'XPC_SERVICE_NAME': '0', 16:10:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-9ziOtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:07 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)) 16:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Tt76dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-QM0Yze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:07 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)) 16:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-fWR05p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-EpnLue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:07 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)) 16:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-8BvsJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:07 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)) 16:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-RmQTXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:07 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)) 16:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-T4pHIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:08 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)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-LVzvH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:08 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)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-sVcjAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-TAeshf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:08 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)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-yKUWuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:08 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)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-iJcRbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:08 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)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-P3I8G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Jc_ycz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:08 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)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-zkX6c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:08 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)) 16:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-buQCP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:09 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)) 16:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:09 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)) 16:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:09 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 16:10:09 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 16:10:09 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 16:10:09 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 16:10:09 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 16:10:09 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 16:10:11 INFO - Downloading blessings-1.6.tar.gz 16:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:10:11 INFO - Installing collected packages: blessings 16:10:11 INFO - Running setup.py install for blessings 16:10:11 INFO - Successfully installed blessings 16:10:11 INFO - Cleaning up... 16:10:11 INFO - Return code: 0 16:10:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:10:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:12 INFO - Reading from file tmpfile_stdout 16:10:12 INFO - Current package versions: 16:10:12 INFO - blessings == 1.6 16:10:12 INFO - blobuploader == 1.2.4 16:10:12 INFO - docopt == 0.6.1 16:10:12 INFO - functools32 == 3.2.3-2 16:10:12 INFO - jsonschema == 2.5.1 16:10:12 INFO - manifestparser == 1.1 16:10:12 INFO - mozInstall == 1.12 16:10:12 INFO - mozcrash == 0.17 16:10:12 INFO - mozdebug == 0.1 16:10:12 INFO - mozdevice == 0.48 16:10:12 INFO - mozfile == 1.2 16:10:12 INFO - mozhttpd == 0.7 16:10:12 INFO - mozinfo == 0.9 16:10:12 INFO - mozleak == 0.1 16:10:12 INFO - mozlog == 3.3 16:10:12 INFO - moznetwork == 0.27 16:10:12 INFO - mozprocess == 0.23 16:10:12 INFO - mozprofile == 0.28 16:10:12 INFO - mozrunner == 6.12 16:10:12 INFO - mozscreenshot == 0.1 16:10:12 INFO - mozsystemmonitor == 0.3 16:10:12 INFO - moztest == 0.7 16:10:12 INFO - mozversion == 1.4 16:10:12 INFO - psutil == 3.1.1 16:10:12 INFO - requests == 1.2.3 16:10:12 INFO - wsgiref == 0.1.2 16:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:12 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 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:10:12 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 16:10:12 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 16:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:12 INFO - 'HOME': '/Users/cltbld', 16:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:12 INFO - 'LOGNAME': 'cltbld', 16:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:12 INFO - 'MOZ_NO_REMOTE': '1', 16:10:12 INFO - 'NO_EM_RESTART': '1', 16:10:12 INFO - 'PAGER': '/bin/cat', 16:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:12 INFO - 'PWD': '/builds/slave/test', 16:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:12 INFO - 'SHELL': '/bin/bash', 16:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:10:12 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:12 INFO - 'USER': 'cltbld', 16:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:12 INFO - 'XPC_FLAGS': '0x0', 16:10:12 INFO - 'XPC_SERVICE_NAME': '0', 16:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 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)) 16:10:12 INFO - Cleaning up... 16:10:12 INFO - Return code: 0 16:10:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105682618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52c70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, '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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 16:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:12 INFO - 'HOME': '/Users/cltbld', 16:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:12 INFO - 'LOGNAME': 'cltbld', 16:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:12 INFO - 'MOZ_NO_REMOTE': '1', 16:10:12 INFO - 'NO_EM_RESTART': '1', 16:10:12 INFO - 'PAGER': '/bin/cat', 16:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:12 INFO - 'PWD': '/builds/slave/test', 16:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:12 INFO - 'SHELL': '/bin/bash', 16:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:10:12 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:12 INFO - 'USER': 'cltbld', 16:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:12 INFO - 'XPC_FLAGS': '0x0', 16:10:12 INFO - 'XPC_SERVICE_NAME': '0', 16:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:10:12 INFO - Cleaning up... 16:10:12 INFO - Return code: 0 16:10:12 INFO - Running post-action listener: _resource_record_post_action 16:10:12 INFO - Running post-action listener: _start_resource_monitoring 16:10:12 INFO - Starting resource monitoring. 16:10:12 INFO - [mozharness: 2016-09-04 23:10:12.679420Z] Finished create-virtualenv step (success) 16:10:12 INFO - [mozharness: 2016-09-04 23:10:12.680417Z] Running install step. 16:10:12 INFO - Running pre-action listener: _resource_record_pre_action 16:10:12 INFO - Running main action method: install 16:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:12 INFO - Reading from file tmpfile_stdout 16:10:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:10:13 INFO - Reading from file tmpfile_stdout 16:10:13 INFO - Output received: 16:10:13 INFO - Usage: mozinstall [options] installer 16:10:13 INFO - Options: 16:10:13 INFO - -h, --help show this help message and exit 16:10:13 INFO - -d DEST, --destination=DEST 16:10:13 INFO - Directory to install application into. [default: 16:10:13 INFO - "/builds/slave/test"] 16:10:13 INFO - --app=APP Application being installed. [default: firefox] 16:10:13 INFO - mkdir: /builds/slave/test/build/application 16:10:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:10:47 INFO - Reading from file tmpfile_stdout 16:10:47 INFO - Output received: 16:10:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:10:47 INFO - Running post-action listener: _resource_record_post_action 16:10:47 INFO - [mozharness: 2016-09-04 23:10:47.123380Z] Finished install step (success) 16:10:47 INFO - [mozharness: 2016-09-04 23:10:47.123509Z] Running run-tests step. 16:10:47 INFO - Running pre-action listener: _resource_record_pre_action 16:10:47 INFO - Running main action method: run_tests 16:10:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:10:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:10:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:10:47 INFO - 2016-09-04 16:10:47.136 screenresolution[1659:14977] starting screenresolution argv=screenresolution get 16:10:47 INFO - 2016-09-04 16:10:47.138 screenresolution[1659:14977] Display 0: 1600x1200x32@60 16:10:47 INFO - 2016-09-04 16:10:47.143 screenresolution[1660:14979] starting screenresolution argv=screenresolution list 16:10:47 INFO - Available Modes on Display 0 16:10:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:10:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:10:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:10:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:10:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:10:47 INFO - Intel Iris: 16:10:47 INFO - Chipset Model: Intel Iris 16:10:47 INFO - Type: GPU 16:10:47 INFO - Bus: Built-In 16:10:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:10:47 INFO - Vendor: Intel (0x8086) 16:10:47 INFO - Device ID: 0x0a2e 16:10:47 INFO - Revision ID: 0x0009 16:10:47 INFO - Displays: 16:10:47 INFO - Display: 16:10:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:10:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:10:47 INFO - Display Serial Number: 1600x1200 60 16:10:47 INFO - Main Display: Yes 16:10:47 INFO - Mirror: Off 16:10:47 INFO - Online: Yes 16:10:47 INFO - Rotation: Supported 16:10:47 INFO - Return code: 0 16:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:10:47 INFO - Python 2.7.3 16:10:47 INFO - Return code: 0 16:10:47 INFO - grabbing minidump binary from tooltool 16:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:47 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 0x105551d30>, '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 0x1052b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105549b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:10:47 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 16:10:47 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 16:10:47 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 16:10:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:10:47 INFO - Return code: 0 16:10:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:10:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:10:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:10:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:10:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 16:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --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 16:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OSzeEdQ2yn/Render', 16:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:47 INFO - 'HOME': '/Users/cltbld', 16:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:47 INFO - 'LOGNAME': 'cltbld', 16:10:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:47 INFO - 'MOZ_NO_REMOTE': '1', 16:10:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:47 INFO - 'NO_EM_RESTART': '1', 16:10:47 INFO - 'PAGER': '/bin/cat', 16:10:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:47 INFO - 'PWD': '/builds/slave/test', 16:10:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:47 INFO - 'SHELL': '/bin/bash', 16:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MkHbhjDYd4/Listeners', 16:10:47 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 16:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:47 INFO - 'USER': 'cltbld', 16:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:47 INFO - 'XPC_FLAGS': '0x0', 16:10:47 INFO - 'XPC_SERVICE_NAME': '0', 16:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 16:10:47 INFO - mozversion application_buildid: 20160904132748 16:10:47 INFO - mozversion application_changeset: b57551bae673035cc9d3134f44d765b5c94a8b40 16:10:47 INFO - mozversion application_display_name: Nightly 16:10:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:10:47 INFO - mozversion application_name: Firefox 16:10:47 INFO - mozversion application_remotingname: firefox 16:10:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:10:47 INFO - mozversion application_vendor: Mozilla 16:10:47 INFO - mozversion application_version: 51.0a1 16:10:47 INFO - mozversion platform_buildid: 20160904132748 16:10:47 INFO - mozversion platform_changeset: b57551bae673035cc9d3134f44d765b5c94a8b40 16:10:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:10:47 INFO - mozversion platform_version: 51.0a1 16:10:47 INFO - using testdate: 1473030647 16:10:47 INFO - actual date: 1473030647 16:10:47 INFO - starting webserver on 'localhost:49271' 16:10:47 INFO - SUITE-START | Running 2 tests 16:10:47 INFO - TEST-START | dromaeo_css 16:10:47 INFO - operating with platform_type : mac_ 16:10:47 INFO - Initialising browser for dromaeo_css test... 16:10:47 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp8NUfpP/profile http://localhost:49271/getInfo.html) 16:10:50 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 16:10:50 INFO - PROCESS | 1670 | colorDepth:24 16:10:50 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 16:10:50 INFO - PROCESS | 1670 | __metrics 16:10:50 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:10:50 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:10:50 INFO - TEST-INFO | 1670: exit 0 16:10:50 INFO - Browser initialized. 16:10:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:10:50 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp8NUfpP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:02 INFO - PROCESS | 1673 | RSS: Main: 232050688 16:11:02 INFO - PROCESS | 1673 | 16:11:54 INFO - PROCESS | 1673 | 1473030714152 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] 16:14:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 16:14:07 INFO - PROCESS | 1673 | RSS: Main: 377606144 16:14:07 INFO - PROCESS | 1673 | 16:17:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 16:17:11 INFO - PROCESS | 1673 | RSS: Main: 374722560 16:17:11 INFO - PROCESS | 1673 | 16:20:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:20:14 INFO - PROCESS | 1673 | RSS: Main: 332386304 16:20:14 INFO - PROCESS | 1673 | 16:23:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:23:17 INFO - PROCESS | 1673 | RSS: Main: 339795968 16:23:17 INFO - PROCESS | 1673 | 16:26:20 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:26:21 INFO - PROCESS | 1673 | RSS: Main: 331759616 16:26:21 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:29:24 INFO - PROCESS | 1673 | RSS: Main: 441626624 16:29:24 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | __start_tp_report 16:29:24 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 16:29:24 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 16:29:24 INFO - PROCESS | 1673 | |i|pagename|runs| 16:29:24 INFO - PROCESS | 1673 | |0;dojo.html;3266.4936934775105;3280.2783387654713;3290.4077266092095;3332.067021234055;3361.2101156228296;5592.972035139829;5616.073347897597;5667.234923285355;5690.2033715279895;5690.630109042914;5690.800821971232;5731.627444216134;5741.741621627027;5742.196092547047;5751.10857817038;5156.2265660151;5201.141811601081;5206.219067139921;5215.452377500345;5261.289725886994;5215.817446389377;5231.895362092756;5232.215167724834;5239.397469291023;5244.475552444763;5141.691498510083;5204.583633309345;5235.973820130894;5242.685438873661;5255.054090263751;5253;5278.551323137538;5289.100852855024;5297.841064768025;5334.519893209591;5082.872928176826;5091;5112.821051263225;5210.322658054467;5214.06146893559;5645.181448689958;5674.262345895048;5710.971445142789;5756.769729210869;5796.1305804129715;6251.437370636664;6270.372962703739;6271.34150914152;6277.937220627781;6286.811395658137;6102.870968870773;6209.161763162006;6287.371262873722;6299.37006299371;6332.145160403333;5774.364819869811;5792.073268277056;5794.942050579524;5802.564807639444;5805.042168042268;6289.339619339903;6317.810465686037;6323.683815809191;6348.365163483615;6357.968210159012;5984.700764961734;6099.420555047263;6137.631742095488;6165.445109940127;6174.598651087665;6239.500839932794;6280.120783090371;6313.273973493016;6326.746930122836;6331.461825744771;6196.194494715658;6250.343713910065;6259.467945224706;6272.1219029335925;6294.527910406646;6138.754449821957;6142.191841058572;6144.9246381882995;6293.244810622755;6322.936770632326;4901.362822833009;4912.459629440758;4918.213085906309;4924.72913989734;4931.87670308238;4380.8904777380185;4405.471343438744;4440.467143942683;4446.221911165598;4482.193205223026;5744.712764361765;5752.482276595127;5759.251297331404;5780.421957804186;5786.739596718157;6246.906296405557;6342.112104305401;6345.302016778151;6351.110844481776;6354.904676429857;5588.608797384225;5651.802186923438;5658.603897727119;5748.597598168171;5789.507891829157;5400.540954018952;5412.675239485643;5413.242146099549;5416.133418652997;5418.431064738224;6133.57950150939;6275.780347687901;6279.529035322278;6282.4974002080635;6313;6346.365363463617;6346.555741098079;6347.270063942521;6347.460465860454;6363.172787537591;5346.973265133805;6320.083587879823;6324;6338.492920566436;6340.524460665376;6065.363136870565;6112.108359148444;6121.788327166137;6164.198654174928;6211.09939058843;6332.873342533031;6339.334369891095;6356.0465930109;6359.904601431075;6362.45919096882;5986.700664966821;6122.571420000557;6176.042713379434;6180.258368995749;6193.4425901669065;5856.3558008618165;5930.199423078002;5932.2584676915385;6033.849153771015;6155.261368635793;5852.882942341044;5885.882282354414;5937.139114828412;5956.106584012433;5970.818633020363;6107.3708791890585;6122.713581872198;6131.866048757478;6135.1408007826785;6152.938470615237;5876.676782776817;5903.144044113666;5940.435658612425;5977.9103313451205;5981.7607295707685 16:29:24 INFO - PROCESS | 1673 | |1;ext.html;510.7420752519977;517.5083670513012;525.1912055434631;537.1620272375093;557.4035781713568;30735;32435;32442.18894527638;32450.67549324506;32507.67492325076;42028.579714202846;43321;43410.565894341125;45891.08217835641;45922;9825.459599722013;9977.15194208493;9984.700458986243;9990.700278991606;9998.700038998806;8861.689840855572;9829.754256143582;9946.20430365569;9955.651552195675;9958.95430979744;8890;9055.094490550926;9094.136057074567;9098.63605455781;11862.7627447451;9643.710688679352;12356.752864942651;12388.876111238862;12395.256284622907;12415.503379864886;11072.778544429148;12034.578789742405;12062.819057714141;12094.818577721342;12098.576549820715;37565.43651845225;40668.389974150414;40683;40709.59290407088;40856.79571602153;3628.2924829658227;3777.376732839106;3829.7127715421457;4021.5830899460307;4076.2051399977017;30582.235444113852;31827.840860795546;31882.521762173586;32673.183170420692;32809.83595082033;3268.836558172082;3357.731381489475;3390.610079840825;3410.4202285611505;3435.8282085895607;506595;509064;509494.4525277387;511529;511786;62753.372466275665;62967.96256299485;63134.0529892052;63171;63266.367336326046;61572.768544629755;61601;61683.6915815418;61785.07322390168;61859.19548849623;16452;16736.6652666946;16750.66498670044;16775.832241677672;16803.579910502092;12914.289714065628;13009.89415899659;13015.804762928563;13021.47914083445;13023.348832558335;16744.328715711606;19027.90486047561;19043.523911902314;19081;19243.422697319103;6520.413162815369;7766.5728384939375;7985.920140798634;8054.154313797084;8070.717524886718;870.8388948044632;934.3272843552631;979.3291595257272;990.2424645146468;1050.753073027838;29786.40427191444;29836;30080.548791768142;30769;31016.53475197874;989.0406305883282;1000.9249306302056;1064.2816099133054;1108.6009036746764;1130.2483848240827;14896.702065958836;15633.14017729013;15657.765133523006;15751.606209844616;16027.679446411006;690083.0991690019;697644;698411;700642;701485;53088.080155591815;57433.85132297331;58489;59093;59189.704051479464;1320.0891384944357;1349.7165595224917;1378.2970684950747;1384.7992041153975;1388.0977364713017;30407.39185216239;30503;31195.75216991295;31981.520277196327;31994.040178794672;52557.737211313695;57052.72735453253;57218;57289;57302.7134864323;636846;858776;890431.5478422566;894008;897298;42771.7861410691;42845;43030.78484607557;43547.129057419304;43727.34408983804;39840.800795995834;48107.518924810305;48844.75577622089;48924.2661360087;49267;37441.81279093587;39725.60274397219;39868.800655996536;39883.00292492711;41571.7921410391;39955.60044399635;40021.79989100036;40548.74575935372;41298.79350603348;41516;38314.23371532498;38490.0377490565;39191.60808391879;39269.803650981565;39319.01702457461;32931.67068329286;33970;34512.48231276483;34678;35183.64816351906;23688.526229475658;24671.753282466947;25315.240542783748;25533.48933021292;26130.608040879782 16:29:24 INFO - PROCESS | 1673 | |2;jquery.html;343.5087824411094;362.6174386022746;364.50427418710547;378.11332425462297;394.65862029344606;13700;15229.543113706593;19832.70250946237;19960.700589491153;19988.90061046642;11884.346360950145;15385.23073846306;19338.806611933876;20046.69929951048;20309.49226269344;5247.317848679676;5518.061929471999;5522.751476183581;5523.25436066132;5527.668339899619;5383.515483606475;5485.286912701344;5970.223870896777;6019.1874096997;6019.5485338599565;5960.254968128984;5960.344362120185;5962.25471816023;5976.611520251192;5988.610740301867;5680.971595142039;5873.7356818943035;5947.791827286068;5954.374790646963;5963.940360596382;4984.352034235562;5264.894702105975;5269.367675878881;5271.973640131813;5298.390685071227;12668.746625067539;13408.865911340958;20790.16839326425;25263.747362526323;25774.74225257761;2036.9287074952454;2189.8357623178167;2410.517896420723;2615.4115324052127;2765.0045983445943;10008.697999460164;10147.797044059078;10437.00848419399;11548.191626586142;16177.35290588375;1849.7780266367988;1864.9627007459774;1874.2784028149124;1875.9062046897736;1946.0853398902493;111179;118245.40877295559;124908.12637810531;125068;125327.3733631335;10632.468376581295;10942.781144377228;11076.723081923017;11450.770984580262;11706.892759303408;14429.134251944917;14469.49356772508;14498.05762625426;14500.347484363228;14516.564503064925;8247.670093196324;8547.57262136903;8582.742517724479;8679.266031200152;8685.174908383693;8472.830543389098;8496.235338819535;8509.489430634181;8670.436421632574;8697.869531957025;3604.675579197885;4481.5070342262325;4501.122281155143;4560.475545312265;4581.5647513486165;1873.278787666758;1917.8178073083313;1919.1363886251243;1923.6729755941524;1976.8023197680118;817.7301490508119;891.0999890111035;921.3366376209119;923.0123767568771;950.8336041192902;15907.761383579256;15965.361385544447;20048;20945;21061;823.3043078598574;869.4652788535005;879.2965627497977;973.4451362723321;992.4194346307347;10230.94435662665;10819.600393837774;10856.581159904928;10862.348683389491;10874.160998355814;530931;584120;592459;595259;605284;123276.38361808134;126739;133125;133410;138681;932.8927173375149;933.9766505837273;960.6349587156835;962.4802606592361;964.8311545479513;15190.848091518943;16590.170491475135;18171.636567268317;18597.34909278169;18728.96990665472;55268;56547.71726141343;56954.71522642526;57273.71363143158;57329.14006289826;82241;82460;82651;82949.75575366254;84039;7735.574543399942;7769;8033.6786528538205;8106.79733006656;8136.959315203386;11060.446977651247;12039.458224379749;12371.628851134481;12419.875801242233;12519.311437871005;10236.027577380137;10292.279540432099;10607.20445966571;10705.19711021661;10820.783584328427;10311.576779456971;10419.687409377731;10642.467876606293;11001.504932277907;11009.394483303495;10785.514651840529;10951;11183.552657893919;11245.606403775828;11298.943505282421;7848.293653571206;7880.960595196987;7936.730123180263;7972.441929064909;8121.431499794958;10362.896371036193;10766.569337226423;10854.945725271324;10874;11546.94226528862 16:29:24 INFO - PROCESS | 1673 | |3;mootools.html;1266.2276011632905;1304.0089531955712;1445.7614493608555;1599.312295712843;1893.962120757585;7856.882146767796;8695.39132260742;8980.281577473803;8980.550972451376;9104.13510716481;8851.380403371766;8918.152775486318;8925.152110549487;8935.508547029911;8950.910490895105;2084.801943815343;2375.681496769292;2381.797547208485;2404.9298062362254;2409.7108346998384;2335.5679199348174;2369.4431808524982;2376.6791483149814;2380.2621187431864;2396.113438027923;2366.538524987628;2383.797377222938;2396.400899775056;2403.7235717892404;2405.651180578815;2341.4263505441277;2365.042157926043;2376.1564644551195;2378.1438682074613;2383.0467812874817;2316.860988340688;2354.5526349993447;2355.5053438777877;2355.6702061711376;2368.9644655330185;8665.913340866637;8762.299016078761;8884.600192991265;8896.8665470018;8899.421537600036;5291.920621190685;5438.428964958702;5438.809641662523;5439.347278326626;5443.59173062018;3568.946465803015;3660.762050466711;3674.3202507536193;3749.793761343125;3750.5686846012786;1093;1105.7843720474511;1106.6403418888813;1108.4070022537903;1131.847200627913;11645.417729113511;11665.883341166564;11752.588659396966;11772.823407648892;11815.409229538489;3831.674307683878;4374.8906277342685;4654.418197725285;4655.441347038377;4656.4645065817185;9080.59137338808;9103.81792364149;9105.726828195166;9106.089391060841;9111.726648200565;5264.78940842362;5275.57795376369;5280.683159010472;5282.154855223146;5285.154375299933;4471.195184866755;4626.8380606679275;4735.928961065587;4899.730514821647;4961.330220420269;3705.4997575327525;3721.2743515014313;3830.751001184914;3832.80835958201;3869.1487872667967;1157.8263260510823;1164.813629819242;1168.39243593331;1176.847009888726;1181.5864447443498;757.9962100189464;815.8857759913617;883.6377085394957;893.9865902011475;915.1214833759665;5628.634138780966;5742.253507044057;5955.017422125387;5963.761449542057;6044.03295472731;421.7300927406462;433.55343995684495;433.7267521461522;433.83731100837184;915.231205787142;4022.899427514277;4073.7555746655294;4094.3449048152747;4182.163567286555;4221.831126754895;9203.447793132433;10711.678649640524;10779.946100269448;10859.75112862031;10915.454227288605;10848.403337816339;10851.78296434067;10852.023317901427;10853.34879907208;10860.239783215256;7749.147593764681;8109.635066422025;8121.066077401175;8145.266925976691;8287.295579875778;5909.261342332208;5937.00181408386;5951.613145145551;6128.724207410766;6171.9691401544505;8614.698485552975;10135.493225338556;10235.897641023494;10240;10272.075513203548;8660.956695216735;10213.795724085625;10253.897461025294;10373.014563616445;10378.844317335397;6995.720171193096;7204.495685302189;7217.097862767154;7526.661300241612;7693.807654808675;7963.562004089831;8019.1579884111325;8063.959680201561;8250.504969701837;8338.999320081386;7354.6690398931105;7488.063992001;7579.734709285369;7651.273129052731;7740.92259077402;7243.927560724536;7402.1117465904435;7447.702091916262;7480.625968701652;7621.771346859603;6827.7610283641825;6989.091418115612;6989.1962424321855;6990.9300906990275;7005.54463959841;4425.291953287458;4890.902181956412;5045.117104506623;5078.085944529872;5171;4906.313116163668;5045.0738571627635;5068.493150684902;5205.687658740488;5228.71242081674 16:29:24 INFO - PROCESS | 1673 | |4;prototype.html;294.97787665925057;300.13411308375345;304.7485824195039;309.330299900715;309.82649716158954;5196.194589838572;5202.8699282517955;5226.189940559215;5229.320188375511;5267.789288428467;5187.870303242421;5188.688678679282;5211.42674305826;5220.712860792655;5227.398849132351;3434.364642541138;3713.535808023997;3740.9899327181643;3872.244912242114;3876.1472476055224;3976.673645917142;3987.421823835542;4005.259027079985;4017.4576432181575;4029.97985010076;3927.8428862845594;3934.449177115192;3944.0928586425;3954.169624378884;3959.3071212537834;3489.755717099804;3689.9631003689888;3751.76191856688;3935.8622448214173;4006.1186538961383;3164.7341063574754;3221.035168547184;3441.380551500729;3462.4286992646184;3471.097514646185;5064.898702025976;5071.594272458231;5089.847304580831;5100.413452452941;5106.9489305106845;4011.2579172852825;4391.780410979438;4415.425056988526;4498.572635599646;4522.34426008227;4317.20789923185;5228.6993722762245;5389.434109418533;5395.622306438551;5438.7280635968045;3319.850606722679;3696.467919475168;3759.51126353575;3788.583255841883;3796.367561948361;5424.701641409761;5667.829965101054;5710.628809127394;5723.824946520295;5758;3262.869485220612;3572.321258960841;3796.7911764853197;3821.9235615288094;3827.3684842000757;3127.5934128563595;3412.4540073588605;3847.846086156578;3896.0259935016247;3934.0361611404815;3812.733108682421;3998.8800335989968;4522.4573051234065;4546.931796023062;4547.636189104864;4569.360289559464;5031.421386540522;5207.114790485626;5461.9453805462235;5577.247071645276;1254.5859866244118;1308.8363954505687;1333.5399287245884;1335.6393773681052;1340.705044890142;782.712438039422;822.2188920525405;822.6791551294999;830.47679961625;831.6817843717654;4804.567588917014;4920.3603531541385;4963.610189147044;4973.35346404965;5115.462876397999;4998.325226094504;5004.84985450437;5627.117289070528;5661.2923384576925;5757.495489462098;4844.958333958216;4997.30037794709;5131.947950670104;5146.459621739738;5151.424287856072;2903.4918889194305;2908.403777225664;2927.355981684026;2930.3113768264443;2938.647362316493;5606.607537472338;5728.656280623176;5748.885022299531;5778.36437991829;5783.971080144656;5076.593872490192;5346.759395827197;5710.71446427677;5775.855603609859;5803.419658034247;4924.261360795909;5858.5898987070495;5979.581429299994;5990.700464976734;6001.189839371629;4878.804847806048;5621.775128994795;5664.660120392789;5677.290338707661;5685.147227915681;4947.208446648519;5517.724113794375;5528.834134975958;5603.551715862803;5608.747606357642;5819.5742043198;5851.795187168429;5872.559558033079;5897.321807992136;5946.613470124428;3167.7782555221834;3177.727924533969;3880.7865567392937;3918.1575961167346;3920.3923391874305;4740.6444516660695;5107.87230319245;5617.74720137603;5642.689652069175;5660.632058916157;4624.260118381043;4678.321643361625;5458.426865179258;5475.780968761205;5515.200295957144;4625.491195968373;5137.434882162885;5394.136938089887;5442.918356224739;5480.6437581557075;5347.090994531017;5353.197020446964;5362.758675859518;5366.604682782427;5377.758000889891;5044.1424957758;5222.869428264324;5406;5457.672539647634;5485.670859748428;4400.383946247464;4525.027119169395;4600.355950166912;5224.458784658459;5387.164989426645 16:29:24 INFO - PROCESS | 1673 | |5;yui.html;701.5475018612995;704.3449591879552;734.295076726343;810.5622963599657;812.8374325134974;15855.920720396396;16491.752623710654;16540.338386464526;16578.419755308565;16626.66746665066;14298.07062540934;14395.92802035991;14407.135571865696;14434.639134021629;14464.421423143061;685.2599192871687;705.9823504412406;852.232990308724;866.960986755596;877.978050548735;858.5063588436674;869.7869022089596;870.9520976346298;872.9476231426103;873.1835733589082;938.1556599060866;938.8826396700413;941.2940294778916;941.5951141009364;943.6508491858023;720.4452571519901;888.693400776731;920.2178148573659;938.4416272317994;941.3175447800359;682.5495173185674;683.7538486144983;683.9965800171017;685.7085738561092;686.8797960356967;14725.410983560645;14774.039687420283;14777.778333325008;14802.629934251621;14851.108933463918;13463.3941472633;13615.25116118613;13704.781870026101;13829.654258643513;13942.302884855819;12039.458224379836;12584.119111662187;12598.118131730782;12619.684507887285;12808.167469114478;3533.717302615785;4044.898877528056;4595.126925884071;4631.490536041067;4716.693414928019;122029;129593;129603.7039629601;130147.34926325403;130448.34775826155;10469.581216751398;10872.238943273895;10891.400972946405;10951.726206844893;11447.027002704697;21332.253371131937;21453.034613442433;21487.355379338333;21532.677009844865;21686.783132168475;7721.498102623312;7734.458587898793;7746.922530774733;7876.645550950221;7938.6427610757655;4293.97853010733;4321.395004699345;4342.32693932441;4352.586504282088;4470.307102399068;3388.423967925459;3511.7717348372275;3515.402381595135;3517.9824100879846;3518.876839310612;654.4796886475168;660.4155322539491;669.9799006029826;676.3540818518303;679.9694013769392;514.6526094886012;602.3193791016212;607.8267693707361;615.5691016288526;627.8744251149789;9005.684801032063;9361.531923403803;9562.713118606453;9601.855972160423;9627.663031793994;576.9307683078058;603.6127561513474;657.6547312660891;683.3781259054236;689.2418339826152;3612.819359032038;4375.846845360397;4645.0334406737675;4667.483956144294;4672.953270467252;147770;151229.21926951694;164917;166120;173514;91414.54292728494;105993;106557.40163897548;136216.31891840478;140794;120552.39723801325;123665;127980.36009820078;128762;128869;8765.737027889174;8859.202671759573;8887.289016878505;8959.163371508956;9051.14014168653;50137.49037567481;60705.48236294128;61981.38018619756;65645;67727.66136169288;97989;105225;105742.47128764307;106405;109130.90869091208;9949.204063674744;11649.825252621387;11865.466054027416;11963;12322.383880805744;9284.95357523208;12220.327881966577;12318.938405307916;12815.423305951068;13196.010299227404;13357.198568085945;14136.222507762172;14220.146791192561;14276;14380.209088500233;13455.730885382432;13473.124246923919;13641.590752277447;13761.793573096611;13903.09629874055;13134.146280491737;13173.538926137539;13434.93282533581;13768.931155344158;14340.426382944564;10775.245732798943;11072.39101849406;11429.771404571695;11709.414529273332;11916.463759130687;11125.388103654377;11295.717607059889;11412.657620271406;11522.308661480338;11533 16:29:24 INFO - PROCESS | 1673 | __end_tp_report 16:29:24 INFO - PROCESS | 1673 | __start_cc_report 16:29:24 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1353 16:29:24 INFO - PROCESS | 1673 | __end_cc_report 16:29:24 INFO - PROCESS | 1673 | __startTimestamp1473031764767__endTimestamp 16:29:24 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | ------- Summary: start ------- 16:29:24 INFO - PROCESS | 1673 | Number of tests: 6 16:29:24 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5753.79 Median:5932.26 stddev:652.17 (11.0%) stddev-sans-first:624.29 16:29:24 INFO - PROCESS | 1673 | Values: 3266.5 3280.3 3290.4 3332.1 3361.2 5593.0 5616.1 5667.2 5690.2 5690.6 5690.8 5731.6 5741.7 5742.2 5751.1 5156.2 5201.1 5206.2 5215.5 5261.3 5215.8 5231.9 5232.2 5239.4 5244.5 5141.7 5204.6 5236.0 5242.7 5255.1 5253.0 5278.6 5289.1 5297.8 5334.5 5082.9 5091.0 5112.8 5210.3 5214.1 5645.2 5674.3 5711.0 5756.8 5796.1 6251.4 6270.4 6271.3 6277.9 6286.8 6102.9 6209.2 6287.4 6299.4 6332.1 5774.4 5792.1 5794.9 5802.6 5805.0 6289.3 6317.8 6323.7 6348.4 6358.0 5984.7 6099.4 6137.6 6165.4 6174.6 6239.5 6280.1 6313.3 6326.7 6331.5 6196.2 6250.3 6259.5 6272.1 6294.5 6138.8 6142.2 6144.9 6293.2 6322.9 4901.4 4912.5 4918.2 4924.7 4931.9 4380.9 4405.5 4440.5 4446.2 4482.2 5744.7 5752.5 5759.3 5780.4 5786.7 6246.9 6342.1 6345.3 6351.1 6354.9 5588.6 5651.8 5658.6 5748.6 5789.5 5400.5 5412.7 5413.2 5416.1 5418.4 6133.6 6275.8 6279.5 6282.5 6313.0 6346.4 6346.6 6347.3 6347.5 6363.2 5347.0 6320.1 6324.0 6338.5 6340.5 6065.4 6112.1 6121.8 6164.2 6211.1 6332.9 6339.3 6356.0 6359.9 6362.5 5986.7 6122.6 6176.0 6180.3 6193.4 5856.4 5930.2 5932.3 6033.8 6155.3 5852.9 5885.9 5937.1 5956.1 5970.8 6107.4 6122.7 6131.9 6135.1 6152.9 5876.7 5903.1 5940.4 5977.9 5981.8 16:29:24 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:80434.44 Median:22021.69 stddev:187290.69 (850.5%) stddev-sans-first:187719.96 16:29:24 INFO - PROCESS | 1673 | Values: 510.7 517.5 525.2 537.2 557.4 30735.0 32435.0 32442.2 32450.7 32507.7 42028.6 43321.0 43410.6 45891.1 45922.0 9825.5 9977.2 9984.7 9990.7 9998.7 8861.7 9829.8 9946.2 9955.7 9959.0 8890.0 9055.1 9094.1 9098.6 11862.8 9643.7 12356.8 12388.9 12395.3 12415.5 11072.8 12034.6 12062.8 12094.8 12098.6 37565.4 40668.4 40683.0 40709.6 40856.8 3628.3 3777.4 3829.7 4021.6 4076.2 30582.2 31827.8 31882.5 32673.2 32809.8 3268.8 3357.7 3390.6 3410.4 3435.8 506595.0 509064.0 509494.5 511529.0 511786.0 62753.4 62968.0 63134.1 63171.0 63266.4 61572.8 61601.0 61683.7 61785.1 61859.2 16452.0 16736.7 16750.7 16775.8 16803.6 12914.3 13009.9 13015.8 13021.5 13023.3 16744.3 19027.9 19043.5 19081.0 19243.4 6520.4 7766.6 7985.9 8054.2 8070.7 870.8 934.3 979.3 990.2 1050.8 29786.4 29836.0 30080.5 30769.0 31016.5 989.0 1000.9 1064.3 1108.6 1130.2 14896.7 15633.1 15657.8 15751.6 16027.7 690083.1 697644.0 698411.0 700642.0 701485.0 53088.1 57433.9 58489.0 59093.0 59189.7 1320.1 1349.7 1378.3 1384.8 1388.1 30407.4 30503.0 31195.8 31981.5 31994.0 52557.7 57052.7 57218.0 57289.0 57302.7 636846.0 858776.0 890431.5 894008.0 897298.0 42771.8 42845.0 43030.8 43547.1 43727.3 39840.8 48107.5 48844.8 48924.3 49267.0 37441.8 39725.6 39868.8 39883.0 41571.8 39955.6 40021.8 40548.7 41298.8 41516.0 38314.2 38490.0 39191.6 39269.8 39319.0 32931.7 33970.0 34512.5 34678.0 35183.6 23688.5 24671.8 25315.2 25533.5 26130.6 16:29:24 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:34511.90 Median:13837.13 stddev:97655.45 (705.7%) stddev-sans-first:97895.70 16:29:24 INFO - PROCESS | 1673 | Values: 343.5 362.6 364.5 378.1 394.7 13700.0 15229.5 19832.7 19960.7 19988.9 11884.3 15385.2 19338.8 20046.7 20309.5 5247.3 5518.1 5522.8 5523.3 5527.7 5383.5 5485.3 5970.2 6019.2 6019.5 5960.3 5960.3 5962.3 5976.6 5988.6 5681.0 5873.7 5947.8 5954.4 5963.9 4984.4 5264.9 5269.4 5272.0 5298.4 12668.7 13408.9 20790.2 25263.7 25774.7 2036.9 2189.8 2410.5 2615.4 2765.0 10008.7 10147.8 10437.0 11548.2 16177.4 1849.8 1865.0 1874.3 1875.9 1946.1 111179.0 118245.4 124908.1 125068.0 125327.4 10632.5 10942.8 11076.7 11450.8 11706.9 14429.1 14469.5 14498.1 14500.3 14516.6 8247.7 8547.6 8582.7 8679.3 8685.2 8472.8 8496.2 8509.5 8670.4 8697.9 3604.7 4481.5 4501.1 4560.5 4581.6 1873.3 1917.8 1919.1 1923.7 1976.8 817.7 891.1 921.3 923.0 950.8 15907.8 15965.4 20048.0 20945.0 21061.0 823.3 869.5 879.3 973.4 992.4 10230.9 10819.6 10856.6 10862.3 10874.2 530931.0 584120.0 592459.0 595259.0 605284.0 123276.4 126739.0 133125.0 133410.0 138681.0 932.9 934.0 960.6 962.5 964.8 15190.8 16590.2 18171.6 18597.3 18729.0 55268.0 56547.7 56954.7 57273.7 57329.1 82241.0 82460.0 82651.0 82949.8 84039.0 7735.6 7769.0 8033.7 8106.8 8137.0 11060.4 12039.5 12371.6 12419.9 12519.3 10236.0 10292.3 10607.2 10705.2 10820.8 10311.6 10419.7 10642.5 11001.5 11009.4 10785.5 10951.0 11183.6 11245.6 11298.9 7848.3 7881.0 7936.7 7972.4 8121.4 10362.9 10766.6 10854.9 10874.0 11546.9 16:29:24 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5676.23 Median:4895.32 stddev:3198.30 (65.3%) stddev-sans-first:3190.10 16:29:24 INFO - PROCESS | 1673 | Values: 1266.2 1304.0 1445.8 1599.3 1894.0 7856.9 8695.4 8980.3 8980.6 9104.1 8851.4 8918.2 8925.2 8935.5 8950.9 2084.8 2375.7 2381.8 2404.9 2409.7 2335.6 2369.4 2376.7 2380.3 2396.1 2366.5 2383.8 2396.4 2403.7 2405.7 2341.4 2365.0 2376.2 2378.1 2383.0 2316.9 2354.6 2355.5 2355.7 2369.0 8665.9 8762.3 8884.6 8896.9 8899.4 5291.9 5438.4 5438.8 5439.3 5443.6 3568.9 3660.8 3674.3 3749.8 3750.6 1093.0 1105.8 1106.6 1108.4 1131.8 11645.4 11665.9 11752.6 11772.8 11815.4 3831.7 4374.9 4654.4 4655.4 4656.5 9080.6 9103.8 9105.7 9106.1 9111.7 5264.8 5275.6 5280.7 5282.2 5285.2 4471.2 4626.8 4735.9 4899.7 4961.3 3705.5 3721.3 3830.8 3832.8 3869.1 1157.8 1164.8 1168.4 1176.8 1181.6 758.0 815.9 883.6 894.0 915.1 5628.6 5742.3 5955.0 5963.8 6044.0 421.7 433.6 433.7 433.8 915.2 4022.9 4073.8 4094.3 4182.2 4221.8 9203.4 10711.7 10779.9 10859.8 10915.5 10848.4 10851.8 10852.0 10853.3 10860.2 7749.1 8109.6 8121.1 8145.3 8287.3 5909.3 5937.0 5951.6 6128.7 6172.0 8614.7 10135.5 10235.9 10240.0 10272.1 8661.0 10213.8 10253.9 10373.0 10378.8 6995.7 7204.5 7217.1 7526.7 7693.8 7963.6 8019.2 8064.0 8250.5 8339.0 7354.7 7488.1 7579.7 7651.3 7740.9 7243.9 7402.1 7447.7 7480.6 7621.8 6827.8 6989.1 6989.2 6990.9 7005.5 4425.3 4890.9 5045.1 5078.1 5171.0 4906.3 5045.1 5068.5 5205.7 5228.7 16:29:24 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:4427.68 Median:5037.78 stddev:1374.81 (27.3%) stddev-sans-first:1343.22 16:29:24 INFO - PROCESS | 1673 | Values: 295.0 300.1 304.7 309.3 309.8 5196.2 5202.9 5226.2 5229.3 5267.8 5187.9 5188.7 5211.4 5220.7 5227.4 3434.4 3713.5 3741.0 3872.2 3876.1 3976.7 3987.4 4005.3 4017.5 4030.0 3927.8 3934.4 3944.1 3954.2 3959.3 3489.8 3690.0 3751.8 3935.9 4006.1 3164.7 3221.0 3441.4 3462.4 3471.1 5064.9 5071.6 5089.8 5100.4 5106.9 4011.3 4391.8 4415.4 4498.6 4522.3 4317.2 5228.7 5389.4 5395.6 5438.7 3319.9 3696.5 3759.5 3788.6 3796.4 5424.7 5667.8 5710.6 5723.8 5758.0 3262.9 3572.3 3796.8 3821.9 3827.4 3127.6 3412.5 3847.8 3896.0 3934.0 3812.7 3998.9 4522.5 4546.9 4547.6 4569.4 5031.4 5207.1 5461.9 5577.2 1254.6 1308.8 1333.5 1335.6 1340.7 782.7 822.2 822.7 830.5 831.7 4804.6 4920.4 4963.6 4973.4 5115.5 4998.3 5004.8 5627.1 5661.3 5757.5 4845.0 4997.3 5131.9 5146.5 5151.4 2903.5 2908.4 2927.4 2930.3 2938.6 5606.6 5728.7 5748.9 5778.4 5784.0 5076.6 5346.8 5710.7 5775.9 5803.4 4924.3 5858.6 5979.6 5990.7 6001.2 4878.8 5621.8 5664.7 5677.3 5685.1 4947.2 5517.7 5528.8 5603.6 5608.7 5819.6 5851.8 5872.6 5897.3 5946.6 3167.8 3177.7 3880.8 3918.2 3920.4 4740.6 5107.9 5617.7 5642.7 5660.6 4624.3 4678.3 5458.4 5475.8 5515.2 4625.5 5137.4 5394.1 5442.9 5480.6 5347.1 5353.2 5362.8 5366.6 5377.8 5044.1 5222.9 5406.0 5457.7 5485.7 4400.4 4525.0 4600.4 5224.5 5387.2 16:29:24 INFO - PROCESS | 1673 | 16:29:24 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:26075.75 Median:12537.60 stddev:42777.95 (341.2%) stddev-sans-first:42855.52 16:29:24 INFO - PROCESS | 1673 | Values: 701.5 704.3 734.3 810.6 812.8 15855.9 16491.8 16540.3 16578.4 16626.7 14298.1 14395.9 14407.1 14434.6 14464.4 685.3 706.0 852.2 867.0 878.0 858.5 869.8 871.0 872.9 873.2 938.2 938.9 941.3 941.6 943.7 720.4 888.7 920.2 938.4 941.3 682.5 683.8 684.0 685.7 686.9 14725.4 14774.0 14777.8 14802.6 14851.1 13463.4 13615.3 13704.8 13829.7 13942.3 12039.5 12584.1 12598.1 12619.7 12808.2 3533.7 4044.9 4595.1 4631.5 4716.7 122029.0 129593.0 129603.7 130147.3 130448.3 10469.6 10872.2 10891.4 10951.7 11447.0 21332.3 21453.0 21487.4 21532.7 21686.8 7721.5 7734.5 7746.9 7876.6 7938.6 4294.0 4321.4 4342.3 4352.6 4470.3 3388.4 3511.8 3515.4 3518.0 3518.9 654.5 660.4 670.0 676.4 680.0 514.7 602.3 607.8 615.6 627.9 9005.7 9361.5 9562.7 9601.9 9627.7 576.9 603.6 657.7 683.4 689.2 3612.8 4375.8 4645.0 4667.5 4673.0 147770.0 151229.2 164917.0 166120.0 173514.0 91414.5 105993.0 106557.4 136216.3 140794.0 120552.4 123665.0 127980.4 128762.0 128869.0 8765.7 8859.2 8887.3 8959.2 9051.1 50137.5 60705.5 61981.4 65645.0 67727.7 97989.0 105225.0 105742.5 106405.0 109130.9 9949.2 11649.8 11865.5 11963.0 12322.4 9285.0 12220.3 12318.9 12815.4 13196.0 13357.2 14136.2 14220.1 14276.0 14380.2 13455.7 13473.1 13641.6 13761.8 13903.1 13134.1 13173.5 13434.9 13768.9 14340.4 10775.2 11072.4 11429.8 11709.4 11916.5 11125.4 11295.7 11412.7 11522.3 11533.0 16:29:24 INFO - PROCESS | 1673 | -------- Summary: end -------- 16:29:24 INFO - PROCESS | 1673 | 16:29:25 INFO - TEST-INFO | 1673: exit 0 16:29:25 INFO - TEST-OK | dromaeo_css | took 1117649ms 16:29:25 INFO - TEST-START | kraken 16:29:25 INFO - operating with platform_type : mac_ 16:29:25 INFO - Initialising browser for kraken test... 16:29:25 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpefvoMm/profile http://localhost:49271/getInfo.html) 16:29:27 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 16:29:27 INFO - PROCESS | 1678 | colorDepth:24 16:29:27 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 16:29:27 INFO - PROCESS | 1678 | __metrics 16:29:27 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:29:27 INFO - PROCESS | 1678 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:28 INFO - TEST-INFO | 1678: exit 0 16:29:28 INFO - Browser initialized. 16:29:28 INFO - Running cycle 1/1 for kraken test... 16:29:28 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpefvoMm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:40 INFO - PROCESS | 1679 | RSS: Main: 231858176 16:29:40 INFO - PROCESS | 1679 | 16:29:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:29:44 INFO - PROCESS | 1679 | RSS: Main: 291000320 16:29:44 INFO - PROCESS | 1679 | 16:29:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:29:47 INFO - PROCESS | 1679 | RSS: Main: 288866304 16:29:47 INFO - PROCESS | 1679 | 16:29:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:29:51 INFO - PROCESS | 1679 | RSS: Main: 377540608 16:29:51 INFO - PROCESS | 1679 | 16:29:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:29:54 INFO - PROCESS | 1679 | RSS: Main: 278757376 16:29:54 INFO - PROCESS | 1679 | 16:29:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:29:56 INFO - PROCESS | 1679 | RSS: Main: 284557312 16:29:56 INFO - PROCESS | 1679 | 16:29:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:30:00 INFO - PROCESS | 1679 | RSS: Main: 323579904 16:30:00 INFO - PROCESS | 1679 | 16:30:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:30:03 INFO - PROCESS | 1679 | RSS: Main: 323493888 16:30:03 INFO - PROCESS | 1679 | 16:30:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:30:07 INFO - PROCESS | 1679 | RSS: Main: 320884736 16:30:07 INFO - PROCESS | 1679 | 16:30:08 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:09 INFO - PROCESS | 1679 | RSS: Main: 297791488 16:30:09 INFO - PROCESS | 1679 | 16:30:11 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:11 INFO - PROCESS | 1679 | RSS: Main: 303529984 16:30:11 INFO - PROCESS | 1679 | 16:30:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:14 INFO - PROCESS | 1679 | RSS: Main: 297807872 16:30:14 INFO - PROCESS | 1679 | 16:30:17 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:18 INFO - PROCESS | 1679 | RSS: Main: 318767104 16:30:18 INFO - PROCESS | 1679 | 16:30:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:22 INFO - PROCESS | 1679 | RSS: Main: 314855424 16:30:22 INFO - PROCESS | 1679 | 16:30:23 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:30:24 INFO - PROCESS | 1679 | RSS: Main: 358526976 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | __start_tp_report 16:30:24 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 16:30:24 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 16:30:24 INFO - PROCESS | 1679 | |i|pagename|runs| 16:30:24 INFO - PROCESS | 1679 | |0;ai-astar;114;114;118;112;114;114;112;115;113;123 16:30:24 INFO - PROCESS | 1679 | |1;audio-beat-detection;146;109;131;161;113;129;128;108;160;110 16:30:24 INFO - PROCESS | 1679 | |2;audio-dft;258;260;184;181;186;182;182;183;181;179 16:30:24 INFO - PROCESS | 1679 | |3;audio-fft;76;72;76;159;58;58;57;63;145;57 16:30:24 INFO - PROCESS | 1679 | |4;audio-oscillator;83;83;135;71;69;79;118;68;69;119 16:30:24 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;89;94;135;87;89;86;90;87;89;85 16:30:24 INFO - PROCESS | 1679 | |6;imaging-darkroom;96;98;99;97;97;96;98;98;96;98 16:30:24 INFO - PROCESS | 1679 | |7;imaging-desaturate;87;84;84;86;84;85;83;85;85;84 16:30:24 INFO - PROCESS | 1679 | |8;json-parse-financial;55;55;55;53;54;52;53;54;53;53 16:30:24 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;65;66;65;78;73;76;69;69;69;71 16:30:24 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;84;98;103;75;93;96;102;80;85;87 16:30:24 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;138;137;134;134;138;140;135;138;177;113 16:30:24 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;168;172;209;171;170;169;167;176;226;203 16:30:24 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;62;65;68;68;67;67;65;67;67;67 16:30:24 INFO - PROCESS | 1679 | __end_tp_report 16:30:24 INFO - PROCESS | 1679 | __start_cc_report 16:30:24 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,2035 16:30:24 INFO - PROCESS | 1679 | __end_cc_report 16:30:24 INFO - PROCESS | 1679 | __startTimestamp1473031824017__endTimestamp 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | ------- Summary: start ------- 16:30:24 INFO - PROCESS | 1679 | Number of tests: 14 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.00 stddev:3.31 (2.9%) stddev-sans-first:3.50 16:30:24 INFO - PROCESS | 1679 | Values: 114.0 114.0 118.0 112.0 114.0 114.0 112.0 115.0 113.0 123.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:130.00 stddev:20.37 (15.7%) stddev-sans-first:20.71 16:30:24 INFO - PROCESS | 1679 | Values: 146.0 109.0 131.0 161.0 113.0 129.0 128.0 108.0 160.0 110.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:197.60 Median:183.50 stddev:32.42 (17.7%) stddev-sans-first:25.99 16:30:24 INFO - PROCESS | 1679 | Values: 258.0 260.0 184.0 181.0 186.0 182.0 182.0 183.0 181.0 179.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:82.10 Median:60.50 stddev:37.76 (62.4%) stddev-sans-first:39.99 16:30:24 INFO - PROCESS | 1679 | Values: 76.0 72.0 76.0 159.0 58.0 58.0 57.0 63.0 145.0 57.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:70.00 stddev:24.93 (35.6%) stddev-sans-first:26.33 16:30:24 INFO - PROCESS | 1679 | Values: 83.0 83.0 135.0 71.0 69.0 79.0 118.0 68.0 69.0 119.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:89.00 stddev:14.93 (16.8%) stddev-sans-first:15.76 16:30:24 INFO - PROCESS | 1679 | Values: 89.0 94.0 135.0 87.0 89.0 86.0 90.0 87.0 89.0 85.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:98.00 stddev:1.06 (1.1%) stddev-sans-first:1.01 16:30:24 INFO - PROCESS | 1679 | Values: 96.0 98.0 99.0 97.0 97.0 96.0 98.0 98.0 96.0 98.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:0.88 16:30:24 INFO - PROCESS | 1679 | Values: 87.0 84.0 84.0 86.0 84.0 85.0 83.0 85.0 85.0 84.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:1.01 16:30:24 INFO - PROCESS | 1679 | Values: 55.0 55.0 55.0 53.0 54.0 52.0 53.0 54.0 53.0 53.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:4.46 (6.4%) stddev-sans-first:4.33 16:30:24 INFO - PROCESS | 1679 | Values: 65.0 66.0 65.0 78.0 73.0 76.0 69.0 69.0 69.0 71.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:86.00 stddev:9.52 (11.1%) stddev-sans-first:9.82 16:30:24 INFO - PROCESS | 1679 | Values: 84.0 98.0 103.0 75.0 93.0 96.0 102.0 80.0 85.0 87.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:138.00 stddev:15.60 (11.3%) stddev-sans-first:16.55 16:30:24 INFO - PROCESS | 1679 | Values: 138.0 137.0 134.0 134.0 138.0 140.0 135.0 138.0 177.0 113.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:174.00 stddev:21.30 (12.2%) stddev-sans-first:21.88 16:30:24 INFO - PROCESS | 1679 | Values: 168.0 172.0 209.0 171.0 170.0 169.0 167.0 176.0 226.0 203.0 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.09 16:30:24 INFO - PROCESS | 1679 | Values: 62.0 65.0 68.0 68.0 67.0 67.0 65.0 67.0 67.0 67.0 16:30:24 INFO - PROCESS | 1679 | -------- Summary: end -------- 16:30:24 INFO - PROCESS | 1679 | 16:30:24 INFO - TEST-INFO | 1679: exit 0 16:30:24 INFO - TEST-OK | kraken | took 59488ms 16:30:24 INFO - SUITE-END | took 1177s 16:30:25 INFO - Completed test suite (00:19:37) 16:30:25 INFO - javascript benchmark 16:30:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.4936934775105, 3280.2783387654713, 3290.4077266092095, 3332.067021234055, 3361.2101156228296, 5592.972035139829, 5616.073347897597, 5667.234923285355, 5690.2033715279895, 5690.630109042914, 5690.800821971232, 5731.627444216134, 5741.741621627027, 5742.196092547047, 5751.10857817038, 5156.2265660151, 5201.141811601081, 5206.219067139921, 5215.452377500345, 5261.289725886994, 5215.817446389377, 5231.895362092756, 5232.215167724834, 5239.397469291023, 5244.475552444763, 5141.691498510083, 5204.583633309345, 5235.973820130894, 5242.685438873661, 5255.054090263751, 5253.0, 5278.551323137538, 5289.100852855024, 5297.841064768025, 5334.519893209591, 5082.872928176826, 5091.0, 5112.821051263225, 5210.322658054467, 5214.06146893559, 5645.181448689958, 5674.262345895048, 5710.971445142789, 5756.769729210869, 5796.1305804129715, 6251.437370636664, 6270.372962703739, 6271.34150914152, 6277.937220627781, 6286.811395658137, 6102.870968870773, 6209.161763162006, 6287.371262873722, 6299.37006299371, 6332.145160403333, 5774.364819869811, 5792.073268277056, 5794.942050579524, 5802.564807639444, 5805.042168042268, 6289.339619339903, 6317.810465686037, 6323.683815809191, 6348.365163483615, 6357.968210159012, 5984.700764961734, 6099.420555047263, 6137.631742095488, 6165.445109940127, 6174.598651087665, 6239.500839932794, 6280.120783090371, 6313.273973493016, 6326.746930122836, 6331.461825744771, 6196.194494715658, 6250.343713910065, 6259.467945224706, 6272.1219029335925, 6294.527910406646, 6138.754449821957, 6142.191841058572, 6144.9246381882995, 6293.244810622755, 6322.936770632326, 4901.362822833009, 4912.459629440758, 4918.213085906309, 4924.72913989734, 4931.87670308238, 4380.8904777380185, 4405.471343438744, 4440.467143942683, 4446.221911165598, 4482.193205223026, 5744.712764361765, 5752.482276595127, 5759.251297331404, 5780.421957804186, 5786.739596718157, 6246.906296405557, 6342.112104305401, 6345.302016778151, 6351.110844481776, 6354.904676429857, 5588.608797384225, 5651.802186923438, 5658.603897727119, 5748.597598168171, 5789.507891829157, 5400.540954018952, 5412.675239485643, 5413.242146099549, 5416.133418652997, 5418.431064738224, 6133.57950150939, 6275.780347687901, 6279.529035322278, 6282.4974002080635, 6313.0, 6346.365363463617, 6346.555741098079, 6347.270063942521, 6347.460465860454, 6363.172787537591, 5346.973265133805, 6320.083587879823, 6324.0, 6338.492920566436, 6340.524460665376, 6065.363136870565, 6112.108359148444, 6121.788327166137, 6164.198654174928, 6211.09939058843, 6332.873342533031, 6339.334369891095, 6356.0465930109, 6359.904601431075, 6362.45919096882, 5986.700664966821, 6122.571420000557, 6176.042713379434, 6180.258368995749, 6193.4425901669065, 5856.3558008618165, 5930.199423078002, 5932.2584676915385, 6033.849153771015, 6155.261368635793, 5852.882942341044, 5885.882282354414, 5937.139114828412, 5956.106584012433, 5970.818633020363, 6107.3708791890585, 6122.713581872198, 6131.866048757478, 6135.1408007826785, 6152.938470615237, 5876.676782776817, 5903.144044113666, 5940.435658612425, 5977.9103313451205, 5981.7607295707685], "value": 5710.36239589865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.7420752519977, 517.5083670513012, 525.1912055434631, 537.1620272375093, 557.4035781713568, 30735.0, 32435.0, 32442.18894527638, 32450.67549324506, 32507.67492325076, 42028.579714202846, 43321.0, 43410.565894341125, 45891.08217835641, 45922.0, 9825.459599722013, 9977.15194208493, 9984.700458986243, 9990.700278991606, 9998.700038998806, 8861.689840855572, 9829.754256143582, 9946.20430365569, 9955.651552195675, 9958.95430979744, 8890.0, 9055.094490550926, 9094.136057074567, 9098.63605455781, 11862.7627447451, 9643.710688679352, 12356.752864942651, 12388.876111238862, 12395.256284622907, 12415.503379864886, 11072.778544429148, 12034.578789742405, 12062.819057714141, 12094.818577721342, 12098.576549820715, 37565.43651845225, 40668.389974150414, 40683.0, 40709.59290407088, 40856.79571602153, 3628.2924829658227, 3777.376732839106, 3829.7127715421457, 4021.5830899460307, 4076.2051399977017, 30582.235444113852, 31827.840860795546, 31882.521762173586, 32673.183170420692, 32809.83595082033, 3268.836558172082, 3357.731381489475, 3390.610079840825, 3410.4202285611505, 3435.8282085895607, 506595.0, 509064.0, 509494.4525277387, 511529.0, 511786.0, 62753.372466275665, 62967.96256299485, 63134.0529892052, 63171.0, 63266.367336326046, 61572.768544629755, 61601.0, 61683.6915815418, 61785.07322390168, 61859.19548849623, 16452.0, 16736.6652666946, 16750.66498670044, 16775.832241677672, 16803.579910502092, 12914.289714065628, 13009.89415899659, 13015.804762928563, 13021.47914083445, 13023.348832558335, 16744.328715711606, 19027.90486047561, 19043.523911902314, 19081.0, 19243.422697319103, 6520.413162815369, 7766.5728384939375, 7985.920140798634, 8054.154313797084, 8070.717524886718, 870.8388948044632, 934.3272843552631, 979.3291595257272, 990.2424645146468, 1050.753073027838, 29786.40427191444, 29836.0, 30080.548791768142, 30769.0, 31016.53475197874, 989.0406305883282, 1000.9249306302056, 1064.2816099133054, 1108.6009036746764, 1130.2483848240827, 14896.702065958836, 15633.14017729013, 15657.765133523006, 15751.606209844616, 16027.679446411006, 690083.0991690019, 697644.0, 698411.0, 700642.0, 701485.0, 53088.080155591815, 57433.85132297331, 58489.0, 59093.0, 59189.704051479464, 1320.0891384944357, 1349.7165595224917, 1378.2970684950747, 1384.7992041153975, 1388.0977364713017, 30407.39185216239, 30503.0, 31195.75216991295, 31981.520277196327, 31994.040178794672, 52557.737211313695, 57052.72735453253, 57218.0, 57289.0, 57302.7134864323, 636846.0, 858776.0, 890431.5478422566, 894008.0, 897298.0, 42771.7861410691, 42845.0, 43030.78484607557, 43547.129057419304, 43727.34408983804, 39840.800795995834, 48107.518924810305, 48844.75577622089, 48924.2661360087, 49267.0, 37441.81279093587, 39725.60274397219, 39868.800655996536, 39883.00292492711, 41571.7921410391, 39955.60044399635, 40021.79989100036, 40548.74575935372, 41298.79350603348, 41516.0, 38314.23371532498, 38490.0377490565, 39191.60808391879, 39269.803650981565, 39319.01702457461, 32931.67068329286, 33970.0, 34512.48231276483, 34678.0, 35183.64816351906, 23688.526229475658, 24671.753282466947, 25315.240542783748, 25533.48933021292, 26130.608040879782], "value": 21044.321083989696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.5087824411094, 362.6174386022746, 364.50427418710547, 378.11332425462297, 394.65862029344606, 13700.0, 15229.543113706593, 19832.70250946237, 19960.700589491153, 19988.90061046642, 11884.346360950145, 15385.23073846306, 19338.806611933876, 20046.69929951048, 20309.49226269344, 5247.317848679676, 5518.061929471999, 5522.751476183581, 5523.25436066132, 5527.668339899619, 5383.515483606475, 5485.286912701344, 5970.223870896777, 6019.1874096997, 6019.5485338599565, 5960.254968128984, 5960.344362120185, 5962.25471816023, 5976.611520251192, 5988.610740301867, 5680.971595142039, 5873.7356818943035, 5947.791827286068, 5954.374790646963, 5963.940360596382, 4984.352034235562, 5264.894702105975, 5269.367675878881, 5271.973640131813, 5298.390685071227, 12668.746625067539, 13408.865911340958, 20790.16839326425, 25263.747362526323, 25774.74225257761, 2036.9287074952454, 2189.8357623178167, 2410.517896420723, 2615.4115324052127, 2765.0045983445943, 10008.697999460164, 10147.797044059078, 10437.00848419399, 11548.191626586142, 16177.35290588375, 1849.7780266367988, 1864.9627007459774, 1874.2784028149124, 1875.9062046897736, 1946.0853398902493, 111179.0, 118245.40877295559, 124908.12637810531, 125068.0, 125327.3733631335, 10632.468376581295, 10942.781144377228, 11076.723081923017, 11450.770984580262, 11706.892759303408, 14429.134251944917, 14469.49356772508, 14498.05762625426, 14500.347484363228, 14516.564503064925, 8247.670093196324, 8547.57262136903, 8582.742517724479, 8679.266031200152, 8685.174908383693, 8472.830543389098, 8496.235338819535, 8509.489430634181, 8670.436421632574, 8697.869531957025, 3604.675579197885, 4481.5070342262325, 4501.122281155143, 4560.475545312265, 4581.5647513486165, 1873.278787666758, 1917.8178073083313, 1919.1363886251243, 1923.6729755941524, 1976.8023197680118, 817.7301490508119, 891.0999890111035, 921.3366376209119, 923.0123767568771, 950.8336041192902, 15907.761383579256, 15965.361385544447, 20048.0, 20945.0, 21061.0, 823.3043078598574, 869.4652788535005, 879.2965627497977, 973.4451362723321, 992.4194346307347, 10230.94435662665, 10819.600393837774, 10856.581159904928, 10862.348683389491, 10874.160998355814, 530931.0, 584120.0, 592459.0, 595259.0, 605284.0, 123276.38361808134, 126739.0, 133125.0, 133410.0, 138681.0, 932.8927173375149, 933.9766505837273, 960.6349587156835, 962.4802606592361, 964.8311545479513, 15190.848091518943, 16590.170491475135, 18171.636567268317, 18597.34909278169, 18728.96990665472, 55268.0, 56547.71726141343, 56954.71522642526, 57273.71363143158, 57329.14006289826, 82241.0, 82460.0, 82651.0, 82949.75575366254, 84039.0, 7735.574543399942, 7769.0, 8033.6786528538205, 8106.79733006656, 8136.959315203386, 11060.446977651247, 12039.458224379749, 12371.628851134481, 12419.875801242233, 12519.311437871005, 10236.027577380137, 10292.279540432099, 10607.20445966571, 10705.19711021661, 10820.783584328427, 10311.576779456971, 10419.687409377731, 10642.467876606293, 11001.504932277907, 11009.394483303495, 10785.514651840529, 10951.0, 11183.552657893919, 11245.606403775828, 11298.943505282421, 7848.293653571206, 7880.960595196987, 7936.730123180263, 7972.441929064909, 8121.431499794958, 10362.896371036193, 10766.569337226423, 10854.945725271324, 10874.0, 11546.94226528862], "value": 9332.672565975121, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.2276011632905, 1304.0089531955712, 1445.7614493608555, 1599.312295712843, 1893.962120757585, 7856.882146767796, 8695.39132260742, 8980.281577473803, 8980.550972451376, 9104.13510716481, 8851.380403371766, 8918.152775486318, 8925.152110549487, 8935.508547029911, 8950.910490895105, 2084.801943815343, 2375.681496769292, 2381.797547208485, 2404.9298062362254, 2409.7108346998384, 2335.5679199348174, 2369.4431808524982, 2376.6791483149814, 2380.2621187431864, 2396.113438027923, 2366.538524987628, 2383.797377222938, 2396.400899775056, 2403.7235717892404, 2405.651180578815, 2341.4263505441277, 2365.042157926043, 2376.1564644551195, 2378.1438682074613, 2383.0467812874817, 2316.860988340688, 2354.5526349993447, 2355.5053438777877, 2355.6702061711376, 2368.9644655330185, 8665.913340866637, 8762.299016078761, 8884.600192991265, 8896.8665470018, 8899.421537600036, 5291.920621190685, 5438.428964958702, 5438.809641662523, 5439.347278326626, 5443.59173062018, 3568.946465803015, 3660.762050466711, 3674.3202507536193, 3749.793761343125, 3750.5686846012786, 1093.0, 1105.7843720474511, 1106.6403418888813, 1108.4070022537903, 1131.847200627913, 11645.417729113511, 11665.883341166564, 11752.588659396966, 11772.823407648892, 11815.409229538489, 3831.674307683878, 4374.8906277342685, 4654.418197725285, 4655.441347038377, 4656.4645065817185, 9080.59137338808, 9103.81792364149, 9105.726828195166, 9106.089391060841, 9111.726648200565, 5264.78940842362, 5275.57795376369, 5280.683159010472, 5282.154855223146, 5285.154375299933, 4471.195184866755, 4626.8380606679275, 4735.928961065587, 4899.730514821647, 4961.330220420269, 3705.4997575327525, 3721.2743515014313, 3830.751001184914, 3832.80835958201, 3869.1487872667967, 1157.8263260510823, 1164.813629819242, 1168.39243593331, 1176.847009888726, 1181.5864447443498, 757.9962100189464, 815.8857759913617, 883.6377085394957, 893.9865902011475, 915.1214833759665, 5628.634138780966, 5742.253507044057, 5955.017422125387, 5963.761449542057, 6044.03295472731, 421.7300927406462, 433.55343995684495, 433.7267521461522, 433.83731100837184, 915.231205787142, 4022.899427514277, 4073.7555746655294, 4094.3449048152747, 4182.163567286555, 4221.831126754895, 9203.447793132433, 10711.678649640524, 10779.946100269448, 10859.75112862031, 10915.454227288605, 10848.403337816339, 10851.78296434067, 10852.023317901427, 10853.34879907208, 10860.239783215256, 7749.147593764681, 8109.635066422025, 8121.066077401175, 8145.266925976691, 8287.295579875778, 5909.261342332208, 5937.00181408386, 5951.613145145551, 6128.724207410766, 6171.9691401544505, 8614.698485552975, 10135.493225338556, 10235.897641023494, 10240.0, 10272.075513203548, 8660.956695216735, 10213.795724085625, 10253.897461025294, 10373.014563616445, 10378.844317335397, 6995.720171193096, 7204.495685302189, 7217.097862767154, 7526.661300241612, 7693.807654808675, 7963.562004089831, 8019.1579884111325, 8063.959680201561, 8250.504969701837, 8338.999320081386, 7354.6690398931105, 7488.063992001, 7579.734709285369, 7651.273129052731, 7740.92259077402, 7243.927560724536, 7402.1117465904435, 7447.702091916262, 7480.625968701652, 7621.771346859603, 6827.7610283641825, 6989.091418115612, 6989.1962424321855, 6990.9300906990275, 7005.54463959841, 4425.291953287458, 4890.902181956412, 5045.117104506623, 5078.085944529872, 5171.0, 4906.313116163668, 5045.0738571627635, 5068.493150684902, 5205.687658740488, 5228.71242081674], "value": 4491.951065792062, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.97787665925057, 300.13411308375345, 304.7485824195039, 309.330299900715, 309.82649716158954, 5196.194589838572, 5202.8699282517955, 5226.189940559215, 5229.320188375511, 5267.789288428467, 5187.870303242421, 5188.688678679282, 5211.42674305826, 5220.712860792655, 5227.398849132351, 3434.364642541138, 3713.535808023997, 3740.9899327181643, 3872.244912242114, 3876.1472476055224, 3976.673645917142, 3987.421823835542, 4005.259027079985, 4017.4576432181575, 4029.97985010076, 3927.8428862845594, 3934.449177115192, 3944.0928586425, 3954.169624378884, 3959.3071212537834, 3489.755717099804, 3689.9631003689888, 3751.76191856688, 3935.8622448214173, 4006.1186538961383, 3164.7341063574754, 3221.035168547184, 3441.380551500729, 3462.4286992646184, 3471.097514646185, 5064.898702025976, 5071.594272458231, 5089.847304580831, 5100.413452452941, 5106.9489305106845, 4011.2579172852825, 4391.780410979438, 4415.425056988526, 4498.572635599646, 4522.34426008227, 4317.20789923185, 5228.6993722762245, 5389.434109418533, 5395.622306438551, 5438.7280635968045, 3319.850606722679, 3696.467919475168, 3759.51126353575, 3788.583255841883, 3796.367561948361, 5424.701641409761, 5667.829965101054, 5710.628809127394, 5723.824946520295, 5758.0, 3262.869485220612, 3572.321258960841, 3796.7911764853197, 3821.9235615288094, 3827.3684842000757, 3127.5934128563595, 3412.4540073588605, 3847.846086156578, 3896.0259935016247, 3934.0361611404815, 3812.733108682421, 3998.8800335989968, 4522.4573051234065, 4546.931796023062, 4547.636189104864, 4569.360289559464, 5031.421386540522, 5207.114790485626, 5461.9453805462235, 5577.247071645276, 1254.5859866244118, 1308.8363954505687, 1333.5399287245884, 1335.6393773681052, 1340.705044890142, 782.712438039422, 822.2188920525405, 822.6791551294999, 830.47679961625, 831.6817843717654, 4804.567588917014, 4920.3603531541385, 4963.610189147044, 4973.35346404965, 5115.462876397999, 4998.325226094504, 5004.84985450437, 5627.117289070528, 5661.2923384576925, 5757.495489462098, 4844.958333958216, 4997.30037794709, 5131.947950670104, 5146.459621739738, 5151.424287856072, 2903.4918889194305, 2908.403777225664, 2927.355981684026, 2930.3113768264443, 2938.647362316493, 5606.607537472338, 5728.656280623176, 5748.885022299531, 5778.36437991829, 5783.971080144656, 5076.593872490192, 5346.759395827197, 5710.71446427677, 5775.855603609859, 5803.419658034247, 4924.261360795909, 5858.5898987070495, 5979.581429299994, 5990.700464976734, 6001.189839371629, 4878.804847806048, 5621.775128994795, 5664.660120392789, 5677.290338707661, 5685.147227915681, 4947.208446648519, 5517.724113794375, 5528.834134975958, 5603.551715862803, 5608.747606357642, 5819.5742043198, 5851.795187168429, 5872.559558033079, 5897.321807992136, 5946.613470124428, 3167.7782555221834, 3177.727924533969, 3880.7865567392937, 3918.1575961167346, 3920.3923391874305, 4740.6444516660695, 5107.87230319245, 5617.74720137603, 5642.689652069175, 5660.632058916157, 4624.260118381043, 4678.321643361625, 5458.426865179258, 5475.780968761205, 5515.200295957144, 4625.491195968373, 5137.434882162885, 5394.136938089887, 5442.918356224739, 5480.6437581557075, 5347.090994531017, 5353.197020446964, 5362.758675859518, 5366.604682782427, 5377.758000889891, 5044.1424957758, 5222.869428264324, 5406.0, 5457.672539647634, 5485.670859748428, 4400.383946247464, 4525.027119169395, 4600.355950166912, 5224.458784658459, 5387.164989426645], "value": 3988.2983164391244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.5475018612995, 704.3449591879552, 734.295076726343, 810.5622963599657, 812.8374325134974, 15855.920720396396, 16491.752623710654, 16540.338386464526, 16578.419755308565, 16626.66746665066, 14298.07062540934, 14395.92802035991, 14407.135571865696, 14434.639134021629, 14464.421423143061, 685.2599192871687, 705.9823504412406, 852.232990308724, 866.960986755596, 877.978050548735, 858.5063588436674, 869.7869022089596, 870.9520976346298, 872.9476231426103, 873.1835733589082, 938.1556599060866, 938.8826396700413, 941.2940294778916, 941.5951141009364, 943.6508491858023, 720.4452571519901, 888.693400776731, 920.2178148573659, 938.4416272317994, 941.3175447800359, 682.5495173185674, 683.7538486144983, 683.9965800171017, 685.7085738561092, 686.8797960356967, 14725.410983560645, 14774.039687420283, 14777.778333325008, 14802.629934251621, 14851.108933463918, 13463.3941472633, 13615.25116118613, 13704.781870026101, 13829.654258643513, 13942.302884855819, 12039.458224379836, 12584.119111662187, 12598.118131730782, 12619.684507887285, 12808.167469114478, 3533.717302615785, 4044.898877528056, 4595.126925884071, 4631.490536041067, 4716.693414928019, 122029.0, 129593.0, 129603.7039629601, 130147.34926325403, 130448.34775826155, 10469.581216751398, 10872.238943273895, 10891.400972946405, 10951.726206844893, 11447.027002704697, 21332.253371131937, 21453.034613442433, 21487.355379338333, 21532.677009844865, 21686.783132168475, 7721.498102623312, 7734.458587898793, 7746.922530774733, 7876.645550950221, 7938.6427610757655, 4293.97853010733, 4321.395004699345, 4342.32693932441, 4352.586504282088, 4470.307102399068, 3388.423967925459, 3511.7717348372275, 3515.402381595135, 3517.9824100879846, 3518.876839310612, 654.4796886475168, 660.4155322539491, 669.9799006029826, 676.3540818518303, 679.9694013769392, 514.6526094886012, 602.3193791016212, 607.8267693707361, 615.5691016288526, 627.8744251149789, 9005.684801032063, 9361.531923403803, 9562.713118606453, 9601.855972160423, 9627.663031793994, 576.9307683078058, 603.6127561513474, 657.6547312660891, 683.3781259054236, 689.2418339826152, 3612.819359032038, 4375.846845360397, 4645.0334406737675, 4667.483956144294, 4672.953270467252, 147770.0, 151229.21926951694, 164917.0, 166120.0, 173514.0, 91414.54292728494, 105993.0, 106557.40163897548, 136216.31891840478, 140794.0, 120552.39723801325, 123665.0, 127980.36009820078, 128762.0, 128869.0, 8765.737027889174, 8859.202671759573, 8887.289016878505, 8959.163371508956, 9051.14014168653, 50137.49037567481, 60705.48236294128, 61981.38018619756, 65645.0, 67727.66136169288, 97989.0, 105225.0, 105742.47128764307, 106405.0, 109130.90869091208, 9949.204063674744, 11649.825252621387, 11865.466054027416, 11963.0, 12322.383880805744, 9284.95357523208, 12220.327881966577, 12318.938405307916, 12815.423305951068, 13196.010299227404, 13357.198568085945, 14136.222507762172, 14220.146791192561, 14276.0, 14380.209088500233, 13455.730885382432, 13473.124246923919, 13641.590752277447, 13761.793573096611, 13903.09629874055, 13134.146280491737, 13173.538926137539, 13434.93282533581, 13768.931155344158, 14340.426382944564, 10775.245732798943, 11072.39101849406, 11429.771404571695, 11709.414529273332, 11916.463759130687, 11125.388103654377, 11295.717607059889, 11412.657620271406, 11522.308661480338, 11533.0], "value": 7874.285184896245, "unit": "score"}], "name": "dromaeo_css", "value": 7354.412856526418, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 118.0, 112.0, 114.0, 114.0, 112.0, 115.0, 113.0, 123.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 131.0, 161.0, 113.0, 129.0, 128.0, 108.0, 160.0, 110.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [258.0, 260.0, 184.0, 181.0, 186.0, 182.0, 182.0, 183.0, 181.0, 179.0], "value": 197.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 76.0, 159.0, 58.0, 58.0, 57.0, 63.0, 145.0, 57.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 135.0, 71.0, 69.0, 79.0, 118.0, 68.0, 69.0, 119.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 135.0, 87.0, 89.0, 86.0, 90.0, 87.0, 89.0, 85.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 99.0, 97.0, 97.0, 96.0, 98.0, 98.0, 96.0, 98.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 86.0, 84.0, 85.0, 83.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 53.0, 54.0, 52.0, 53.0, 54.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 78.0, 73.0, 76.0, 69.0, 69.0, 69.0, 71.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 98.0, 103.0, 75.0, 93.0, 96.0, 102.0, 80.0, 85.0, 87.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 134.0, 134.0, 138.0, 140.0, 135.0, 138.0, 177.0, 113.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 209.0, 171.0, 170.0, 169.0, 167.0, 176.0, 226.0, 203.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 68.0, 68.0, 67.0, 67.0, 65.0, 67.0, 67.0, 67.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1490.5, "alertThreshold": 2.0}]} 16:30:25 INFO - Return code: 0 16:30:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:30:25 INFO - # TBPL SUCCESS # 16:30:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:30:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:30:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:30:25 INFO - 2016-09-04 16:30:25.362 screenresolution[1684:17085] starting screenresolution argv=screenresolution get 16:30:25 INFO - 2016-09-04 16:30:25.364 screenresolution[1684:17085] Display 0: 1600x1200x32@60 16:30:25 INFO - 2016-09-04 16:30:25.370 screenresolution[1685:17088] starting screenresolution argv=screenresolution list 16:30:25 INFO - Available Modes on Display 0 16:30:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:30:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:30:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:30:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:30:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:30:25 INFO - Intel Iris: 16:30:25 INFO - Chipset Model: Intel Iris 16:30:25 INFO - Type: GPU 16:30:25 INFO - Bus: Built-In 16:30:25 INFO - VRAM (Dynamic, Max): 1536 MB 16:30:25 INFO - Vendor: Intel (0x8086) 16:30:25 INFO - Device ID: 0x0a2e 16:30:25 INFO - Revision ID: 0x0009 16:30:25 INFO - Displays: 16:30:25 INFO - Display: 16:30:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:30:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:30:25 INFO - Display Serial Number: 1600x1200 60 16:30:25 INFO - Main Display: Yes 16:30:25 INFO - Mirror: Off 16:30:25 INFO - Online: Yes 16:30:25 INFO - Rotation: Supported 16:30:25 INFO - Return code: 0 16:30:25 INFO - Running post-action listener: _resource_record_post_action 16:30:25 INFO - [mozharness: 2016-09-04 23:30:25.604641Z] Finished run-tests step (success) 16:30:25 INFO - Running post-run listener: _resource_record_post_run 16:30:25 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31894528; Write bytes: 706500608; Read time: 197; Write time: 1987 16:30:25 INFO - TinderboxPrint: CPU usage
53.8% 16:30:25 INFO - TinderboxPrint: I/O read bytes / time
31,894,528 / 197 16:30:25 INFO - TinderboxPrint: I/O write bytes / time
706,500,608 / 1,987 16:30:25 INFO - TinderboxPrint: CPU idle
2,242.2 (46.2%) 16:30:25 INFO - TinderboxPrint: CPU system
976.3 (20.1%) 16:30:25 INFO - TinderboxPrint: CPU user
1,631.3 (33.6%) 16:30:25 INFO - TinderboxPrint: Swap in / out
433,143,808 / 0 16:30:25 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398299648; Write bytes: 392837120; Read time: 29373; Write time: 832 16:30:25 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29838336; Write bytes: 296886272; Read time: 178; Write time: 1111 16:30:26 INFO - Running post-run listener: _upload_blobber_files 16:30:26 INFO - Blob upload gear active. 16:30:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:30:26 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 16:30:26 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:30:26 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:30:26 INFO - (blobuploader) - INFO - Open directory for files ... 16:30:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:30:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:30:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:27 INFO - (blobuploader) - INFO - Done attempting. 16:30:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:30:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:30:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:29 INFO - (blobuploader) - INFO - Done attempting. 16:30:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:30:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:32 INFO - (blobuploader) - INFO - Done attempting. 16:30:32 INFO - (blobuploader) - INFO - Iteration through files over. 16:30:32 INFO - Return code: 0 16:30:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:30:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:30:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/89ac89284dc993a5b97fafe07df6b0e06e7c9f5ea6a905eaaf1ad7bbabf4c826f90aa15cf616be399a24575db827c146c5e0e94abdecd0655ea5d2150f47d80d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/63680548eb37b4488a790a2db4b87f53f0ac5677ec3c702b9ebfc385a7b3051eb6bf9b28c71042948afaab8e80877561056fca989cf37c8bc9ea0be9d96d65ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1d80d3d7529c61d63a2b9b94855afb56cb4cec5728a0204f1ef7bd3661534c745ec543183a293b8425d9d43957ef5d2e4149ecc8b1b1c9e2a2bb5a06b2a0322"} 16:30:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:30:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:30:32 INFO - Contents: 16:30:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/89ac89284dc993a5b97fafe07df6b0e06e7c9f5ea6a905eaaf1ad7bbabf4c826f90aa15cf616be399a24575db827c146c5e0e94abdecd0655ea5d2150f47d80d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/63680548eb37b4488a790a2db4b87f53f0ac5677ec3c702b9ebfc385a7b3051eb6bf9b28c71042948afaab8e80877561056fca989cf37c8bc9ea0be9d96d65ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1d80d3d7529c61d63a2b9b94855afb56cb4cec5728a0204f1ef7bd3661534c745ec543183a293b8425d9d43957ef5d2e4149ecc8b1b1c9e2a2bb5a06b2a0322"} 16:30:32 INFO - Running post-run listener: copy_logs_to_upload_dir 16:30:32 INFO - Copying logs to upload dir... 16:30:32 INFO - mkdir: /builds/slave/test/build/upload/logs 16:30:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.759452 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-04 16:30:32.493904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-04 16:30:32.497302) ========= 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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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/Autoland/sha512/89ac89284dc993a5b97fafe07df6b0e06e7c9f5ea6a905eaaf1ad7bbabf4c826f90aa15cf616be399a24575db827c146c5e0e94abdecd0655ea5d2150f47d80d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/63680548eb37b4488a790a2db4b87f53f0ac5677ec3c702b9ebfc385a7b3051eb6bf9b28c71042948afaab8e80877561056fca989cf37c8bc9ea0be9d96d65ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1d80d3d7529c61d63a2b9b94855afb56cb4cec5728a0204f1ef7bd3661534c745ec543183a293b8425d9d43957ef5d2e4149ecc8b1b1c9e2a2bb5a06b2a0322"} build_url:https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010751 build_url: 'https://queue.taskcluster.net/v1/task/ITr7mQQFRfG6QhkHxerXJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/89ac89284dc993a5b97fafe07df6b0e06e7c9f5ea6a905eaaf1ad7bbabf4c826f90aa15cf616be399a24575db827c146c5e0e94abdecd0655ea5d2150f47d80d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/63680548eb37b4488a790a2db4b87f53f0ac5677ec3c702b9ebfc385a7b3051eb6bf9b28c71042948afaab8e80877561056fca989cf37c8bc9ea0be9d96d65ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1d80d3d7529c61d63a2b9b94855afb56cb4cec5728a0204f1ef7bd3661534c745ec543183a293b8425d9d43957ef5d2e4149ecc8b1b1c9e2a2bb5a06b2a0322"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-04 16:30:32.530599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 16:30:32.530977) ========= 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.OSzeEdQ2yn/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.MkHbhjDYd4/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005151 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 16:30:32.579805) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-04 16:30:32.580147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-04 16:30:32.580515) ========= ========= Total master_lag: 0.18 =========