builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0173 starttime: 1473227167.35 results: success (0) buildid: 20160906185516 builduid: f5f255877a8443dbbc841936a6d98819 revision: a6b6a93eb41a05e310a11f0172f01ba9b21d3eac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:07.355147) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:07.355658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:07.356001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:07.686731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:07.687051) ========= 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.FMTy9nCgId/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.qotRqiA3UY/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-06 22:46:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2016-09-06 22:46:08 (14.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.542383 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:08.259662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:08.260001) ========= 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.FMTy9nCgId/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.qotRqiA3UY/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.027661 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:08.308477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-06 22:46:08.308852) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a6b6a93eb41a05e310a11f0172f01ba9b21d3eac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a6b6a93eb41a05e310a11f0172f01ba9b21d3eac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FMTy9nCgId/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.qotRqiA3UY/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-06 22:46:08,384 truncating revision to first 12 chars 2016-09-06 22:46:08,384 Setting DEBUG logging. 2016-09-06 22:46:08,384 attempt 1/10 2016-09-06 22:46:08,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a6b6a93eb41a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-06 22:46:10,413 unpacking tar archive at: fx-team-a6b6a93eb41a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.296961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-06 22:46:10.627882) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:10.628206) ========= script_repo_revision: a6b6a93eb41a05e310a11f0172f01ba9b21d3eac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:10.629168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:10.629472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 22:46:10.652072) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-06 22:46:10.652679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FMTy9nCgId/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.qotRqiA3UY/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46:10 INFO - MultiFileLogger online at 20160906 22:46:10 in /builds/slave/test 22:46:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:46:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:46:10 INFO - {'append_to_log': False, 22:46:10 INFO - 'base_work_dir': '/builds/slave/test', 22:46:10 INFO - 'blob_upload_branch': 'Fx-Team', 22:46:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:46:10 INFO - 'branch': 'Fx-Team', 22:46:10 INFO - 'buildbot_json_path': 'buildprops.json', 22:46:10 INFO - 'config_files': ('talos/mac_config.py',), 22:46:10 INFO - 'default_actions': ('clobber', 22:46:10 INFO - 'read-buildbot-config', 22:46:10 INFO - 'download-and-extract', 22:46:10 INFO - 'populate-webroot', 22:46:10 INFO - 'create-virtualenv', 22:46:10 INFO - 'install', 22:46:10 INFO - 'run-tests'), 22:46:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:46:10 INFO - 'download_minidump_stackwalk': True, 22:46:10 INFO - 'download_symbols': 'ondemand', 22:46:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:46:10 INFO - 'tooltool.py': '/tools/tooltool.py', 22:46:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:46:10 INFO - '/tools/misc-python/virtualenv.py')}, 22:46:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:46:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:46:10 INFO - 'installer_path': 'installer.exe', 22:46:10 INFO - 'log_level': 'info', 22:46:10 INFO - 'log_name': 'talos', 22:46:10 INFO - 'log_to_console': True, 22:46:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:46:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:46:10 INFO - 'opt_config_files': (), 22:46:10 INFO - 'pip_index': False, 22:46:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:46:10 INFO - 'cmd': ('bash', 22:46:10 INFO - '-c', 22:46:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:46:10 INFO - 'enabled': True, 22:46:10 INFO - 'halt_on_failure': False, 22:46:10 INFO - 'name': 'check_screen_resolution'},), 22:46:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:46:10 INFO - 'cmd': ('bash', 22:46:10 INFO - '-c', 22:46:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:46:10 INFO - 'enabled': True, 22:46:10 INFO - 'halt_on_failure': False, 22:46:10 INFO - 'name': 'check_screen_resolution'},), 22:46:10 INFO - 'run_cmd_checks_enabled': True, 22:46:10 INFO - 'sps_profile': False, 22:46:10 INFO - 'sps_profile_interval': 0, 22:46:10 INFO - 'suite': 'dromaeojs', 22:46:10 INFO - 'system_bits': '32', 22:46:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:46:10 INFO - 'title': 't-yosemite-r7-0173', 22:46:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:46:10 INFO - 'use_talos_json': True, 22:46:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:46:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:46:10 INFO - 'work_dir': 'build'} 22:46:10 INFO - [mozharness: 2016-09-07 05:46:10.849903Z] Running clobber step. 22:46:10 INFO - Running pre-action listener: _resource_record_pre_action 22:46:10 INFO - Running main action method: clobber 22:46:10 INFO - rmtree: /builds/slave/test/build 22:46:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:46:13 INFO - Running post-action listener: _resource_record_post_action 22:46:13 INFO - [mozharness: 2016-09-07 05:46:13.084629Z] Finished clobber step (success) 22:46:13 INFO - [mozharness: 2016-09-07 05:46:13.084782Z] Running read-buildbot-config step. 22:46:13 INFO - Running pre-action listener: _resource_record_pre_action 22:46:13 INFO - Running main action method: read_buildbot_config 22:46:13 INFO - Using buildbot properties: 22:46:13 INFO - { 22:46:13 INFO - "project": "", 22:46:13 INFO - "product": "firefox", 22:46:13 INFO - "script_repo_revision": "production", 22:46:13 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:46:13 INFO - "repository": "", 22:46:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:46:13 INFO - "buildid": "20160906185516", 22:46:13 INFO - "pgo_build": "False", 22:46:13 INFO - "basedir": "/builds/slave/test", 22:46:13 INFO - "buildnumber": 132, 22:46:13 INFO - "slavename": "t-yosemite-r7-0173", 22:46:13 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 22:46:13 INFO - "platform": "yosemite_r7", 22:46:13 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:46:13 INFO - "branch": "fx-team", 22:46:13 INFO - "repo_path": "integration/fx-team", 22:46:13 INFO - "revision": "a6b6a93eb41a05e310a11f0172f01ba9b21d3eac", 22:46:13 INFO - "stage_platform": "macosx64", 22:46:13 INFO - "builduid": "f5f255877a8443dbbc841936a6d98819", 22:46:13 INFO - "slavebuilddir": "test" 22:46:13 INFO - } 22:46:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 22:46:13 INFO - Running post-action listener: _resource_record_post_action 22:46:13 INFO - [mozharness: 2016-09-07 05:46:13.088113Z] Finished read-buildbot-config step (success) 22:46:13 INFO - [mozharness: 2016-09-07 05:46:13.088231Z] Running download-and-extract step. 22:46:13 INFO - Running pre-action listener: _resource_record_pre_action 22:46:13 INFO - Running main action method: download_and_extract 22:46:13 INFO - mkdir: /builds/slave/test/build/tests 22:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:13 INFO - trying https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 22:46:13 INFO - Downloading https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/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 22:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/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 22:46:14 INFO - Downloaded 1199 bytes. 22:46:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 22:46:14 INFO - Using the following test package requirements: 22:46:14 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 22:46:14 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:46:14 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 22:46:14 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:46:14 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 22:46:14 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:46:14 INFO - u'jsshell-mac.zip'], 22:46:14 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:46:14 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 22:46:14 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 22:46:14 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:46:14 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 22:46:14 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:46:14 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 22:46:14 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:46:14 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 22:46:14 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:46:14 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 22:46:14 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:46:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 22:46:15 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 22:46:21 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 22:46:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 22:46:22 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 22:46:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 22:46:29 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 22:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:30 INFO - trying https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:46:30 INFO - Downloading https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 22:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/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 22:46:33 INFO - Downloaded 111495597 bytes. 22:46:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:46:33 INFO - mkdir: /builds/slave/test/properties 22:46:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:46:33 INFO - Writing to file /builds/slave/test/properties/build_url 22:46:33 INFO - Contents: 22:46:33 INFO - build_url:https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:46:34 INFO - Running post-action listener: _resource_record_post_action 22:46:34 INFO - Running post-action listener: set_extra_try_arguments 22:46:34 INFO - [mozharness: 2016-09-07 05:46:34.109019Z] Finished download-and-extract step (success) 22:46:34 INFO - [mozharness: 2016-09-07 05:46:34.109171Z] Running populate-webroot step. 22:46:34 INFO - Running pre-action listener: _resource_record_pre_action 22:46:34 INFO - Running main action method: populate_webroot 22:46:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:46:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:46:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:46:34 INFO - '--tppagecycles', 22:46:34 INFO - '7'], 22:46:34 INFO - 'tests': ['tsvgm']}}, 22:46:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:46:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:46:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:46:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:46:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:34 INFO - 'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:34 INFO - 'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['damp', 'tps']}, 22:46:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:34 INFO - 'tests': ['damp', 'tps']}, 22:46:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['dromaeo_dom']}, 22:46:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:46:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['basic_compositor_video']}, 22:46:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:46:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['a11yr', 22:46:34 INFO - 'ts_paint', 22:46:34 INFO - 'tpaint', 22:46:34 INFO - 'sessionrestore', 22:46:34 INFO - 'sessionrestore_no_auto_restore', 22:46:34 INFO - 'tabpaint']}, 22:46:34 INFO - 'other-e10s': {'tests': ['a11yr', 22:46:34 INFO - 'ts_paint', 22:46:34 INFO - 'tpaint', 22:46:34 INFO - 'sessionrestore', 22:46:34 INFO - 'sessionrestore_no_auto_restore', 22:46:34 INFO - 'tabpaint']}, 22:46:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:46:34 INFO - 'ts_paint', 22:46:34 INFO - 'tpaint', 22:46:34 INFO - 'sessionrestore', 22:46:34 INFO - 'sessionrestore_no_auto_restore', 22:46:34 INFO - 'tabpaint']}, 22:46:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:46:34 INFO - 'ts_paint', 22:46:34 INFO - 'tpaint', 22:46:34 INFO - 'sessionrestore', 22:46:34 INFO - 'sessionrestore_no_auto_restore', 22:46:34 INFO - 'tabpaint']}, 22:46:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['a11yr', 22:46:34 INFO - 'ts_paint', 22:46:34 INFO - 'tpaint', 22:46:34 INFO - 'sessionrestore', 22:46:34 INFO - 'sessionrestore_no_auto_restore', 22:46:34 INFO - 'tabpaint']}, 22:46:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['a11yr', 22:46:34 INFO - 'ts_paint', 22:46:34 INFO - 'tpaint', 22:46:34 INFO - 'sessionrestore', 22:46:34 INFO - 'sessionrestore_no_auto_restore', 22:46:34 INFO - 'tabpaint']}, 22:46:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['tsvgx', 22:46:34 INFO - 'tsvgr_opacity', 22:46:34 INFO - 'tart', 22:46:34 INFO - 'tscrollx', 22:46:34 INFO - 'cart']}, 22:46:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:46:34 INFO - 'tsvgr_opacity', 22:46:34 INFO - 'tart', 22:46:34 INFO - 'tscrollx', 22:46:34 INFO - 'cart']}, 22:46:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:34 INFO - 'talos_options': ['--disable-e10s'], 22:46:34 INFO - 'tests': ['tp5o']}, 22:46:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:34 INFO - 'tests': ['tp5o']}, 22:46:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:34 INFO - 'talos_options': ['--disable-e10s', 22:46:34 INFO - '--xperf_path', 22:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:34 INFO - 'tests': ['tp5n']}, 22:46:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:34 INFO - 'talos_options': ['--xperf_path', 22:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:34 INFO - 'tests': ['tp5n']}}, 22:46:34 INFO - 'talos.zip': {'path': '', 22:46:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:46:34 INFO - Running post-action listener: _resource_record_post_action 22:46:34 INFO - [mozharness: 2016-09-07 05:46:34.128558Z] Finished populate-webroot step (success) 22:46:34 INFO - [mozharness: 2016-09-07 05:46:34.128700Z] Running create-virtualenv step. 22:46:34 INFO - Running pre-action listener: _resource_record_pre_action 22:46:34 INFO - Running main action method: create_virtualenv 22:46:34 INFO - Creating virtualenv /builds/slave/test/build/venv 22:46:34 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 22:46:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:46:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:46:34 INFO - Using real prefix '/tools/python27' 22:46:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:46:34 INFO - Installing distribute.............................................................................................................................................................................................done. 22:46:37 INFO - Installing pip.................done. 22:46:37 INFO - Return code: 0 22:46:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:46:37 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')]} 22:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:37 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')]} 22:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:37 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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46:37 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 22:46:37 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 22:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:37 INFO - 'HOME': '/Users/cltbld', 22:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:37 INFO - 'LOGNAME': 'cltbld', 22:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:37 INFO - 'MOZ_NO_REMOTE': '1', 22:46:37 INFO - 'NO_EM_RESTART': '1', 22:46:37 INFO - 'PAGER': '/bin/cat', 22:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:37 INFO - 'PWD': '/builds/slave/test', 22:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:37 INFO - 'SHELL': '/bin/bash', 22:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:46:37 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:37 INFO - 'USER': 'cltbld', 22:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:37 INFO - 'XPC_FLAGS': '0x0', 22:46:37 INFO - 'XPC_SERVICE_NAME': '0', 22:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:38 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 22:46:38 INFO - Cleaning up... 22:46:38 INFO - Return code: 0 22:46:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:38 INFO - 'HOME': '/Users/cltbld', 22:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:38 INFO - 'LOGNAME': 'cltbld', 22:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:38 INFO - 'MOZ_NO_REMOTE': '1', 22:46:38 INFO - 'NO_EM_RESTART': '1', 22:46:38 INFO - 'PAGER': '/bin/cat', 22:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:38 INFO - 'PWD': '/builds/slave/test', 22:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:38 INFO - 'SHELL': '/bin/bash', 22:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:46:38 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:38 INFO - 'USER': 'cltbld', 22:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:38 INFO - 'XPC_FLAGS': '0x0', 22:46:38 INFO - 'XPC_SERVICE_NAME': '0', 22:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:38 INFO - Downloading/unpacking psutil>=3.1.1 22:46:38 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 22:46:38 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 22:46:38 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 22:46:38 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 22:46:38 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 22:46:38 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 22:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:46:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:41 INFO - Installing collected packages: psutil 22:46:41 INFO - Running setup.py install for psutil 22:46:41 INFO - building 'psutil._psutil_osx' extension 22:46:41 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 22:46:42 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 22:46:42 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 22:46:42 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 22:46:42 INFO - building 'psutil._psutil_posix' extension 22:46:42 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 22:46:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:46:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:46:42 INFO - ^ 22:46:42 INFO - 1 warning generated. 22:46:42 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 22:46:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:42 INFO - Successfully installed psutil 22:46:42 INFO - Cleaning up... 22:46:42 INFO - Return code: 0 22:46:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:42 INFO - 'HOME': '/Users/cltbld', 22:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:42 INFO - 'LOGNAME': 'cltbld', 22:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:42 INFO - 'MOZ_NO_REMOTE': '1', 22:46:42 INFO - 'NO_EM_RESTART': '1', 22:46:42 INFO - 'PAGER': '/bin/cat', 22:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:42 INFO - 'PWD': '/builds/slave/test', 22:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:42 INFO - 'SHELL': '/bin/bash', 22:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:46:42 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:42 INFO - 'USER': 'cltbld', 22:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:42 INFO - 'XPC_FLAGS': '0x0', 22:46:42 INFO - 'XPC_SERVICE_NAME': '0', 22:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:46:45 INFO - Installing collected packages: mozsystemmonitor 22:46:45 INFO - Running setup.py install for mozsystemmonitor 22:46:45 INFO - Successfully installed mozsystemmonitor 22:46:45 INFO - Cleaning up... 22:46:45 INFO - Return code: 0 22:46:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46: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')]} 22:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46: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', '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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:46: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 jsonschema==2.5.1 22:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:45 INFO - 'HOME': '/Users/cltbld', 22:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:45 INFO - 'LOGNAME': 'cltbld', 22:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:45 INFO - 'MOZ_NO_REMOTE': '1', 22:46:45 INFO - 'NO_EM_RESTART': '1', 22:46:45 INFO - 'PAGER': '/bin/cat', 22:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:45 INFO - 'PWD': '/builds/slave/test', 22:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:45 INFO - 'SHELL': '/bin/bash', 22:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:46:45 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:45 INFO - 'USER': 'cltbld', 22:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:45 INFO - 'XPC_FLAGS': '0x0', 22:46:45 INFO - 'XPC_SERVICE_NAME': '0', 22:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:45 INFO - Downloading/unpacking jsonschema==2.5.1 22:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:46:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:46:48 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 22:46:48 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 22:46:48 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 22:46:48 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 22:46:48 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 22:46:48 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 22:46:48 INFO - Downloading functools32-3.2.3-2.tar.gz 22:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:46:49 INFO - warning: no files found matching '*.txt' 22:46:49 INFO - no previously-included directories found matching 'build' 22:46:49 INFO - no previously-included directories found matching 'dist' 22:46:49 INFO - no previously-included directories found matching '.git*' 22:46:49 INFO - Installing collected packages: jsonschema, functools32 22:46:49 INFO - Running setup.py install for functools32 22:46:49 INFO - warning: no files found matching '*.txt' 22:46:49 INFO - no previously-included directories found matching 'build' 22:46:49 INFO - no previously-included directories found matching 'dist' 22:46:49 INFO - no previously-included directories found matching '.git*' 22:46:49 INFO - Successfully installed jsonschema functools32 22:46:49 INFO - Cleaning up... 22:46:49 INFO - Return code: 0 22:46:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:46:49 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')]} 22:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:49 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')]} 22:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:49 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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46:49 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 22:46:49 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 22:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:49 INFO - 'HOME': '/Users/cltbld', 22:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:49 INFO - 'LOGNAME': 'cltbld', 22:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:49 INFO - 'MOZ_NO_REMOTE': '1', 22:46:49 INFO - 'NO_EM_RESTART': '1', 22:46:49 INFO - 'PAGER': '/bin/cat', 22:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:49 INFO - 'PWD': '/builds/slave/test', 22:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:49 INFO - 'SHELL': '/bin/bash', 22:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:46:49 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:49 INFO - 'USER': 'cltbld', 22:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:49 INFO - 'XPC_FLAGS': '0x0', 22:46:49 INFO - 'XPC_SERVICE_NAME': '0', 22:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:46:49 INFO - Cleaning up... 22:46:49 INFO - Return code: 0 22:46:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:46:49 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')]} 22:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:49 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')]} 22:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:49 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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46:49 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 22:46:49 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 22:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:49 INFO - 'HOME': '/Users/cltbld', 22:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:49 INFO - 'LOGNAME': 'cltbld', 22:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:49 INFO - 'MOZ_NO_REMOTE': '1', 22:46:49 INFO - 'NO_EM_RESTART': '1', 22:46:49 INFO - 'PAGER': '/bin/cat', 22:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:49 INFO - 'PWD': '/builds/slave/test', 22:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:49 INFO - 'SHELL': '/bin/bash', 22:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:46:49 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:49 INFO - 'USER': 'cltbld', 22:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:49 INFO - 'XPC_FLAGS': '0x0', 22:46:49 INFO - 'XPC_SERVICE_NAME': '0', 22:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:49 INFO - Downloading/unpacking blobuploader==1.2.4 22:46:49 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 22:46:49 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 22:46:49 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 22:46:49 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 22:46:49 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 22:46:49 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 22:46:52 INFO - Downloading blobuploader-1.2.4.tar.gz 22:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:46:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:46:52 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 22:46:52 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 22:46:52 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 22:46:52 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 22:46:52 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 22:46:52 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 22:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:46:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:46:53 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 22:46:53 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 22:46:53 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 22:46:53 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 22:46:53 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 22:46:53 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 22:46:53 INFO - Downloading docopt-0.6.1.tar.gz 22:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:46:53 INFO - Installing collected packages: blobuploader, requests, docopt 22:46:53 INFO - Running setup.py install for blobuploader 22:46:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:46:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:46:53 INFO - Running setup.py install for requests 22:46:54 INFO - Running setup.py install for docopt 22:46:54 INFO - Successfully installed blobuploader requests docopt 22:46:54 INFO - Cleaning up... 22:46:54 INFO - Return code: 0 22:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46:54 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')]} 22:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:54 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')]} 22:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:54 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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46:54 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 22:46:54 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 22:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:54 INFO - 'HOME': '/Users/cltbld', 22:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:54 INFO - 'LOGNAME': 'cltbld', 22:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:54 INFO - 'MOZ_NO_REMOTE': '1', 22:46:54 INFO - 'NO_EM_RESTART': '1', 22:46:54 INFO - 'PAGER': '/bin/cat', 22:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:54 INFO - 'PWD': '/builds/slave/test', 22:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:54 INFO - 'SHELL': '/bin/bash', 22:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:46:54 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:54 INFO - 'USER': 'cltbld', 22:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:54 INFO - 'XPC_FLAGS': '0x0', 22:46:54 INFO - 'XPC_SERVICE_NAME': '0', 22:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:46:54 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-y6be6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:46:54 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Tw5ckf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:46:54 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-GMLVIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-q0pWbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-OCbomX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-w8WELq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-84cb7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-1UdiuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-_DbeQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-H3iQoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-2OviYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:46:55 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-p2BnfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:46:56 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-PQwlAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:46:56 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-InuCYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:56 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-iQh9Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:46:56 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-3xmqF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:46:56 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-_gZM_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:46:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:46:56 INFO - Running setup.py install for manifestparser 22:46:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:46:56 INFO - Running setup.py install for mozcrash 22:46:56 INFO - Running setup.py install for mozdebug 22:46:56 INFO - Running setup.py install for mozdevice 22:46:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:46:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:46:57 INFO - Running setup.py install for mozfile 22:46:57 INFO - Running setup.py install for mozhttpd 22:46:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:46:57 INFO - Running setup.py install for mozinfo 22:46:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:46:57 INFO - Running setup.py install for mozInstall 22:46:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:46:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:46:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:46:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:46:57 INFO - Running setup.py install for mozleak 22:46:57 INFO - Running setup.py install for mozlog 22:46:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:46:58 INFO - Running setup.py install for moznetwork 22:46:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:46:58 INFO - Running setup.py install for mozprocess 22:46:58 INFO - Running setup.py install for mozprofile 22:46:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:46:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:46:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:46:58 INFO - Running setup.py install for mozrunner 22:46:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:46:58 INFO - Running setup.py install for mozscreenshot 22:46:58 INFO - Running setup.py install for moztest 22:46:59 INFO - Running setup.py install for mozversion 22:46:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:46:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:46:59 INFO - Cleaning up... 22:46:59 INFO - Return code: 0 22:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46:59 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')]} 22:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:59 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')]} 22:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:59 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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:46:59 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 22:46:59 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 22:46:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:46:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:46:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:46:59 INFO - 'HOME': '/Users/cltbld', 22:46:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:46:59 INFO - 'LOGNAME': 'cltbld', 22:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:59 INFO - 'MOZ_NO_REMOTE': '1', 22:46:59 INFO - 'NO_EM_RESTART': '1', 22:46:59 INFO - 'PAGER': '/bin/cat', 22:46:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:59 INFO - 'PWD': '/builds/slave/test', 22:46:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:46:59 INFO - 'SHELL': '/bin/bash', 22:46:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:46:59 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:46:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:46:59 INFO - 'USER': 'cltbld', 22:46:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:46:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:59 INFO - 'XPC_FLAGS': '0x0', 22:46:59 INFO - 'XPC_SERVICE_NAME': '0', 22:46:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:46:59 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-7Xcc7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:46:59 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)) 22:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:46:59 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-CTMphm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:46:59 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)) 22:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:46:59 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-kV8EVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:46:59 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)) 22:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:46:59 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-X1Vi6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:46:59 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)) 22:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:46:59 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-iBABSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:46:59 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)) 22:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:46:59 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-YiTjEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-gxHuiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-wn1oJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-PpTaRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-cGCWrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-TrQ2V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-MO_25a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-DvkPiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-7TaAMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:47:00 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)) 22:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:00 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-yKUOEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:01 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)) 22:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:47:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-t8ErQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:47:01 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)) 22:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:47:01 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-vEs8uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:47:01 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)) 22:47:01 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)) 22:47:01 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)) 22:47:01 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)) 22:47:01 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)) 22:47:01 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)) 22:47:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:47: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 22:47: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 22:47: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 22:47: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 22:47: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 22:47: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 22:47:03 INFO - Downloading blessings-1.6.tar.gz 22:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:47:03 INFO - Installing collected packages: blessings 22:47:03 INFO - Running setup.py install for blessings 22:47:04 INFO - Successfully installed blessings 22:47:04 INFO - Cleaning up... 22:47:04 INFO - Return code: 0 22:47:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:47:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:47:04 INFO - Reading from file tmpfile_stdout 22:47:04 INFO - Current package versions: 22:47:04 INFO - blessings == 1.6 22:47:04 INFO - blobuploader == 1.2.4 22:47:04 INFO - docopt == 0.6.1 22:47:04 INFO - functools32 == 3.2.3-2 22:47:04 INFO - jsonschema == 2.5.1 22:47:04 INFO - manifestparser == 1.1 22:47:04 INFO - mozInstall == 1.12 22:47:04 INFO - mozcrash == 0.17 22:47:04 INFO - mozdebug == 0.1 22:47:04 INFO - mozdevice == 0.48 22:47:04 INFO - mozfile == 1.2 22:47:04 INFO - mozhttpd == 0.7 22:47:04 INFO - mozinfo == 0.9 22:47:04 INFO - mozleak == 0.1 22:47:04 INFO - mozlog == 3.3 22:47:04 INFO - moznetwork == 0.27 22:47:04 INFO - mozprocess == 0.23 22:47:04 INFO - mozprofile == 0.28 22:47:04 INFO - mozrunner == 6.12 22:47:04 INFO - mozscreenshot == 0.1 22:47:04 INFO - mozsystemmonitor == 0.3 22:47:04 INFO - moztest == 0.7 22:47:04 INFO - mozversion == 1.4 22:47:04 INFO - psutil == 3.1.1 22:47:04 INFO - requests == 1.2.3 22:47:04 INFO - wsgiref == 0.1.2 22:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:47:04 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')]} 22:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:04 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')]} 22:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:04 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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:47:04 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 22:47:04 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 22:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:47:04 INFO - 'HOME': '/Users/cltbld', 22:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:47:04 INFO - 'LOGNAME': 'cltbld', 22:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:04 INFO - 'MOZ_NO_REMOTE': '1', 22:47:04 INFO - 'NO_EM_RESTART': '1', 22:47:04 INFO - 'PAGER': '/bin/cat', 22:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:04 INFO - 'PWD': '/builds/slave/test', 22:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:47:04 INFO - 'SHELL': '/bin/bash', 22:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:47:04 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:47:04 INFO - 'USER': 'cltbld', 22:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:04 INFO - 'XPC_FLAGS': '0x0', 22:47:04 INFO - 'XPC_SERVICE_NAME': '0', 22:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 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)) 22:47:04 INFO - Cleaning up... 22:47:04 INFO - Return code: 0 22:47:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:47:04 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')]} 22:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:04 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')]} 22:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:04 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 0x10a366a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fa3c6b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, '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.FMTy9nCgId/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.qotRqiA3UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 22:47:04 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 22:47:04 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 22:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:47:04 INFO - 'HOME': '/Users/cltbld', 22:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:47:04 INFO - 'LOGNAME': 'cltbld', 22:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:04 INFO - 'MOZ_NO_REMOTE': '1', 22:47:04 INFO - 'NO_EM_RESTART': '1', 22:47:04 INFO - 'PAGER': '/bin/cat', 22:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:04 INFO - 'PWD': '/builds/slave/test', 22:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:47:04 INFO - 'SHELL': '/bin/bash', 22:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:47:04 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:47:04 INFO - 'USER': 'cltbld', 22:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:04 INFO - 'XPC_FLAGS': '0x0', 22:47:04 INFO - 'XPC_SERVICE_NAME': '0', 22:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:47:04 INFO - Cleaning up... 22:47:04 INFO - Return code: 0 22:47:04 INFO - Running post-action listener: _resource_record_post_action 22:47:04 INFO - Running post-action listener: _start_resource_monitoring 22:47:04 INFO - Starting resource monitoring. 22:47:04 INFO - [mozharness: 2016-09-07 05:47:04.981110Z] Finished create-virtualenv step (success) 22:47:04 INFO - [mozharness: 2016-09-07 05:47:04.982174Z] Running install step. 22:47:04 INFO - Running pre-action listener: _resource_record_pre_action 22:47:04 INFO - Running main action method: install 22:47:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:47:05 INFO - Reading from file tmpfile_stdout 22:47:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:47:05 INFO - Reading from file tmpfile_stdout 22:47:05 INFO - Output received: 22:47:05 INFO - Usage: mozinstall [options] installer 22:47:05 INFO - Options: 22:47:05 INFO - -h, --help show this help message and exit 22:47:05 INFO - -d DEST, --destination=DEST 22:47:05 INFO - Directory to install application into. [default: 22:47:05 INFO - "/builds/slave/test"] 22:47:05 INFO - --app=APP Application being installed. [default: firefox] 22:47:05 INFO - mkdir: /builds/slave/test/build/application 22:47:05 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'] 22:47:05 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 22:47:39 INFO - Reading from file tmpfile_stdout 22:47:39 INFO - Output received: 22:47:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:47:39 INFO - Running post-action listener: _resource_record_post_action 22:47:39 INFO - [mozharness: 2016-09-07 05:47:39.500384Z] Finished install step (success) 22:47:39 INFO - [mozharness: 2016-09-07 05:47:39.500526Z] Running run-tests step. 22:47:39 INFO - Running pre-action listener: _resource_record_pre_action 22:47:39 INFO - Running main action method: run_tests 22:47:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:47:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:47:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:47:39 INFO - 2016-09-06 22:47:39.515 screenresolution[1646:9833] starting screenresolution argv=screenresolution get 22:47:39 INFO - 2016-09-06 22:47:39.517 screenresolution[1646:9833] Display 0: 1600x1200x32@60 22:47:39 INFO - 2016-09-06 22:47:39.524 screenresolution[1647:9835] starting screenresolution argv=screenresolution list 22:47:39 INFO - Available Modes on Display 0 22:47:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:47:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:47:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:47:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:47:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:47:39 INFO - Intel Iris: 22:47:39 INFO - Chipset Model: Intel Iris 22:47:39 INFO - Type: GPU 22:47:39 INFO - Bus: Built-In 22:47:39 INFO - VRAM (Dynamic, Max): 1536 MB 22:47:39 INFO - Vendor: Intel (0x8086) 22:47:39 INFO - Device ID: 0x0a2e 22:47:39 INFO - Revision ID: 0x0009 22:47:39 INFO - Displays: 22:47:39 INFO - Display: 22:47:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:47:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:47:39 INFO - Display Serial Number: 1600x1200 60 22:47:39 INFO - Main Display: Yes 22:47:39 INFO - Mirror: Off 22:47:39 INFO - Online: Yes 22:47:39 INFO - Rotation: Supported 22:47:39 INFO - Return code: 0 22:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:47:39 INFO - Python 2.7.3 22:47:39 INFO - Return code: 0 22:47:39 INFO - grabbing minidump binary from tooltool 22:47:39 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')]} 22:47:39 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 0x10a2cad30>, '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 0x10a02fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:47:39 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 22:47:39 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 22:47:39 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 22:47:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:47:39 INFO - Return code: 0 22:47:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:47:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:47:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:47:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:47:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 22:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0173 --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 22:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FMTy9nCgId/Render', 22:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:47:39 INFO - 'HOME': '/Users/cltbld', 22:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:47:39 INFO - 'LOGNAME': 'cltbld', 22:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:39 INFO - 'MOZ_NO_REMOTE': '1', 22:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:47:39 INFO - 'NO_EM_RESTART': '1', 22:47:39 INFO - 'PAGER': '/bin/cat', 22:47:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:39 INFO - 'PWD': '/builds/slave/test', 22:47:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:47:39 INFO - 'SHELL': '/bin/bash', 22:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qotRqiA3UY/Listeners', 22:47:39 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 22:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:47:39 INFO - 'USER': 'cltbld', 22:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:39 INFO - 'XPC_FLAGS': '0x0', 22:47:39 INFO - 'XPC_SERVICE_NAME': '0', 22:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:47:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 22:47:40 INFO - mozversion application_buildid: 20160906185516 22:47:40 INFO - mozversion application_changeset: a6b6a93eb41a05e310a11f0172f01ba9b21d3eac 22:47:40 INFO - mozversion application_display_name: Nightly 22:47:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:47:40 INFO - mozversion application_name: Firefox 22:47:40 INFO - mozversion application_remotingname: firefox 22:47:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:47:40 INFO - mozversion application_vendor: Mozilla 22:47:40 INFO - mozversion application_version: 51.0a1 22:47:40 INFO - mozversion platform_buildid: 20160906185516 22:47:40 INFO - mozversion platform_changeset: a6b6a93eb41a05e310a11f0172f01ba9b21d3eac 22:47:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:47:40 INFO - mozversion platform_version: 51.0a1 22:47:40 INFO - using testdate: 1473227260 22:47:40 INFO - actual date: 1473227260 22:47:40 INFO - starting webserver on 'localhost:49272' 22:47:40 INFO - SUITE-START | Running 2 tests 22:47:40 INFO - TEST-START | dromaeo_css 22:47:40 INFO - operating with platform_type : mac_ 22:47:40 INFO - Initialising browser for dromaeo_css test... 22:47:40 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpV8gTHU/profile http://localhost:49272/getInfo.html) 22:47:42 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 22:47:42 INFO - PROCESS | 1657 | colorDepth:24 22:47:42 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 22:47:42 INFO - PROCESS | 1657 | __metrics 22:47:42 INFO - PROCESS | 1657 | 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" 22:47:42 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:47:43 INFO - TEST-INFO | 1657: exit 0 22:47:43 INFO - Browser initialized. 22:47:43 INFO - Running cycle 1/1 for dromaeo_css test... 22:47:43 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpV8gTHU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:47:55 INFO - PROCESS | 1660 | RSS: Main: 232288256 22:47:55 INFO - PROCESS | 1660 | 22:48:47 INFO - PROCESS | 1660 | 1473227327306 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] 22:50:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 22:50:59 INFO - PROCESS | 1660 | RSS: Main: 367632384 22:50:59 INFO - PROCESS | 1660 | 22:54:02 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 22:54:03 INFO - PROCESS | 1660 | RSS: Main: 370196480 22:54:03 INFO - PROCESS | 1660 | 22:57:05 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 22:57:06 INFO - PROCESS | 1660 | RSS: Main: 336814080 22:57:06 INFO - PROCESS | 1660 | 23:00:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 23:00:09 INFO - PROCESS | 1660 | RSS: Main: 341778432 23:00:09 INFO - PROCESS | 1660 | 23:03:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 23:03:13 INFO - PROCESS | 1660 | RSS: Main: 337272832 23:03:13 INFO - PROCESS | 1660 | 23:06:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 23:06:17 INFO - PROCESS | 1660 | RSS: Main: 407420928 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - PROCESS | 1660 | __start_tp_report 23:06:17 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 23:06:17 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 23:06:17 INFO - PROCESS | 1660 | |i|pagename|runs| 23:06:17 INFO - PROCESS | 1660 | |0;dojo.html;2632.47350529894;3313.1717070732316;3347.364000839839;3373.004963535757;3412.9658703412974;5588.469095435938;5650.915236271459;5674.801381951633;5722.971385143073;5726.770929162829;5660.433956604337;5663.292088488939;5740.282464691924;5741.598088133832;5784.652920824743;5106.897862042757;5159.638825282232;5230.921536176941;5234.973825130869;5272.683638981654;5290.391604965421;5332.280142180814;5340.893182136355;5346.438623944488;5370.91943620846;5140.997505486432;5165.276861239429;5185.922211166836;5203.869903252411;5252.921206181911;4289.463817022872;5180.481951804827;5220.086484865172;5324.148136298212;5336.893262134774;5222.686638801646;5253.684778913239;5254.0805359062015;5262.526372626482;5323.334583177103;5610.158476228598;5784.739686714108;5785.595008349417;5788.623739456922;5795.913061304083;6023.337432882379;6121.483458747687;6123.008104567366;6127.387261273881;6233.2208473940755;6262.342454042306;6272.40412160844;6304.369563043705;6307.558470907038;6314.62112273265;4787.952120478821;5635.295588051494;5768.134779783066;5773.336066352381;5789.478946894799;6278.372162783685;6279.7488100476385;6344.397282258178;6345.4923606112325;6350.491960643138;6148.938510614926;6163.630182188993;6166.105914642351;6167.229096362955;6170.136180934673;6224.315325314212;6286.968565157145;6296.087067375205;6303.621782693053;6325.272593651789;6031.306399763996;6041.365656606081;6057.454829065406;6113.932424433873;6123.326434092246;6114.784027539347;6115.453310713017;6116.701002199504;6126.672418006053;6138.449706860586;4891.388576427947;4958.9504104959215;4975.4527002029745;4979.676321039121;4980.078685443133;4349.238883195429;4392.253316936129;4392.253316936129;4393.297072468454;4409.625181859514;5677.318721753416;5703.828885133453;5703.9732848086915;5705.172749951317;5706.629069110494;6095.105866018708;6146.0166373380935;6168;6181.165542651775;6254.843628909222;5713.428657134254;5716.399778023331;5721.22763426932;5723.570732195102;5762.827115186551;5371.516563509303;5417.864553386118;5438.510534051954;5439.020976224238;5442.945570544323;5239.345081864767;6257.9687101564205;6282.905756413749;6301.212348456443;6332.556721029484;6191.84520386994;6277.937220627918;6280.340564240689;6287.717052732546;6288.654124023223;6292.119103325446;6314.116023756769;6327.936720632919;6328.272248691459;6343.777967771106;6006.189164462741;6132.509399248139;6168.9691551541955;6184.845378865564;6192.969035154795;6222.253329600477;6268.122462855113;6270.7491700331475;6296.5277604178955;6317.6841157941;6124.785632502841;6126.724297406717;6160.568760186744;6161.4146656067605;6170.629762214281;5485;5897.734601942837;6065.8180254592435;6089.391060893875;6135.631862088289;5440.945590544202;5670.603057785916;5888.234529511136;6015.849603759766;6027.21646185993;6136.846578835565;6152.630842149485;6176.227971503562;6185.907211391743;6189.876202476015;5797.333306669787;5883.441073098049;5938.584299099021;5947.1079338099635;5953.672548009901 23:06:17 INFO - PROCESS | 1660 | |1;ext.html;460.7419844886862;481.8434008947091;484.60504688678725;525.1728527569074;536.2894165231069;30410;32260.838695806517;41307.38038929411;41318.38022429662;43536.56463435365;34249;42681.57318426815;42788;42853.78573107138;42961.78519107408;8719.389642725011;9736.805263894736;9935;9950.950245248763;9951;8617.698380556682;11768.176227664024;11981.460834262436;11996.700082497964;12206.267623942547;12041.93979030108;12099.395030248497;12109.697257568543;12112.394380280995;12178.939105304506;10698.144148468182;11106.666799996014;12040.458179381949;12127.211731237441;12136.635900922942;11867.169298149132;11943;11947.701307467296;11956;11957.282563046245;39956.40065399021;40227.79886100551;40253.79873100645;40267.194656106716;40305.79847100775;3198.9360212795614;3309.4539400998806;3656.8171591420323;3963.742356746802;4122.40225167349;30471;30745.077647670605;30849.537256941163;31105.688943110505;32249;3201;3211.1811488070393;3231.5960504936884;3244.951325730116;3356.580427446569;507337;511178.9999999963;515068;516757;519410;62865.68567157226;64030;64046.6797666018;64149.03776443357;64181.679091604245;35315.293694126485;35816.28367432637;36112.63887361145;37226.25547489035;67238.6552268952;16974.660506789794;17172.484825455256;17190.398336058177;17191.742123868153;17215.91392043057;10597.20520960931;11773.88226117745;11999.520019199133;12956.157849739737;13072.607821765363;20072.99635018243;20828.895855520626;20832.791672083084;20859.791402086088;20860.165593376096;7703.383729301642;8422.34328350763;8777.29781617469;8857.475619448427;8904.109589041043;833.9041010283773;987.2357399281982;1045.6235755128148;1053.5871069509956;1126.6901602059336;29666.25834354115;30060.248493787392;30118.247043824078;30802;31044;1071.9410432426291;1104.5581767293147;1118.0831717991168;1118.5302173087323;1216.8075286219555;14736;14991.625209369853;15522.379104835905;15671.482102602282;15861.603459913595;687966;693509;695339;695382;695633;58126.22179558315;58643.4135658638;58726.412735872946;58755;58829.70585147047;1218.9085818563642;1351.094766506443;1359.4358341288255;1382.1499777636682;1387.2092907042888;30226.9420570279;31067.84466077655;31119;31889;32060.6793932067;48749.78125546889;49397.76505587389;49398.25902611392;49406.25890611715;49416;508981;510500;510639;511289.44355277985;511406;26557.336066597716;27396.726032740215;27437;27717.72282277232;27967.44065118727;46653.76673116748;46715.766421167675;47318;47681.761591191826;47789;38235.80882095572;38311.04222394463;38875.222495549366;39323;39694;37934.430983534716;38490.80754596209;39217.411738824514;39322.80338598289;40065;36683.266334672626;36921.63078369182;37778.68460864714;37884.81057594695;37947.86156415312;30981.69018309878;31928.699321206717;33683.83158084292;33945;33964.83017584896;22618.886905565367;23011.84940752989;25011.374715631526;25103.99584016692;25456.109036183643 23:06:17 INFO - PROCESS | 1660 | |2;jquery.html;344.12592016278654;363.45663233465973;366.8074261012968;372.4859693622801;394.8815355393383;15350.616234594127;16556.420525281617;17158.142092895367;20630.587388252265;20805;11925.76148477032;14076.296185190751;19778.10998505071;20517.589648207027;20727.689084663703;5400.78396864125;5624.718764061801;5631.549476041927;5636;5637.661740295575;5166.199239117943;5484.232207490954;6113.755449782004;6176.351483094255;6236;6163.383661633846;6203.131561581382;6205.441510264075;6215.09881067245;6220.813375598716;6782.966085169567;6874.621895795729;6903.654817259167;6928.064711263965;6934.757283495053;5799.710014499258;5949.375315591844;6033.456988871023;6042.184305118797;6072.332043475214;13136.934315328457;13224.140430871963;13242.66893327665;18726.438206853818;25115;2098.9790102098937;2111.0078263216265;2347.5891718949115;2417.7340492545804;2815.127310533741;9462.668806591737;10102;10286.845697314546;12307.953823924978;15592.064476131354;1871.1205733305326;1897.4118023412648;1928.350112355097;1955.9804401955942;1962.1660794162424;125146;129210;129403;131049;134701.61193552247;11199.304229604211;11226.775464490664;11414.600488983011;11450.198486105892;11544.653660390202;14398.856011439751;14454.638634034232;14466.132032078109;14471.855281447051;14490.275486225646;8403.369747268856;8584;8600.956995214983;8605.31157507398;8722.956385218033;8409.53747543891;8465.576721163918;8605.655773769104;8672.219500245008;8677.045524992245;4385.407969924083;4466.0844526871915;4467.374567560544;4541.704789188759;4565.863024109282;1813.791413987382;1850.3260901934714;1851.694470412394;1856.6843636581814;1859.0890463672704;843.8312337532395;856.2850020233051;888.1518150166704;888.2849306308354;892.2950868813565;19834.404967850987;21083.578328433345;21476.89261553682;21539.89230053871;21568.890278956766;903.516618609041;906.4515967839494;919.8344298026286;939.3049143633662;940.6660635474445;10538.947305263424;11078.778424431466;11140.33158010522;11192.160587955936;11262.605808796652;531913;537097;542126;569915;571521;92995;107784.84430311507;116901.97176338724;119811;121215;896.8116695494019;906.7823722306599;960.0879164793474;961.1685891703626;964.7395203295071;19466.124024418652;19775.307864224684;19787.30744423938;19794.307199247956;19836.801631983497;55448;56280;57119;57283;57472.13791793043;78774;81089;82100.58949705213;84588.30823383621;85241;6402.423781859655;6563.113979612882;6930.930690693029;7394.260573942563;7929.722459714113;10439.686809395731;11567.537298508301;11805;12788.744225115259;13313.933430332787;10031.448270345201;10282.897171028493;11003.33979961205;11283.774324513628;11382.260153090023;10839.783204336027;10903.890961090288;10921.344719316867;11216.55133794639;11526.769464610828;8382;11089.390083545482;11402.20184587104;11536.711582210512;11589.768204635691;7124.287571242834;7261.927380726336;7266.890996634949;7342.5227360221415;7466.440016998856;8935.731928042169;10892.618758343737;11225.775484490101;11266.929641684026;11433.942830286129 23:06:17 INFO - PROCESS | 1660 | |3;mootools.html;1500.6473478732496;1536.8539988701073;1753.9824601753978;1880.6896862017768;1930.81657242562;8610.87083693745;9088.90911090889;9107.95446022769;9114.54427278636;9126.543672816366;7887.92112078879;8108.270255676988;8111.43219974602;8205.384596155282;8877.644894204224;2170.4465361332836;2359.8112151027963;2438.1588352018525;2442.4748679034005;2450.1669432392982;2429.586970215059;2430.4895971845935;2433.513297340539;2435.1111844176835;2436.768506991833;2366.372911178539;2425.5876500994787;2427.817913656474;2428.4657375377387;2429.2712186344115;2413.1192114878118;2419.0928401849305;2432.1852179519883;2434.087217293515;2434.6226334918115;2396.2571602803187;2415.287490190398;2416.9395765105837;2426.3691440225493;2431.3070774829266;8904.777380565472;8965.820683586291;9021.729348119567;9031.503267320295;9040.638374465014;5284.550813180885;5455.208994695747;5459.754311056012;5470.480304371078;5472.890542189174;3551.627079156677;3664.395374763161;3738.532683414573;3748.212875296191;3756.849726010956;1053.9947300263527;1100.1748688483638;1121.5906194239126;1125.4091601909063;1133.9036181924546;11875.584354547636;11877.227980181347;11882.168248222628;11888.346140962243;11889.762204755943;4703.412073490814;4752.477227504972;4948.925766113512;5007.824726134568;5047.697138171721;9253.768655783659;9308.720738377859;9318.30112741547;9320;9325.580348884316;5350.277712508761;5357.330333708286;5361.705106219118;5361.973190134102;5362.678239305654;4919.2129259318335;4966.932109596454;4970.453250142481;4991.625628077836;5031.371078615173;3162.2884850908363;3482.6865582097225;3660.139867131222;3694.5935947045805;3695.722820788452;1122.971925701864;1161.1639619473965;1165.953361865516;1167.731421772997;1174.4362705901215;878.7319867440365;881.4975463985595;885.8272636835756;889.7731078574922;900.3832374823266;5728.77084916607;5740.827775166752;5966.284045914518;6072.119542666377;6198.194234749544;931.4457897550947;932.4172392254841;936.3305236755753;946.4747065378781;997.0478193325357;3780.716446266541;3821.541415030214;3887.455756194135;4022;4045;9787.951060244653;10346.948265258776;10581.894181058246;10742.570297188182;10907.400092994962;10618.522166502371;10854.620088296871;10863.728406789893;10865.967733065347;10890.945545272223;7930.524168549906;8354.79113022167;8357.12250213731;8358.414910956175;8366.958165209257;5933.851653708519;5950.375210602824;6070.150178974859;6122;6169.105479705508;8531.786705332417;8619.612117454855;9956.277825470674;10221.693349199535;10243.07812296867;10258.12805911476;10507.369557826554;10518.421486817992;10524.842127368249;10536.10443112344;7032.050673159058;7090.787276381717;7093.82265443368;7098.929010710033;7123.109611298588;7501;8131.146229645802;8150.510969341858;8243.505389676639;8278.006639203335;6445.991316077176;7072.3634872861685;7562.168161502341;7688.654010569426;7718;7385.446091543048;7469.215732348025;7474.626268686435;7511.173770885089;7568.81077973033;6989.510734248757;7117.8576428470105;7121.893171602326;7124.073870397023;7125.002499650157;4857.489963553776;4908.141075311878;4942.258661200849;4967.7516124192925;5181.041507321158;4789.161896668139;4900.730459824744;5014.17266151081;5049.318342023927;5206.349206349207 23:06:17 INFO - PROCESS | 1660 | |4;prototype.html;291.3517423732196;295.7323622121979;298.2558516501329;306.2206683989247;306.6243851282178;4555.794989225485;5298.284731561238;5317.8404647860525;5337.5196232339085;5340.465953404662;5266.605004624659;5317.867053323669;5370.2750128732705;5385.842043960548;5394.244805727191;3110.9889285982144;3152.8738850445957;3418.794872307657;4015.2973229684835;4079.4492743479695;4035.4552135461777;4055.8783236502804;4080.204360149772;4088.2028004539125;4088.4889388826396;3673.7876500754687;3688.041109311585;3802.8591422573254;3979.5025621797276;4039.939400908989;3237.7571682123817;3561.9314205738306;3869.2454971280613;3924.274009308287;4035.4955630546183;3496.702780263681;3501.597316308606;3508.1931155834045;3525.4440530615357;3538.5576802899636;4228.80102346781;5103.4896510349035;5104.591632669378;5143.922841157386;5149.253358263031;4446.822127114911;4525.502194758574;4591.586757191835;4619.445666520006;4623.428034468263;4819.6867203631655;5441.047816632074;5509.944900550983;5520.585956053312;5521.3926468088475;3238.951415728766;3855.2867719471988;3857.324968130566;3862.497875276224;3878.4764056852528;5092.439831618556;5568.276124103881;5775.94224057754;5795.88408231833;5795.88408231833;3181.729552988022;3236.886708965175;3407.148212946763;3882.0877093882914;3888.2806680764147;3365.663433656615;3985.80070996449;3989.3218152914073;4001.379786133154;4034.1931613677384;3840.519935008124;4229.703920725519;4622.768861556909;4648.883777905512;4674.106986670404;4170.9582904171175;5303.628745987744;5441.374241962146;5563.221149039137;5646.20953066571;1126.6169502369235;1267.6387229639693;1353.9187648741106;1357.5180810812217;1358.7418390505773;759.9468037237451;781.3827076609415;895.8297923394534;948.2271948362063;949.9905000949902;4291;4817.470078291385;4886.898633587592;5057.519535644108;5219.08665983459;5055.443901170868;5663.801766938137;5752.597318187771;5753.194552762617;5844.590878638454;4925.236588328815;5145.665531740425;5185.714785686823;5210.374755029345;5238.423773384925;2216.7561568227484;2885.321949341903;3013.804102733315;3031.7423019043626;3033.8634761435787;5177.576166554228;5212;5938.940610593925;5943.227380440601;6056.485198758067;4923.507649235119;4951.975240123848;5025.738417712044;5543.861403464865;5971.864770995176;5311.946880531223;5819.621724587888;6037.72830222641;6039.667818270037;6062.636241825505;4638.234691275901;5023.69857808518;5792;5845.473907348359;5939.316978547349;4345.478542574911;4751.50109238525;4952.2819191217795;5013.147764879906;5783.421657834183;5758.395368486416;5977.671228082497;6008;6021.7956408717555;6053.848653783514;3261.7390608751716;3894.591067937939;3898.7465814721954;3907.3357529219534;3927.155661532784;5098.311727916684;5527.949689558971;5558.57170607303;5824.078054242005;5831.650100993954;5409.78360865561;5597.829616935409;5633.619828103106;5645.870825834767;5661.094224923992;5269.4730526947;5315.760790764502;5363.249145119765;5565.666060036411;5605.271314729059;4556.931646025246;5020.924686129784;5321.893562128813;5337.199420087018;5441.7551210196425;5373.462653734595;5550.222968784454;5620.718964051863;5627.88744225105;5628.296462942132;4319.265724826724;4522.773861306987;5259.947400525945;5427.538659214011;5477.972610136924 23:06:17 INFO - PROCESS | 1660 | |5;yui.html;695.2491309385864;761.4859969520572;774.3379410603934;813.7070654564358;846.6486408140626;14734.557963261093;16005.199740013011;16037.278322475488;16048;16056.999999999985;14040.859591404083;14360.138391696479;14681.412743490275;14698.412063517473;14704.044237124579;833.8874251975997;834.0366876257932;845.4420082745389;848.5757121439281;850.2517784349764;668.4785867023729;687.6492988575837;842.0737189091981;846.5132548784474;847.817719190374;697.2086681616352;698.183125742882;699.2552931128332;863.9092895246002;894.2979760887672;891.3760367742574;893.3121496447764;893.6827426263712;894.3784070071302;894.9284057275403;664.5182242873926;664.7573635622963;664.8371149068461;665.0356982375574;665.0855074272874;12043.217190882564;14453.783193252004;14507.202103884281;14548.709025819424;15017.624559385993;13695.109817861907;14349.210793406359;14508.202048887308;14514.419423223058;14563.854361456355;11314.886851131465;11679.7080072998;11749.29504229749;11833.112516561207;12092.032637388987;3822.751521151144;3825.6365645263654;3853.344931361675;3860.5560360558334;3862.4013277941963;104694;107874;109392.90607093986;109465.90534094637;111323.63160078577;11348.546058157746;11572.074234061423;11583.189176757545;11606.535738570363;11786.410679465993;23328.950197241164;23523.882380587987;23565.175218867258;23573.410664733517;23605;8057.274845263954;8096.757097287091;8277.917220827836;8336;8348.499090054616;4427.180971520279;4509.413776209072;4551.385562949025;4644.3265726470145;4691.648126390534;3590.24604832988;3697.205100903319;3702.81485925708;3706.684931780775;3707.1102935295876;654.6890227142069;667.0394631730293;682.2495255219219;684.1106561470168;685.1093578348127;626.5432868580568;626.8495561065312;628.9559730818798;663.1577896071962;685.9108315918999;8772.649094036295;8961.641534338683;9039.502827344428;9355.953220233856;9367.110124538158;558.1460365640577;583.8948989181903;602.6594973839855;637.219406227377;663.3963093584815;3913.25648126855;4363.629091527192;4573.336866154389;4587.564181402761;4636.582707556337;151054;164755;165045;165295;168154;98321;139610;140371;142608.2869585666;144406;97305.0269497296;105968.94031059745;110102;111182;119471.20793187935;9159.633614655606;9435.433873967584;9488.193503552275;9531.285153613368;9622.951885240529;63577;63694.36305636884;65210.34789652043;65712.34287657062;67063.32936670572;95916.04083959071;98775;101468;102694.48652756689;103456.48271758592;13677.658058548615;13686.600155325934;13740.793888091486;13814.37835297394;13952.58142255734;14756.360629113036;14818.110913345234;14888.032277901902;14963.551093467213;15627.609309767347;10904.672859814218;13845.723085538435;14065.789013165015;14387.136771793726;14407;13565;13923.58229253124;13947.790783138058;14073.155610663393;14097.647558811112;13586.116902401312;13596.388162532907;13609.52366667162;14041.1575305482;14230.928845355707;11112.499937502671;11406.17938186331;11461.52585226261;11931.761364772483;11951.641450756491;10997.945010274898;11435.313562570618;11491.195616306779;11701.356425396345;11713.355765432641 23:06:17 INFO - PROCESS | 1660 | __end_tp_report 23:06:17 INFO - PROCESS | 1660 | __start_cc_report 23:06:17 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1246 23:06:17 INFO - PROCESS | 1660 | __end_cc_report 23:06:17 INFO - PROCESS | 1660 | __startTimestamp1473228377070__endTimestamp 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - PROCESS | 1660 | ------- Summary: start ------- 23:06:17 INFO - PROCESS | 1660 | Number of tests: 6 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5720.10 Median:5897.73 stddev:662.62 (11.2%) stddev-sans-first:618.80 23:06:17 INFO - PROCESS | 1660 | Values: 2632.5 3313.2 3347.4 3373.0 3413.0 5588.5 5650.9 5674.8 5723.0 5726.8 5660.4 5663.3 5740.3 5741.6 5784.7 5106.9 5159.6 5230.9 5235.0 5272.7 5290.4 5332.3 5340.9 5346.4 5370.9 5141.0 5165.3 5185.9 5203.9 5252.9 4289.5 5180.5 5220.1 5324.1 5336.9 5222.7 5253.7 5254.1 5262.5 5323.3 5610.2 5784.7 5785.6 5788.6 5795.9 6023.3 6121.5 6123.0 6127.4 6233.2 6262.3 6272.4 6304.4 6307.6 6314.6 4788.0 5635.3 5768.1 5773.3 5789.5 6278.4 6279.7 6344.4 6345.5 6350.5 6148.9 6163.6 6166.1 6167.2 6170.1 6224.3 6287.0 6296.1 6303.6 6325.3 6031.3 6041.4 6057.5 6113.9 6123.3 6114.8 6115.5 6116.7 6126.7 6138.4 4891.4 4959.0 4975.5 4979.7 4980.1 4349.2 4392.3 4392.3 4393.3 4409.6 5677.3 5703.8 5704.0 5705.2 5706.6 6095.1 6146.0 6168.0 6181.2 6254.8 5713.4 5716.4 5721.2 5723.6 5762.8 5371.5 5417.9 5438.5 5439.0 5442.9 5239.3 6258.0 6282.9 6301.2 6332.6 6191.8 6277.9 6280.3 6287.7 6288.7 6292.1 6314.1 6327.9 6328.3 6343.8 6006.2 6132.5 6169.0 6184.8 6193.0 6222.3 6268.1 6270.7 6296.5 6317.7 6124.8 6126.7 6160.6 6161.4 6170.6 5485.0 5897.7 6065.8 6089.4 6135.6 5440.9 5670.6 5888.2 6015.8 6027.2 6136.8 6152.6 6176.2 6185.9 6189.9 5797.3 5883.4 5938.6 5947.1 5953.7 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:70343.89 Median:34106.92 stddev:154830.76 (454.0%) stddev-sans-first:155176.19 23:06:17 INFO - PROCESS | 1660 | Values: 460.7 481.8 484.6 525.2 536.3 30410.0 32260.8 41307.4 41318.4 43536.6 34249.0 42681.6 42788.0 42853.8 42961.8 8719.4 9736.8 9935.0 9951.0 9951.0 8617.7 11768.2 11981.5 11996.7 12206.3 12041.9 12099.4 12109.7 12112.4 12178.9 10698.1 11106.7 12040.5 12127.2 12136.6 11867.2 11943.0 11947.7 11956.0 11957.3 39956.4 40227.8 40253.8 40267.2 40305.8 3198.9 3309.5 3656.8 3963.7 4122.4 30471.0 30745.1 30849.5 31105.7 32249.0 3201.0 3211.2 3231.6 3245.0 3356.6 507337.0 511179.0 515068.0 516757.0 519410.0 62865.7 64030.0 64046.7 64149.0 64181.7 35315.3 35816.3 36112.6 37226.3 67238.7 16974.7 17172.5 17190.4 17191.7 17215.9 10597.2 11773.9 11999.5 12956.2 13072.6 20073.0 20828.9 20832.8 20859.8 20860.2 7703.4 8422.3 8777.3 8857.5 8904.1 833.9 987.2 1045.6 1053.6 1126.7 29666.3 30060.2 30118.2 30802.0 31044.0 1071.9 1104.6 1118.1 1118.5 1216.8 14736.0 14991.6 15522.4 15671.5 15861.6 687966.0 693509.0 695339.0 695382.0 695633.0 58126.2 58643.4 58726.4 58755.0 58829.7 1218.9 1351.1 1359.4 1382.1 1387.2 30226.9 31067.8 31119.0 31889.0 32060.7 48749.8 49397.8 49398.3 49406.3 49416.0 508981.0 510500.0 510639.0 511289.4 511406.0 26557.3 27396.7 27437.0 27717.7 27967.4 46653.8 46715.8 47318.0 47681.8 47789.0 38235.8 38311.0 38875.2 39323.0 39694.0 37934.4 38490.8 39217.4 39322.8 40065.0 36683.3 36921.6 37778.7 37884.8 37947.9 30981.7 31928.7 33683.8 33945.0 33964.8 22618.9 23011.8 25011.4 25104.0 25456.1 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:33438.34 Median:1579.63 stddev:92461.35 (5853.4%) stddev-sans-first:92687.34 23:06:17 INFO - PROCESS | 1660 | Values: 344.1 363.5 366.8 372.5 394.9 15350.6 16556.4 17158.1 20630.6 20805.0 11925.8 14076.3 19778.1 20517.6 20727.7 5400.8 5624.7 5631.5 5636.0 5637.7 5166.2 5484.2 6113.8 6176.4 6236.0 6163.4 6203.1 6205.4 6215.1 6220.8 6783.0 6874.6 6903.7 6928.1 6934.8 5799.7 5949.4 6033.5 6042.2 6072.3 13136.9 13224.1 13242.7 18726.4 25115.0 2099.0 2111.0 2347.6 2417.7 2815.1 9462.7 10102.0 10286.8 12308.0 15592.1 1871.1 1897.4 1928.4 1956.0 1962.2 125146.0 129210.0 129403.0 131049.0 134701.6 11199.3 11226.8 11414.6 11450.2 11544.7 14398.9 14454.6 14466.1 14471.9 14490.3 8403.4 8584.0 8601.0 8605.3 8723.0 8409.5 8465.6 8605.7 8672.2 8677.0 4385.4 4466.1 4467.4 4541.7 4565.9 1813.8 1850.3 1851.7 1856.7 1859.1 843.8 856.3 888.2 888.3 892.3 19834.4 21083.6 21476.9 21539.9 21568.9 903.5 906.5 919.8 939.3 940.7 10538.9 11078.8 11140.3 11192.2 11262.6 531913.0 537097.0 542126.0 569915.0 571521.0 92995.0 107784.8 116902.0 119811.0 121215.0 896.8 906.8 960.1 961.2 964.7 19466.1 19775.3 19787.3 19794.3 19836.8 55448.0 56280.0 57119.0 57283.0 57472.1 78774.0 81089.0 82100.6 84588.3 85241.0 6402.4 6563.1 6930.9 7394.3 7929.7 10439.7 11567.5 11805.0 12788.7 13313.9 10031.4 10282.9 11003.3 11283.8 11382.3 10839.8 10903.9 10921.3 11216.6 11526.8 8382.0 11089.4 11402.2 11536.7 11589.8 7124.3 7261.9 7266.9 7342.5 7466.4 8935.7 10892.6 11225.8 11266.9 11433.9 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5712.21 Median:5022.77 stddev:3174.71 (63.2%) stddev-sans-first:3167.84 23:06:17 INFO - PROCESS | 1660 | Values: 1500.6 1536.9 1754.0 1880.7 1930.8 8610.9 9088.9 9108.0 9114.5 9126.5 7887.9 8108.3 8111.4 8205.4 8877.6 2170.4 2359.8 2438.2 2442.5 2450.2 2429.6 2430.5 2433.5 2435.1 2436.8 2366.4 2425.6 2427.8 2428.5 2429.3 2413.1 2419.1 2432.2 2434.1 2434.6 2396.3 2415.3 2416.9 2426.4 2431.3 8904.8 8965.8 9021.7 9031.5 9040.6 5284.6 5455.2 5459.8 5470.5 5472.9 3551.6 3664.4 3738.5 3748.2 3756.8 1054.0 1100.2 1121.6 1125.4 1133.9 11875.6 11877.2 11882.2 11888.3 11889.8 4703.4 4752.5 4948.9 5007.8 5047.7 9253.8 9308.7 9318.3 9320.0 9325.6 5350.3 5357.3 5361.7 5362.0 5362.7 4919.2 4966.9 4970.5 4991.6 5031.4 3162.3 3482.7 3660.1 3694.6 3695.7 1123.0 1161.2 1166.0 1167.7 1174.4 878.7 881.5 885.8 889.8 900.4 5728.8 5740.8 5966.3 6072.1 6198.2 931.4 932.4 936.3 946.5 997.0 3780.7 3821.5 3887.5 4022.0 4045.0 9788.0 10346.9 10581.9 10742.6 10907.4 10618.5 10854.6 10863.7 10866.0 10890.9 7930.5 8354.8 8357.1 8358.4 8367.0 5933.9 5950.4 6070.2 6122.0 6169.1 8531.8 8619.6 9956.3 10221.7 10243.1 10258.1 10507.4 10518.4 10524.8 10536.1 7032.1 7090.8 7093.8 7098.9 7123.1 7501.0 8131.1 8150.5 8243.5 8278.0 6446.0 7072.4 7562.2 7688.7 7718.0 7385.4 7469.2 7474.6 7511.2 7568.8 6989.5 7117.9 7121.9 7124.1 7125.0 4857.5 4908.1 4942.3 4967.8 5181.0 4789.2 4900.7 5014.2 5049.3 5206.3 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4461.17 Median:5040.59 stddev:1398.91 (27.8%) stddev-sans-first:1367.37 23:06:17 INFO - PROCESS | 1660 | Values: 291.4 295.7 298.3 306.2 306.6 4555.8 5298.3 5317.8 5337.5 5340.5 5266.6 5317.9 5370.3 5385.8 5394.2 3111.0 3152.9 3418.8 4015.3 4079.4 4035.5 4055.9 4080.2 4088.2 4088.5 3673.8 3688.0 3802.9 3979.5 4039.9 3237.8 3561.9 3869.2 3924.3 4035.5 3496.7 3501.6 3508.2 3525.4 3538.6 4228.8 5103.5 5104.6 5143.9 5149.3 4446.8 4525.5 4591.6 4619.4 4623.4 4819.7 5441.0 5509.9 5520.6 5521.4 3239.0 3855.3 3857.3 3862.5 3878.5 5092.4 5568.3 5775.9 5795.9 5795.9 3181.7 3236.9 3407.1 3882.1 3888.3 3365.7 3985.8 3989.3 4001.4 4034.2 3840.5 4229.7 4622.8 4648.9 4674.1 4171.0 5303.6 5441.4 5563.2 5646.2 1126.6 1267.6 1353.9 1357.5 1358.7 759.9 781.4 895.8 948.2 950.0 4291.0 4817.5 4886.9 5057.5 5219.1 5055.4 5663.8 5752.6 5753.2 5844.6 4925.2 5145.7 5185.7 5210.4 5238.4 2216.8 2885.3 3013.8 3031.7 3033.9 5177.6 5212.0 5938.9 5943.2 6056.5 4923.5 4952.0 5025.7 5543.9 5971.9 5311.9 5819.6 6037.7 6039.7 6062.6 4638.2 5023.7 5792.0 5845.5 5939.3 4345.5 4751.5 4952.3 5013.1 5783.4 5758.4 5977.7 6008.0 6021.8 6053.8 3261.7 3894.6 3898.7 3907.3 3927.2 5098.3 5527.9 5558.6 5824.1 5831.7 5409.8 5597.8 5633.6 5645.9 5661.1 5269.5 5315.8 5363.2 5565.7 5605.3 4556.9 5020.9 5321.9 5337.2 5441.8 5373.5 5550.2 5620.7 5627.9 5628.3 4319.3 4522.8 5259.9 5427.5 5478.0 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:25759.86 Median:13597.62 stddev:41598.05 (305.9%) stddev-sans-first:41672.17 23:06:17 INFO - PROCESS | 1660 | Values: 695.2 761.5 774.3 813.7 846.6 14734.6 16005.2 16037.3 16048.0 16057.0 14040.9 14360.1 14681.4 14698.4 14704.0 833.9 834.0 845.4 848.6 850.3 668.5 687.6 842.1 846.5 847.8 697.2 698.2 699.3 863.9 894.3 891.4 893.3 893.7 894.4 894.9 664.5 664.8 664.8 665.0 665.1 12043.2 14453.8 14507.2 14548.7 15017.6 13695.1 14349.2 14508.2 14514.4 14563.9 11314.9 11679.7 11749.3 11833.1 12092.0 3822.8 3825.6 3853.3 3860.6 3862.4 104694.0 107874.0 109392.9 109465.9 111323.6 11348.5 11572.1 11583.2 11606.5 11786.4 23329.0 23523.9 23565.2 23573.4 23605.0 8057.3 8096.8 8277.9 8336.0 8348.5 4427.2 4509.4 4551.4 4644.3 4691.6 3590.2 3697.2 3702.8 3706.7 3707.1 654.7 667.0 682.2 684.1 685.1 626.5 626.8 629.0 663.2 685.9 8772.6 8961.6 9039.5 9356.0 9367.1 558.1 583.9 602.7 637.2 663.4 3913.3 4363.6 4573.3 4587.6 4636.6 151054.0 164755.0 165045.0 165295.0 168154.0 98321.0 139610.0 140371.0 142608.3 144406.0 97305.0 105968.9 110102.0 111182.0 119471.2 9159.6 9435.4 9488.2 9531.3 9623.0 63577.0 63694.4 65210.3 65712.3 67063.3 95916.0 98775.0 101468.0 102694.5 103456.5 13677.7 13686.6 13740.8 13814.4 13952.6 14756.4 14818.1 14888.0 14963.6 15627.6 10904.7 13845.7 14065.8 14387.1 14407.0 13565.0 13923.6 13947.8 14073.2 14097.6 13586.1 13596.4 13609.5 14041.2 14230.9 11112.5 11406.2 11461.5 11931.8 11951.6 10997.9 11435.3 11491.2 11701.4 11713.4 23:06:17 INFO - PROCESS | 1660 | -------- Summary: end -------- 23:06:17 INFO - PROCESS | 1660 | 23:06:17 INFO - TEST-INFO | 1660: exit 0 23:06:17 INFO - TEST-OK | dromaeo_css | took 1117624ms 23:06:17 INFO - TEST-START | kraken 23:06:17 INFO - operating with platform_type : mac_ 23:06:17 INFO - Initialising browser for kraken test... 23:06:17 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmp3qDYFw/profile http://localhost:49272/getInfo.html) 23:06:19 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 23:06:19 INFO - PROCESS | 1665 | colorDepth:24 23:06:19 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 23:06:19 INFO - PROCESS | 1665 | __metrics 23:06:20 INFO - PROCESS | 1665 | 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" 23:06:20 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:06:20 INFO - TEST-INFO | 1665: exit 0 23:06:20 INFO - Browser initialized. 23:06:20 INFO - Running cycle 1/1 for kraken test... 23:06:20 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmp3qDYFw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:32 INFO - PROCESS | 1666 | RSS: Main: 232427520 23:06:32 INFO - PROCESS | 1666 | 23:06:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 23:06:36 INFO - PROCESS | 1666 | RSS: Main: 291192832 23:06:36 INFO - PROCESS | 1666 | 23:06:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 23:06:39 INFO - PROCESS | 1666 | RSS: Main: 287420416 23:06:39 INFO - PROCESS | 1666 | 23:06:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 23:06:43 INFO - PROCESS | 1666 | RSS: Main: 377032704 23:06:43 INFO - PROCESS | 1666 | 23:06:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 23:06:46 INFO - PROCESS | 1666 | RSS: Main: 278507520 23:06:46 INFO - PROCESS | 1666 | 23:06:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:06:49 INFO - PROCESS | 1666 | RSS: Main: 282824704 23:06:49 INFO - PROCESS | 1666 | 23:06:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 23:06:52 INFO - PROCESS | 1666 | RSS: Main: 321146880 23:06:52 INFO - PROCESS | 1666 | 23:06:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 23:06:56 INFO - PROCESS | 1666 | RSS: Main: 321740800 23:06:56 INFO - PROCESS | 1666 | 23:06:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 23:06:59 INFO - PROCESS | 1666 | RSS: Main: 322007040 23:06:59 INFO - PROCESS | 1666 | 23:07:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:07:01 INFO - PROCESS | 1666 | RSS: Main: 297955328 23:07:01 INFO - PROCESS | 1666 | 23:07:03 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:07:04 INFO - PROCESS | 1666 | RSS: Main: 305500160 23:07:04 INFO - PROCESS | 1666 | 23:07:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:07:07 INFO - PROCESS | 1666 | RSS: Main: 299003904 23:07:07 INFO - PROCESS | 1666 | 23:07:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:07:10 INFO - PROCESS | 1666 | RSS: Main: 319762432 23:07:10 INFO - PROCESS | 1666 | 23:07:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:07:14 INFO - PROCESS | 1666 | RSS: Main: 316076032 23:07:14 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 23:07:16 INFO - PROCESS | 1666 | RSS: Main: 359366656 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | __start_tp_report 23:07:16 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 23:07:16 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 23:07:16 INFO - PROCESS | 1666 | |i|pagename|runs| 23:07:16 INFO - PROCESS | 1666 | |0;ai-astar;114;114;117;114;115;113;114;114;113;119 23:07:16 INFO - PROCESS | 1666 | |1;audio-beat-detection;145;111;136;163;108;148;129;109;159;107 23:07:16 INFO - PROCESS | 1666 | |2;audio-dft;184;190;236;184;183;183;184;178;184;214 23:07:16 INFO - PROCESS | 1666 | |3;audio-fft;79;98;106;183;57;58;58;60;141;57 23:07:16 INFO - PROCESS | 1666 | |4;audio-oscillator;83;85;133;75;100;105;132;68;69;111 23:07:16 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;84;88;85;87;83;88;85;87;83 23:07:16 INFO - PROCESS | 1666 | |6;imaging-darkroom;111;150;152;93;102;94;93;93;93;93 23:07:16 INFO - PROCESS | 1666 | |7;imaging-desaturate;86;86;83;85;83;83;84;85;83;83 23:07:16 INFO - PROCESS | 1666 | |8;json-parse-financial;56;53;55;55;55;54;53;55;55;55 23:07:16 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;65;67;74;74;73;71;69;76;104;103 23:07:16 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;87;102;107;111;89;88;107;109;87;85 23:07:16 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;137;140;138;138;134;151;158;133;181;139 23:07:16 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;175;175;176;181;245;197;174;176;175;180 23:07:16 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;68;68;65;67;67;66;70;78;86 23:07:16 INFO - PROCESS | 1666 | __end_tp_report 23:07:16 INFO - PROCESS | 1666 | __start_cc_report 23:07:16 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2021 23:07:16 INFO - PROCESS | 1666 | __end_cc_report 23:07:16 INFO - PROCESS | 1666 | __startTimestamp1473228436628__endTimestamp 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | ------- Summary: start ------- 23:07:16 INFO - PROCESS | 1666 | Number of tests: 14 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:1.89 (1.7%) stddev-sans-first:1.99 23:07:16 INFO - PROCESS | 1666 | Values: 114.0 114.0 117.0 114.0 115.0 113.0 114.0 114.0 113.0 119.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:140.50 stddev:21.88 (15.6%) stddev-sans-first:22.66 23:07:16 INFO - PROCESS | 1666 | Values: 145.0 111.0 136.0 163.0 108.0 148.0 129.0 109.0 159.0 107.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:192.00 Median:184.00 stddev:18.37 (10.0%) stddev-sans-first:19.26 23:07:16 INFO - PROCESS | 1666 | Values: 184.0 190.0 236.0 184.0 183.0 183.0 184.0 178.0 184.0 214.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:89.70 Median:58.00 stddev:43.23 (74.5%) stddev-sans-first:45.67 23:07:16 INFO - PROCESS | 1666 | Values: 79.0 98.0 106.0 183.0 57.0 58.0 58.0 60.0 141.0 57.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:68.50 stddev:24.11 (35.2%) stddev-sans-first:25.10 23:07:16 INFO - PROCESS | 1666 | Values: 83.0 85.0 133.0 75.0 100.0 105.0 132.0 68.0 69.0 111.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:2.18 (2.5%) stddev-sans-first:2.01 23:07:16 INFO - PROCESS | 1666 | Values: 89.0 84.0 88.0 85.0 87.0 83.0 88.0 85.0 87.0 83.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:93.00 stddev:23.72 (25.5%) stddev-sans-first:25.12 23:07:16 INFO - PROCESS | 1666 | Values: 111.0 150.0 152.0 93.0 102.0 94.0 93.0 93.0 93.0 93.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.50 stddev:1.29 (1.5%) stddev-sans-first:1.17 23:07:16 INFO - PROCESS | 1666 | Values: 86.0 86.0 83.0 85.0 83.0 83.0 84.0 85.0 83.0 83.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 23:07:16 INFO - PROCESS | 1666 | Values: 56.0 53.0 55.0 55.0 55.0 54.0 53.0 55.0 55.0 55.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:77.60 Median:72.00 stddev:14.06 (19.5%) stddev-sans-first:14.16 23:07:16 INFO - PROCESS | 1666 | Values: 65.0 67.0 74.0 74.0 73.0 71.0 69.0 76.0 104.0 103.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:97.20 Median:86.00 stddev:10.82 (12.6%) stddev-sans-first:10.83 23:07:16 INFO - PROCESS | 1666 | Values: 87.0 102.0 107.0 111.0 89.0 88.0 107.0 109.0 87.0 85.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:139.50 stddev:14.87 (10.7%) stddev-sans-first:15.49 23:07:16 INFO - PROCESS | 1666 | Values: 137.0 140.0 138.0 138.0 134.0 151.0 158.0 133.0 181.0 139.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:178.00 stddev:22.03 (12.4%) stddev-sans-first:23.04 23:07:16 INFO - PROCESS | 1666 | Values: 175.0 175.0 176.0 181.0 245.0 197.0 174.0 176.0 175.0 180.0 23:07:16 INFO - PROCESS | 1666 | 23:07:16 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:68.50 stddev:6.55 (9.6%) stddev-sans-first:6.93 23:07:16 INFO - PROCESS | 1666 | Values: 69.0 68.0 68.0 65.0 67.0 67.0 66.0 70.0 78.0 86.0 23:07:16 INFO - PROCESS | 1666 | -------- Summary: end -------- 23:07:16 INFO - PROCESS | 1666 | 23:07:17 INFO - TEST-INFO | 1666: exit 0 23:07:17 INFO - TEST-OK | kraken | took 59738ms 23:07:17 INFO - SUITE-END | took 1177s 23:07:17 INFO - Completed test suite (00:19:37) 23:07:17 INFO - javascript benchmark 23:07:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.47350529894, 3313.1717070732316, 3347.364000839839, 3373.004963535757, 3412.9658703412974, 5588.469095435938, 5650.915236271459, 5674.801381951633, 5722.971385143073, 5726.770929162829, 5660.433956604337, 5663.292088488939, 5740.282464691924, 5741.598088133832, 5784.652920824743, 5106.897862042757, 5159.638825282232, 5230.921536176941, 5234.973825130869, 5272.683638981654, 5290.391604965421, 5332.280142180814, 5340.893182136355, 5346.438623944488, 5370.91943620846, 5140.997505486432, 5165.276861239429, 5185.922211166836, 5203.869903252411, 5252.921206181911, 4289.463817022872, 5180.481951804827, 5220.086484865172, 5324.148136298212, 5336.893262134774, 5222.686638801646, 5253.684778913239, 5254.0805359062015, 5262.526372626482, 5323.334583177103, 5610.158476228598, 5784.739686714108, 5785.595008349417, 5788.623739456922, 5795.913061304083, 6023.337432882379, 6121.483458747687, 6123.008104567366, 6127.387261273881, 6233.2208473940755, 6262.342454042306, 6272.40412160844, 6304.369563043705, 6307.558470907038, 6314.62112273265, 4787.952120478821, 5635.295588051494, 5768.134779783066, 5773.336066352381, 5789.478946894799, 6278.372162783685, 6279.7488100476385, 6344.397282258178, 6345.4923606112325, 6350.491960643138, 6148.938510614926, 6163.630182188993, 6166.105914642351, 6167.229096362955, 6170.136180934673, 6224.315325314212, 6286.968565157145, 6296.087067375205, 6303.621782693053, 6325.272593651789, 6031.306399763996, 6041.365656606081, 6057.454829065406, 6113.932424433873, 6123.326434092246, 6114.784027539347, 6115.453310713017, 6116.701002199504, 6126.672418006053, 6138.449706860586, 4891.388576427947, 4958.9504104959215, 4975.4527002029745, 4979.676321039121, 4980.078685443133, 4349.238883195429, 4392.253316936129, 4392.253316936129, 4393.297072468454, 4409.625181859514, 5677.318721753416, 5703.828885133453, 5703.9732848086915, 5705.172749951317, 5706.629069110494, 6095.105866018708, 6146.0166373380935, 6168.0, 6181.165542651775, 6254.843628909222, 5713.428657134254, 5716.399778023331, 5721.22763426932, 5723.570732195102, 5762.827115186551, 5371.516563509303, 5417.864553386118, 5438.510534051954, 5439.020976224238, 5442.945570544323, 5239.345081864767, 6257.9687101564205, 6282.905756413749, 6301.212348456443, 6332.556721029484, 6191.84520386994, 6277.937220627918, 6280.340564240689, 6287.717052732546, 6288.654124023223, 6292.119103325446, 6314.116023756769, 6327.936720632919, 6328.272248691459, 6343.777967771106, 6006.189164462741, 6132.509399248139, 6168.9691551541955, 6184.845378865564, 6192.969035154795, 6222.253329600477, 6268.122462855113, 6270.7491700331475, 6296.5277604178955, 6317.6841157941, 6124.785632502841, 6126.724297406717, 6160.568760186744, 6161.4146656067605, 6170.629762214281, 5485.0, 5897.734601942837, 6065.8180254592435, 6089.391060893875, 6135.631862088289, 5440.945590544202, 5670.603057785916, 5888.234529511136, 6015.849603759766, 6027.21646185993, 6136.846578835565, 6152.630842149485, 6176.227971503562, 6185.907211391743, 6189.876202476015, 5797.333306669787, 5883.441073098049, 5938.584299099021, 5947.1079338099635, 5953.672548009901], "value": 5675.940148518727, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.7419844886862, 481.8434008947091, 484.60504688678725, 525.1728527569074, 536.2894165231069, 30410.0, 32260.838695806517, 41307.38038929411, 41318.38022429662, 43536.56463435365, 34249.0, 42681.57318426815, 42788.0, 42853.78573107138, 42961.78519107408, 8719.389642725011, 9736.805263894736, 9935.0, 9950.950245248763, 9951.0, 8617.698380556682, 11768.176227664024, 11981.460834262436, 11996.700082497964, 12206.267623942547, 12041.93979030108, 12099.395030248497, 12109.697257568543, 12112.394380280995, 12178.939105304506, 10698.144148468182, 11106.666799996014, 12040.458179381949, 12127.211731237441, 12136.635900922942, 11867.169298149132, 11943.0, 11947.701307467296, 11956.0, 11957.282563046245, 39956.40065399021, 40227.79886100551, 40253.79873100645, 40267.194656106716, 40305.79847100775, 3198.9360212795614, 3309.4539400998806, 3656.8171591420323, 3963.742356746802, 4122.40225167349, 30471.0, 30745.077647670605, 30849.537256941163, 31105.688943110505, 32249.0, 3201.0, 3211.1811488070393, 3231.5960504936884, 3244.951325730116, 3356.580427446569, 507337.0, 511178.9999999963, 515068.0, 516757.0, 519410.0, 62865.68567157226, 64030.0, 64046.6797666018, 64149.03776443357, 64181.679091604245, 35315.293694126485, 35816.28367432637, 36112.63887361145, 37226.25547489035, 67238.6552268952, 16974.660506789794, 17172.484825455256, 17190.398336058177, 17191.742123868153, 17215.91392043057, 10597.20520960931, 11773.88226117745, 11999.520019199133, 12956.157849739737, 13072.607821765363, 20072.99635018243, 20828.895855520626, 20832.791672083084, 20859.791402086088, 20860.165593376096, 7703.383729301642, 8422.34328350763, 8777.29781617469, 8857.475619448427, 8904.109589041043, 833.9041010283773, 987.2357399281982, 1045.6235755128148, 1053.5871069509956, 1126.6901602059336, 29666.25834354115, 30060.248493787392, 30118.247043824078, 30802.0, 31044.0, 1071.9410432426291, 1104.5581767293147, 1118.0831717991168, 1118.5302173087323, 1216.8075286219555, 14736.0, 14991.625209369853, 15522.379104835905, 15671.482102602282, 15861.603459913595, 687966.0, 693509.0, 695339.0, 695382.0, 695633.0, 58126.22179558315, 58643.4135658638, 58726.412735872946, 58755.0, 58829.70585147047, 1218.9085818563642, 1351.094766506443, 1359.4358341288255, 1382.1499777636682, 1387.2092907042888, 30226.9420570279, 31067.84466077655, 31119.0, 31889.0, 32060.6793932067, 48749.78125546889, 49397.76505587389, 49398.25902611392, 49406.25890611715, 49416.0, 508981.0, 510500.0, 510639.0, 511289.44355277985, 511406.0, 26557.336066597716, 27396.726032740215, 27437.0, 27717.72282277232, 27967.44065118727, 46653.76673116748, 46715.766421167675, 47318.0, 47681.761591191826, 47789.0, 38235.80882095572, 38311.04222394463, 38875.222495549366, 39323.0, 39694.0, 37934.430983534716, 38490.80754596209, 39217.411738824514, 39322.80338598289, 40065.0, 36683.266334672626, 36921.63078369182, 37778.68460864714, 37884.81057594695, 37947.86156415312, 30981.69018309878, 31928.699321206717, 33683.83158084292, 33945.0, 33964.83017584896, 22618.886905565367, 23011.84940752989, 25011.374715631526, 25103.99584016692, 25456.109036183643], "value": 20410.631279731122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.12592016278654, 363.45663233465973, 366.8074261012968, 372.4859693622801, 394.8815355393383, 15350.616234594127, 16556.420525281617, 17158.142092895367, 20630.587388252265, 20805.0, 11925.76148477032, 14076.296185190751, 19778.10998505071, 20517.589648207027, 20727.689084663703, 5400.78396864125, 5624.718764061801, 5631.549476041927, 5636.0, 5637.661740295575, 5166.199239117943, 5484.232207490954, 6113.755449782004, 6176.351483094255, 6236.0, 6163.383661633846, 6203.131561581382, 6205.441510264075, 6215.09881067245, 6220.813375598716, 6782.966085169567, 6874.621895795729, 6903.654817259167, 6928.064711263965, 6934.757283495053, 5799.710014499258, 5949.375315591844, 6033.456988871023, 6042.184305118797, 6072.332043475214, 13136.934315328457, 13224.140430871963, 13242.66893327665, 18726.438206853818, 25115.0, 2098.9790102098937, 2111.0078263216265, 2347.5891718949115, 2417.7340492545804, 2815.127310533741, 9462.668806591737, 10102.0, 10286.845697314546, 12307.953823924978, 15592.064476131354, 1871.1205733305326, 1897.4118023412648, 1928.350112355097, 1955.9804401955942, 1962.1660794162424, 125146.0, 129210.0, 129403.0, 131049.0, 134701.61193552247, 11199.304229604211, 11226.775464490664, 11414.600488983011, 11450.198486105892, 11544.653660390202, 14398.856011439751, 14454.638634034232, 14466.132032078109, 14471.855281447051, 14490.275486225646, 8403.369747268856, 8584.0, 8600.956995214983, 8605.31157507398, 8722.956385218033, 8409.53747543891, 8465.576721163918, 8605.655773769104, 8672.219500245008, 8677.045524992245, 4385.407969924083, 4466.0844526871915, 4467.374567560544, 4541.704789188759, 4565.863024109282, 1813.791413987382, 1850.3260901934714, 1851.694470412394, 1856.6843636581814, 1859.0890463672704, 843.8312337532395, 856.2850020233051, 888.1518150166704, 888.2849306308354, 892.2950868813565, 19834.404967850987, 21083.578328433345, 21476.89261553682, 21539.89230053871, 21568.890278956766, 903.516618609041, 906.4515967839494, 919.8344298026286, 939.3049143633662, 940.6660635474445, 10538.947305263424, 11078.778424431466, 11140.33158010522, 11192.160587955936, 11262.605808796652, 531913.0, 537097.0, 542126.0, 569915.0, 571521.0, 92995.0, 107784.84430311507, 116901.97176338724, 119811.0, 121215.0, 896.8116695494019, 906.7823722306599, 960.0879164793474, 961.1685891703626, 964.7395203295071, 19466.124024418652, 19775.307864224684, 19787.30744423938, 19794.307199247956, 19836.801631983497, 55448.0, 56280.0, 57119.0, 57283.0, 57472.13791793043, 78774.0, 81089.0, 82100.58949705213, 84588.30823383621, 85241.0, 6402.423781859655, 6563.113979612882, 6930.930690693029, 7394.260573942563, 7929.722459714113, 10439.686809395731, 11567.537298508301, 11805.0, 12788.744225115259, 13313.933430332787, 10031.448270345201, 10282.897171028493, 11003.33979961205, 11283.774324513628, 11382.260153090023, 10839.783204336027, 10903.890961090288, 10921.344719316867, 11216.55133794639, 11526.769464610828, 8382.0, 11089.390083545482, 11402.20184587104, 11536.711582210512, 11589.768204635691, 7124.287571242834, 7261.927380726336, 7266.890996634949, 7342.5227360221415, 7466.440016998856, 8935.731928042169, 10892.618758343737, 11225.775484490101, 11266.929641684026, 11433.942830286129], "value": 9365.001587538545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.6473478732496, 1536.8539988701073, 1753.9824601753978, 1880.6896862017768, 1930.81657242562, 8610.87083693745, 9088.90911090889, 9107.95446022769, 9114.54427278636, 9126.543672816366, 7887.92112078879, 8108.270255676988, 8111.43219974602, 8205.384596155282, 8877.644894204224, 2170.4465361332836, 2359.8112151027963, 2438.1588352018525, 2442.4748679034005, 2450.1669432392982, 2429.586970215059, 2430.4895971845935, 2433.513297340539, 2435.1111844176835, 2436.768506991833, 2366.372911178539, 2425.5876500994787, 2427.817913656474, 2428.4657375377387, 2429.2712186344115, 2413.1192114878118, 2419.0928401849305, 2432.1852179519883, 2434.087217293515, 2434.6226334918115, 2396.2571602803187, 2415.287490190398, 2416.9395765105837, 2426.3691440225493, 2431.3070774829266, 8904.777380565472, 8965.820683586291, 9021.729348119567, 9031.503267320295, 9040.638374465014, 5284.550813180885, 5455.208994695747, 5459.754311056012, 5470.480304371078, 5472.890542189174, 3551.627079156677, 3664.395374763161, 3738.532683414573, 3748.212875296191, 3756.849726010956, 1053.9947300263527, 1100.1748688483638, 1121.5906194239126, 1125.4091601909063, 1133.9036181924546, 11875.584354547636, 11877.227980181347, 11882.168248222628, 11888.346140962243, 11889.762204755943, 4703.412073490814, 4752.477227504972, 4948.925766113512, 5007.824726134568, 5047.697138171721, 9253.768655783659, 9308.720738377859, 9318.30112741547, 9320.0, 9325.580348884316, 5350.277712508761, 5357.330333708286, 5361.705106219118, 5361.973190134102, 5362.678239305654, 4919.2129259318335, 4966.932109596454, 4970.453250142481, 4991.625628077836, 5031.371078615173, 3162.2884850908363, 3482.6865582097225, 3660.139867131222, 3694.5935947045805, 3695.722820788452, 1122.971925701864, 1161.1639619473965, 1165.953361865516, 1167.731421772997, 1174.4362705901215, 878.7319867440365, 881.4975463985595, 885.8272636835756, 889.7731078574922, 900.3832374823266, 5728.77084916607, 5740.827775166752, 5966.284045914518, 6072.119542666377, 6198.194234749544, 931.4457897550947, 932.4172392254841, 936.3305236755753, 946.4747065378781, 997.0478193325357, 3780.716446266541, 3821.541415030214, 3887.455756194135, 4022.0, 4045.0, 9787.951060244653, 10346.948265258776, 10581.894181058246, 10742.570297188182, 10907.400092994962, 10618.522166502371, 10854.620088296871, 10863.728406789893, 10865.967733065347, 10890.945545272223, 7930.524168549906, 8354.79113022167, 8357.12250213731, 8358.414910956175, 8366.958165209257, 5933.851653708519, 5950.375210602824, 6070.150178974859, 6122.0, 6169.105479705508, 8531.786705332417, 8619.612117454855, 9956.277825470674, 10221.693349199535, 10243.07812296867, 10258.12805911476, 10507.369557826554, 10518.421486817992, 10524.842127368249, 10536.10443112344, 7032.050673159058, 7090.787276381717, 7093.82265443368, 7098.929010710033, 7123.109611298588, 7501.0, 8131.146229645802, 8150.510969341858, 8243.505389676639, 8278.006639203335, 6445.991316077176, 7072.3634872861685, 7562.168161502341, 7688.654010569426, 7718.0, 7385.446091543048, 7469.215732348025, 7474.626268686435, 7511.173770885089, 7568.81077973033, 6989.510734248757, 7117.8576428470105, 7121.893171602326, 7124.073870397023, 7125.002499650157, 4857.489963553776, 4908.141075311878, 4942.258661200849, 4967.7516124192925, 5181.041507321158, 4789.161896668139, 4900.730459824744, 5014.17266151081, 5049.318342023927, 5206.349206349207], "value": 4604.643227276001, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.3517423732196, 295.7323622121979, 298.2558516501329, 306.2206683989247, 306.6243851282178, 4555.794989225485, 5298.284731561238, 5317.8404647860525, 5337.5196232339085, 5340.465953404662, 5266.605004624659, 5317.867053323669, 5370.2750128732705, 5385.842043960548, 5394.244805727191, 3110.9889285982144, 3152.8738850445957, 3418.794872307657, 4015.2973229684835, 4079.4492743479695, 4035.4552135461777, 4055.8783236502804, 4080.204360149772, 4088.2028004539125, 4088.4889388826396, 3673.7876500754687, 3688.041109311585, 3802.8591422573254, 3979.5025621797276, 4039.939400908989, 3237.7571682123817, 3561.9314205738306, 3869.2454971280613, 3924.274009308287, 4035.4955630546183, 3496.702780263681, 3501.597316308606, 3508.1931155834045, 3525.4440530615357, 3538.5576802899636, 4228.80102346781, 5103.4896510349035, 5104.591632669378, 5143.922841157386, 5149.253358263031, 4446.822127114911, 4525.502194758574, 4591.586757191835, 4619.445666520006, 4623.428034468263, 4819.6867203631655, 5441.047816632074, 5509.944900550983, 5520.585956053312, 5521.3926468088475, 3238.951415728766, 3855.2867719471988, 3857.324968130566, 3862.497875276224, 3878.4764056852528, 5092.439831618556, 5568.276124103881, 5775.94224057754, 5795.88408231833, 5795.88408231833, 3181.729552988022, 3236.886708965175, 3407.148212946763, 3882.0877093882914, 3888.2806680764147, 3365.663433656615, 3985.80070996449, 3989.3218152914073, 4001.379786133154, 4034.1931613677384, 3840.519935008124, 4229.703920725519, 4622.768861556909, 4648.883777905512, 4674.106986670404, 4170.9582904171175, 5303.628745987744, 5441.374241962146, 5563.221149039137, 5646.20953066571, 1126.6169502369235, 1267.6387229639693, 1353.9187648741106, 1357.5180810812217, 1358.7418390505773, 759.9468037237451, 781.3827076609415, 895.8297923394534, 948.2271948362063, 949.9905000949902, 4291.0, 4817.470078291385, 4886.898633587592, 5057.519535644108, 5219.08665983459, 5055.443901170868, 5663.801766938137, 5752.597318187771, 5753.194552762617, 5844.590878638454, 4925.236588328815, 5145.665531740425, 5185.714785686823, 5210.374755029345, 5238.423773384925, 2216.7561568227484, 2885.321949341903, 3013.804102733315, 3031.7423019043626, 3033.8634761435787, 5177.576166554228, 5212.0, 5938.940610593925, 5943.227380440601, 6056.485198758067, 4923.507649235119, 4951.975240123848, 5025.738417712044, 5543.861403464865, 5971.864770995176, 5311.946880531223, 5819.621724587888, 6037.72830222641, 6039.667818270037, 6062.636241825505, 4638.234691275901, 5023.69857808518, 5792.0, 5845.473907348359, 5939.316978547349, 4345.478542574911, 4751.50109238525, 4952.2819191217795, 5013.147764879906, 5783.421657834183, 5758.395368486416, 5977.671228082497, 6008.0, 6021.7956408717555, 6053.848653783514, 3261.7390608751716, 3894.591067937939, 3898.7465814721954, 3907.3357529219534, 3927.155661532784, 5098.311727916684, 5527.949689558971, 5558.57170607303, 5824.078054242005, 5831.650100993954, 5409.78360865561, 5597.829616935409, 5633.619828103106, 5645.870825834767, 5661.094224923992, 5269.4730526947, 5315.760790764502, 5363.249145119765, 5565.666060036411, 5605.271314729059, 4556.931646025246, 5020.924686129784, 5321.893562128813, 5337.199420087018, 5441.7551210196425, 5373.462653734595, 5550.222968784454, 5620.718964051863, 5627.88744225105, 5628.296462942132, 4319.265724826724, 4522.773861306987, 5259.947400525945, 5427.538659214011, 5477.972610136924], "value": 4017.325526664464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.2491309385864, 761.4859969520572, 774.3379410603934, 813.7070654564358, 846.6486408140626, 14734.557963261093, 16005.199740013011, 16037.278322475488, 16048.0, 16056.999999999985, 14040.859591404083, 14360.138391696479, 14681.412743490275, 14698.412063517473, 14704.044237124579, 833.8874251975997, 834.0366876257932, 845.4420082745389, 848.5757121439281, 850.2517784349764, 668.4785867023729, 687.6492988575837, 842.0737189091981, 846.5132548784474, 847.817719190374, 697.2086681616352, 698.183125742882, 699.2552931128332, 863.9092895246002, 894.2979760887672, 891.3760367742574, 893.3121496447764, 893.6827426263712, 894.3784070071302, 894.9284057275403, 664.5182242873926, 664.7573635622963, 664.8371149068461, 665.0356982375574, 665.0855074272874, 12043.217190882564, 14453.783193252004, 14507.202103884281, 14548.709025819424, 15017.624559385993, 13695.109817861907, 14349.210793406359, 14508.202048887308, 14514.419423223058, 14563.854361456355, 11314.886851131465, 11679.7080072998, 11749.29504229749, 11833.112516561207, 12092.032637388987, 3822.751521151144, 3825.6365645263654, 3853.344931361675, 3860.5560360558334, 3862.4013277941963, 104694.0, 107874.0, 109392.90607093986, 109465.90534094637, 111323.63160078577, 11348.546058157746, 11572.074234061423, 11583.189176757545, 11606.535738570363, 11786.410679465993, 23328.950197241164, 23523.882380587987, 23565.175218867258, 23573.410664733517, 23605.0, 8057.274845263954, 8096.757097287091, 8277.917220827836, 8336.0, 8348.499090054616, 4427.180971520279, 4509.413776209072, 4551.385562949025, 4644.3265726470145, 4691.648126390534, 3590.24604832988, 3697.205100903319, 3702.81485925708, 3706.684931780775, 3707.1102935295876, 654.6890227142069, 667.0394631730293, 682.2495255219219, 684.1106561470168, 685.1093578348127, 626.5432868580568, 626.8495561065312, 628.9559730818798, 663.1577896071962, 685.9108315918999, 8772.649094036295, 8961.641534338683, 9039.502827344428, 9355.953220233856, 9367.110124538158, 558.1460365640577, 583.8948989181903, 602.6594973839855, 637.219406227377, 663.3963093584815, 3913.25648126855, 4363.629091527192, 4573.336866154389, 4587.564181402761, 4636.582707556337, 151054.0, 164755.0, 165045.0, 165295.0, 168154.0, 98321.0, 139610.0, 140371.0, 142608.2869585666, 144406.0, 97305.0269497296, 105968.94031059745, 110102.0, 111182.0, 119471.20793187935, 9159.633614655606, 9435.433873967584, 9488.193503552275, 9531.285153613368, 9622.951885240529, 63577.0, 63694.36305636884, 65210.34789652043, 65712.34287657062, 67063.32936670572, 95916.04083959071, 98775.0, 101468.0, 102694.48652756689, 103456.48271758592, 13677.658058548615, 13686.600155325934, 13740.793888091486, 13814.37835297394, 13952.58142255734, 14756.360629113036, 14818.110913345234, 14888.032277901902, 14963.551093467213, 15627.609309767347, 10904.672859814218, 13845.723085538435, 14065.789013165015, 14387.136771793726, 14407.0, 13565.0, 13923.58229253124, 13947.790783138058, 14073.155610663393, 14097.647558811112, 13586.116902401312, 13596.388162532907, 13609.52366667162, 14041.1575305482, 14230.928845355707, 11112.499937502671, 11406.17938186331, 11461.52585226261, 11931.761364772483, 11951.641450756491, 10997.945010274898, 11435.313562570618, 11491.195616306779, 11701.356425396345, 11713.355765432641], "value": 7916.980147562068, "unit": "score"}], "name": "dromaeo_css", "value": 7359.647372436493, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 114.0, 115.0, 113.0, 114.0, 114.0, 113.0, 119.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 136.0, 163.0, 108.0, 148.0, 129.0, 109.0, 159.0, 107.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 190.0, 236.0, 184.0, 183.0, 183.0, 184.0, 178.0, 184.0, 214.0], "value": 192.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 98.0, 106.0, 183.0, 57.0, 58.0, 58.0, 60.0, 141.0, 57.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 133.0, 75.0, 100.0, 105.0, 132.0, 68.0, 69.0, 111.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 88.0, 85.0, 87.0, 83.0, 88.0, 85.0, 87.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 150.0, 152.0, 93.0, 102.0, 94.0, 93.0, 93.0, 93.0, 93.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 83.0, 85.0, 83.0, 83.0, 84.0, 85.0, 83.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 55.0, 55.0, 54.0, 53.0, 55.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 74.0, 74.0, 73.0, 71.0, 69.0, 76.0, 104.0, 103.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 102.0, 107.0, 111.0, 89.0, 88.0, 107.0, 109.0, 87.0, 85.0], "value": 97.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 138.0, 138.0, 134.0, 151.0, 158.0, 133.0, 181.0, 139.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 176.0, 181.0, 245.0, 197.0, 174.0, 176.0, 175.0, 180.0], "value": 185.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 65.0, 67.0, 67.0, 66.0, 70.0, 78.0, 86.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1531.5000000000002, "alertThreshold": 2.0}]} 23:07:17 INFO - Return code: 0 23:07:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:07:17 INFO - # TBPL SUCCESS # 23:07:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:07:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:07:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:07:17 INFO - 2016-09-06 23:07:17.900 screenresolution[1670:11961] starting screenresolution argv=screenresolution get 23:07:17 INFO - 2016-09-06 23:07:17.903 screenresolution[1670:11961] Display 0: 1600x1200x32@60 23:07:17 INFO - 2016-09-06 23:07:17.909 screenresolution[1671:11964] starting screenresolution argv=screenresolution list 23:07:17 INFO - Available Modes on Display 0 23:07:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:07:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:07:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:07:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:07:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:07:18 INFO - Intel Iris: 23:07:18 INFO - Chipset Model: Intel Iris 23:07:18 INFO - Type: GPU 23:07:18 INFO - Bus: Built-In 23:07:18 INFO - VRAM (Dynamic, Max): 1536 MB 23:07:18 INFO - Vendor: Intel (0x8086) 23:07:18 INFO - Device ID: 0x0a2e 23:07:18 INFO - Revision ID: 0x0009 23:07:18 INFO - Displays: 23:07:18 INFO - Display: 23:07:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:07:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:07:18 INFO - Display Serial Number: 1600x1200 60 23:07:18 INFO - Main Display: Yes 23:07:18 INFO - Mirror: Off 23:07:18 INFO - Online: Yes 23:07:18 INFO - Rotation: Supported 23:07:18 INFO - Return code: 0 23:07:18 INFO - Running post-action listener: _resource_record_post_action 23:07:18 INFO - [mozharness: 2016-09-07 06:07:18.145891Z] Finished run-tests step (success) 23:07:18 INFO - Running post-run listener: _resource_record_post_run 23:07:18 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 32807936; Write bytes: 705807360; Read time: 340; Write time: 2071 23:07:18 INFO - TinderboxPrint: CPU usage
53.3% 23:07:18 INFO - TinderboxPrint: I/O read bytes / time
32,807,936 / 340 23:07:18 INFO - TinderboxPrint: I/O write bytes / time
705,807,360 / 2,071 23:07:18 INFO - TinderboxPrint: CPU idle
2,265.1 (46.7%) 23:07:18 INFO - TinderboxPrint: CPU system
965.1 (19.9%) 23:07:18 INFO - TinderboxPrint: CPU user
1,619.6 (33.4%) 23:07:18 INFO - TinderboxPrint: Swap in / out
434,249,728 / 0 23:07:18 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396200448; Write bytes: 391475712; Read time: 29801; Write time: 747 23:07:18 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30833664; Write bytes: 295604736; Read time: 318; Write time: 1287 23:07:18 INFO - Running post-run listener: _upload_blobber_files 23:07:18 INFO - Blob upload gear active. 23:07:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:07:18 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 23:07:18 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:07:18 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:07:19 INFO - (blobuploader) - INFO - Open directory for files ... 23:07:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:07:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:07:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:20 INFO - (blobuploader) - INFO - Done attempting. 23:07:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:07:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:07:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:21 INFO - (blobuploader) - INFO - Done attempting. 23:07:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:07:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:23 INFO - (blobuploader) - INFO - Done attempting. 23:07:23 INFO - (blobuploader) - INFO - Iteration through files over. 23:07:23 INFO - Return code: 0 23:07:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:07:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:07:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/368a2dd8cf229710fb9c7615d69c46e9ad6b51e1ee267781de89b09060b547a971cdb47a51d186ec04085a6cc9a690b98c8e1f530b1ba3428203e763d4437043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25735a6ee91d45395b86a42dac89ce744a95af212c758070d4eac8aa8098476f7cdbb0c9e56416107f2b3efc07b8fe461e2c2a7490c324f357eb6593549ac45e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ebaf77b3c76c6d43e4062057c14aeb11d0c9dc4bdc41144191901408ee1407c212f974014834db3a692c205f0c7711f2eb3de478b362f671c10a7577a4997e4"} 23:07:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:07:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:07:23 INFO - Contents: 23:07:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/368a2dd8cf229710fb9c7615d69c46e9ad6b51e1ee267781de89b09060b547a971cdb47a51d186ec04085a6cc9a690b98c8e1f530b1ba3428203e763d4437043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25735a6ee91d45395b86a42dac89ce744a95af212c758070d4eac8aa8098476f7cdbb0c9e56416107f2b3efc07b8fe461e2c2a7490c324f357eb6593549ac45e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ebaf77b3c76c6d43e4062057c14aeb11d0c9dc4bdc41144191901408ee1407c212f974014834db3a692c205f0c7711f2eb3de478b362f671c10a7577a4997e4"} 23:07:23 INFO - Running post-run listener: copy_logs_to_upload_dir 23:07:23 INFO - Copying logs to upload dir... 23:07:23 INFO - mkdir: /builds/slave/test/build/upload/logs 23:07:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.892569 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-06 23:07:23.582107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 23:07:23.585195) ========= 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.FMTy9nCgId/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.qotRqiA3UY/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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/Fx-Team/sha512/368a2dd8cf229710fb9c7615d69c46e9ad6b51e1ee267781de89b09060b547a971cdb47a51d186ec04085a6cc9a690b98c8e1f530b1ba3428203e763d4437043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25735a6ee91d45395b86a42dac89ce744a95af212c758070d4eac8aa8098476f7cdbb0c9e56416107f2b3efc07b8fe461e2c2a7490c324f357eb6593549ac45e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ebaf77b3c76c6d43e4062057c14aeb11d0c9dc4bdc41144191901408ee1407c212f974014834db3a692c205f0c7711f2eb3de478b362f671c10a7577a4997e4"} build_url:https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011100 build_url: 'https://queue.taskcluster.net/v1/task/FtCm2RM1TsekYX8-zNcnGQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/368a2dd8cf229710fb9c7615d69c46e9ad6b51e1ee267781de89b09060b547a971cdb47a51d186ec04085a6cc9a690b98c8e1f530b1ba3428203e763d4437043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25735a6ee91d45395b86a42dac89ce744a95af212c758070d4eac8aa8098476f7cdbb0c9e56416107f2b3efc07b8fe461e2c2a7490c324f357eb6593549ac45e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ebaf77b3c76c6d43e4062057c14aeb11d0c9dc4bdc41144191901408ee1407c212f974014834db3a692c205f0c7711f2eb3de478b362f671c10a7577a4997e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 23:07:23.618732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 23:07:23.619072) ========= 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.FMTy9nCgId/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.qotRqiA3UY/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.005045 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 23:07:23.667655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 23:07:23.667981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 23:07:23.668301) ========= ========= Total master_lag: 0.18 =========