builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0385 starttime: 1473768968.61 results: success (0) buildid: 20160913032907 builduid: b0e72d15b5ab46dcb356103cb2a8c67b revision: f5d043ce6d36a3c461cbd829d4a4a38394b7c436 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:08.613840) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:08.614484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:08.615447) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:08.672846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:08.673165) ========= 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.fZGmPRzmEy/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.HqszsnMHul/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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-13 05:16:08-- 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% 30.0M=0s 2016-09-13 05:16:08 (30.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102387 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:08.801669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:08.802028) ========= 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.fZGmPRzmEy/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.HqszsnMHul/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.025535 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:08.851450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 05:16:08.852202) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5d043ce6d36a3c461cbd829d4a4a38394b7c436 --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 f5d043ce6d36a3c461cbd829d4a4a38394b7c436 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fZGmPRzmEy/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.HqszsnMHul/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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-13 05:16:08,940 truncating revision to first 12 chars 2016-09-13 05:16:08,940 Setting DEBUG logging. 2016-09-13 05:16:08,940 attempt 1/10 2016-09-13 05:16:08,940 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5d043ce6d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 05:16:10,106 unpacking tar archive at: fx-team-f5d043ce6d36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462528 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 05:16:10.339166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:10.339539) ========= script_repo_revision: f5d043ce6d36a3c461cbd829d4a4a38394b7c436 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:10.339988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:10.340321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 05:16:10.359107) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-13 05:16:10.359742) ========= /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.fZGmPRzmEy/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.HqszsnMHul/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16:10 INFO - MultiFileLogger online at 20160913 05:16:10 in /builds/slave/test 05:16: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 05:16:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:10 INFO - {'append_to_log': False, 05:16:10 INFO - 'base_work_dir': '/builds/slave/test', 05:16:10 INFO - 'blob_upload_branch': 'Fx-Team', 05:16:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:10 INFO - 'branch': 'Fx-Team', 05:16:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:10 INFO - 'config_files': ('talos/mac_config.py',), 05:16:10 INFO - 'default_actions': ('clobber', 05:16:10 INFO - 'read-buildbot-config', 05:16:10 INFO - 'download-and-extract', 05:16:10 INFO - 'populate-webroot', 05:16:10 INFO - 'create-virtualenv', 05:16:10 INFO - 'install', 05:16:10 INFO - 'run-tests'), 05:16:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:10 INFO - 'download_minidump_stackwalk': True, 05:16:10 INFO - 'download_symbols': 'ondemand', 05:16:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:10 INFO - 'installer_path': 'installer.exe', 05:16:10 INFO - 'log_level': 'info', 05:16:10 INFO - 'log_name': 'talos', 05:16:10 INFO - 'log_to_console': True, 05:16:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:16:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:16:10 INFO - 'opt_config_files': (), 05:16:10 INFO - 'pip_index': False, 05:16:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:10 INFO - 'cmd': ('bash', 05:16:10 INFO - '-c', 05:16:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:10 INFO - 'enabled': True, 05:16:10 INFO - 'halt_on_failure': False, 05:16:10 INFO - 'name': 'check_screen_resolution'},), 05:16:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:10 INFO - 'cmd': ('bash', 05:16:10 INFO - '-c', 05:16:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:10 INFO - 'enabled': True, 05:16:10 INFO - 'halt_on_failure': False, 05:16:10 INFO - 'name': 'check_screen_resolution'},), 05:16:10 INFO - 'run_cmd_checks_enabled': True, 05:16:10 INFO - 'sps_profile': False, 05:16:10 INFO - 'sps_profile_interval': 0, 05:16:10 INFO - 'suite': 'dromaeojs', 05:16:10 INFO - 'system_bits': '32', 05:16:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:10 INFO - 'title': 't-yosemite-r7-0385', 05:16:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:10 INFO - 'use_talos_json': True, 05:16:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:10 INFO - 'work_dir': 'build'} 05:16:10 INFO - [mozharness: 2016-09-13 12:16:10.558967Z] Running clobber step. 05:16:10 INFO - Running pre-action listener: _resource_record_pre_action 05:16:10 INFO - Running main action method: clobber 05:16:10 INFO - rmtree: /builds/slave/test/build 05:16:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:12 INFO - Running post-action listener: _resource_record_post_action 05:16:12 INFO - [mozharness: 2016-09-13 12:16:12.521630Z] Finished clobber step (success) 05:16:12 INFO - [mozharness: 2016-09-13 12:16:12.521826Z] Running read-buildbot-config step. 05:16:12 INFO - Running pre-action listener: _resource_record_pre_action 05:16:12 INFO - Running main action method: read_buildbot_config 05:16:12 INFO - Using buildbot properties: 05:16:12 INFO - { 05:16:12 INFO - "project": "", 05:16:12 INFO - "product": "firefox", 05:16:12 INFO - "script_repo_revision": "production", 05:16:12 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:16:12 INFO - "repository": "", 05:16:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:16:12 INFO - "buildid": "20160913032907", 05:16:12 INFO - "pgo_build": "False", 05:16:12 INFO - "basedir": "/builds/slave/test", 05:16:12 INFO - "buildnumber": 157, 05:16:12 INFO - "slavename": "t-yosemite-r7-0385", 05:16:12 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:16:12 INFO - "platform": "yosemite_r7", 05:16:12 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:16:12 INFO - "branch": "fx-team", 05:16:12 INFO - "repo_path": "integration/fx-team", 05:16:12 INFO - "revision": "f5d043ce6d36a3c461cbd829d4a4a38394b7c436", 05:16:12 INFO - "stage_platform": "macosx64", 05:16:12 INFO - "builduid": "b0e72d15b5ab46dcb356103cb2a8c67b", 05:16:12 INFO - "slavebuilddir": "test" 05:16:12 INFO - } 05:16:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:16:12 INFO - Running post-action listener: _resource_record_post_action 05:16:12 INFO - [mozharness: 2016-09-13 12:16:12.525888Z] Finished read-buildbot-config step (success) 05:16:12 INFO - [mozharness: 2016-09-13 12:16:12.526009Z] Running download-and-extract step. 05:16:12 INFO - Running pre-action listener: _resource_record_pre_action 05:16:12 INFO - Running main action method: download_and_extract 05:16:12 INFO - mkdir: /builds/slave/test/build/tests 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:12 INFO - trying https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:16:12 INFO - Downloading https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/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 05:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/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 05:16:13 INFO - Downloaded 1199 bytes. 05:16:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:16:13 INFO - Using the following test package requirements: 05:16:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:16:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:16:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:16:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:16:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:16:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:16:13 INFO - u'jsshell-mac.zip'], 05:16:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:16:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:16:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:16:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:16:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:16:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:16:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:16:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:16:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:16:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:16:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:16:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:16:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:16:14 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:16: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 05:16:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:16:21 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:16:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:16:29 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:16: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')]} 05:16:30 INFO - trying https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:16:30 INFO - Downloading https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/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 05:16:33 INFO - Downloaded 111384804 bytes. 05:16:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:16:33 INFO - mkdir: /builds/slave/test/properties 05:16:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:33 INFO - Contents: 05:16:33 INFO - build_url:https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:16:34 INFO - Running post-action listener: _resource_record_post_action 05:16:34 INFO - Running post-action listener: set_extra_try_arguments 05:16:34 INFO - [mozharness: 2016-09-13 12:16:34.010813Z] Finished download-and-extract step (success) 05:16:34 INFO - [mozharness: 2016-09-13 12:16:34.010957Z] Running populate-webroot step. 05:16:34 INFO - Running pre-action listener: _resource_record_pre_action 05:16:34 INFO - Running main action method: populate_webroot 05:16:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:34 INFO - '--tppagecycles', 05:16:34 INFO - '7'], 05:16:34 INFO - 'tests': ['tsvgm']}}, 05:16:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:34 INFO - 'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:34 INFO - 'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['damp', 'tps']}, 05:16:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:34 INFO - 'tests': ['damp', 'tps']}, 05:16:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['dromaeo_dom']}, 05:16:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['basic_compositor_video']}, 05:16:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:16:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['a11yr', 05:16:34 INFO - 'ts_paint', 05:16:34 INFO - 'tpaint', 05:16:34 INFO - 'sessionrestore', 05:16:34 INFO - 'sessionrestore_no_auto_restore', 05:16:34 INFO - 'tabpaint']}, 05:16:34 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:34 INFO - 'ts_paint', 05:16:34 INFO - 'tpaint', 05:16:34 INFO - 'sessionrestore', 05:16:34 INFO - 'sessionrestore_no_auto_restore', 05:16:34 INFO - 'tabpaint']}, 05:16:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:34 INFO - 'ts_paint', 05:16:34 INFO - 'tpaint', 05:16:34 INFO - 'sessionrestore', 05:16:34 INFO - 'sessionrestore_no_auto_restore', 05:16:34 INFO - 'tabpaint']}, 05:16:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:34 INFO - 'ts_paint', 05:16:34 INFO - 'tpaint', 05:16:34 INFO - 'sessionrestore', 05:16:34 INFO - 'sessionrestore_no_auto_restore', 05:16:34 INFO - 'tabpaint']}, 05:16:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['a11yr', 05:16:34 INFO - 'ts_paint', 05:16:34 INFO - 'tpaint', 05:16:34 INFO - 'sessionrestore', 05:16:34 INFO - 'sessionrestore_no_auto_restore', 05:16:34 INFO - 'tabpaint']}, 05:16:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['a11yr', 05:16:34 INFO - 'ts_paint', 05:16:34 INFO - 'tpaint', 05:16:34 INFO - 'sessionrestore', 05:16:34 INFO - 'sessionrestore_no_auto_restore', 05:16:34 INFO - 'tabpaint']}, 05:16:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['tsvgx', 05:16:34 INFO - 'tsvgr_opacity', 05:16:34 INFO - 'tart', 05:16:34 INFO - 'tscrollx', 05:16:34 INFO - 'cart']}, 05:16:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:34 INFO - 'tsvgr_opacity', 05:16:34 INFO - 'tart', 05:16:34 INFO - 'tscrollx', 05:16:34 INFO - 'cart']}, 05:16:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:34 INFO - 'talos_options': ['--disable-e10s'], 05:16:34 INFO - 'tests': ['tp5o']}, 05:16:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:34 INFO - 'tests': ['tp5o']}, 05:16:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:34 INFO - 'talos_options': ['--disable-e10s', 05:16:34 INFO - '--xperf_path', 05:16:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:34 INFO - 'tests': ['tp5n']}, 05:16:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:34 INFO - 'talos_options': ['--xperf_path', 05:16:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:34 INFO - 'tests': ['tp5n']}}, 05:16:34 INFO - 'talos.zip': {'path': '', 05:16:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:34 INFO - Running post-action listener: _resource_record_post_action 05:16:34 INFO - [mozharness: 2016-09-13 12:16:34.029762Z] Finished populate-webroot step (success) 05:16:34 INFO - [mozharness: 2016-09-13 12:16:34.029907Z] Running create-virtualenv step. 05:16:34 INFO - Running pre-action listener: _resource_record_pre_action 05:16:34 INFO - Running main action method: create_virtualenv 05:16:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16: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 05:16:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:34 INFO - Using real prefix '/tools/python27' 05:16:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:37 INFO - Installing pip.................done. 05:16:37 INFO - Return code: 0 05:16:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16: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 05:16: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 05:16:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:16:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:37 INFO - 'HOME': '/Users/cltbld', 05:16:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:37 INFO - 'LOGNAME': 'cltbld', 05:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:37 INFO - 'MOZ_NO_REMOTE': '1', 05:16:37 INFO - 'NO_EM_RESTART': '1', 05:16:37 INFO - 'PAGER': '/bin/cat', 05:16:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:37 INFO - 'PWD': '/builds/slave/test', 05:16:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:37 INFO - 'SHELL': '/bin/bash', 05:16:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:16:37 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:16:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:37 INFO - 'USER': 'cltbld', 05:16:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:37 INFO - 'XPC_FLAGS': '0x0', 05:16:37 INFO - 'XPC_SERVICE_NAME': '0', 05:16:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:37 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 05:16:37 INFO - Cleaning up... 05:16:37 INFO - Return code: 0 05:16:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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', '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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:16: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 psutil>=3.1.1 05:16:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:16:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:37 INFO - 'HOME': '/Users/cltbld', 05:16:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:37 INFO - 'LOGNAME': 'cltbld', 05:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:37 INFO - 'MOZ_NO_REMOTE': '1', 05:16:37 INFO - 'NO_EM_RESTART': '1', 05:16:37 INFO - 'PAGER': '/bin/cat', 05:16:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:37 INFO - 'PWD': '/builds/slave/test', 05:16:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:37 INFO - 'SHELL': '/bin/bash', 05:16:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:16:37 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:16:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:37 INFO - 'USER': 'cltbld', 05:16:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:37 INFO - 'XPC_FLAGS': '0x0', 05:16:37 INFO - 'XPC_SERVICE_NAME': '0', 05:16:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:38 INFO - Downloading/unpacking psutil>=3.1.1 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:40 INFO - Installing collected packages: psutil 05:16:40 INFO - Running setup.py install for psutil 05:16:40 INFO - building 'psutil._psutil_osx' extension 05:16:40 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 05:16: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:16: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:16:41 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 05:16:41 INFO - building 'psutil._psutil_posix' extension 05:16:41 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 05:16:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:16:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:16:41 INFO - ^ 05:16:41 INFO - 1 warning generated. 05:16:41 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 05:16:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:41 INFO - Successfully installed psutil 05:16:41 INFO - Cleaning up... 05:16:41 INFO - Return code: 0 05:16:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:41 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')]} 05:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16: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 05:16: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 05:16:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:16:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:42 INFO - 'HOME': '/Users/cltbld', 05:16:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:42 INFO - 'LOGNAME': 'cltbld', 05:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:42 INFO - 'MOZ_NO_REMOTE': '1', 05:16:42 INFO - 'NO_EM_RESTART': '1', 05:16:42 INFO - 'PAGER': '/bin/cat', 05:16:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:42 INFO - 'PWD': '/builds/slave/test', 05:16:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:42 INFO - 'SHELL': '/bin/bash', 05:16:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:16:42 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:16:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:42 INFO - 'USER': 'cltbld', 05:16:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:42 INFO - 'XPC_FLAGS': '0x0', 05:16:42 INFO - 'XPC_SERVICE_NAME': '0', 05:16:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:16:44 INFO - Installing collected packages: mozsystemmonitor 05:16:44 INFO - Running setup.py install for mozsystemmonitor 05:16:44 INFO - Successfully installed mozsystemmonitor 05:16:44 INFO - Cleaning up... 05:16:45 INFO - Return code: 0 05:16:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16: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 05:16: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 05:16:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:16:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:45 INFO - 'HOME': '/Users/cltbld', 05:16:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:45 INFO - 'LOGNAME': 'cltbld', 05:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:45 INFO - 'MOZ_NO_REMOTE': '1', 05:16:45 INFO - 'NO_EM_RESTART': '1', 05:16:45 INFO - 'PAGER': '/bin/cat', 05:16:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:45 INFO - 'PWD': '/builds/slave/test', 05:16:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:45 INFO - 'SHELL': '/bin/bash', 05:16:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:16:45 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:16:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:45 INFO - 'USER': 'cltbld', 05:16:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:45 INFO - 'XPC_FLAGS': '0x0', 05:16:45 INFO - 'XPC_SERVICE_NAME': '0', 05:16:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:45 INFO - Downloading/unpacking jsonschema==2.5.1 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:16:47 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 05:16:47 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 05:16:47 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 05:16:47 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 05:16:47 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 05:16:47 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 05:16:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:48 INFO - warning: no files found matching '*.txt' 05:16:48 INFO - no previously-included directories found matching 'build' 05:16:48 INFO - no previously-included directories found matching 'dist' 05:16:48 INFO - no previously-included directories found matching '.git*' 05:16:48 INFO - Installing collected packages: jsonschema, functools32 05:16:48 INFO - Running setup.py install for functools32 05:16:48 INFO - warning: no files found matching '*.txt' 05:16:48 INFO - no previously-included directories found matching 'build' 05:16:48 INFO - no previously-included directories found matching 'dist' 05:16:48 INFO - no previously-included directories found matching '.git*' 05:16:48 INFO - Successfully installed jsonschema functools32 05:16:48 INFO - Cleaning up... 05:16:48 INFO - Return code: 0 05:16:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:16:48 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')]} 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 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')]} 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16:48 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 05:16:48 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 05:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:48 INFO - 'HOME': '/Users/cltbld', 05:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:48 INFO - 'LOGNAME': 'cltbld', 05:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:48 INFO - 'MOZ_NO_REMOTE': '1', 05:16:48 INFO - 'NO_EM_RESTART': '1', 05:16:48 INFO - 'PAGER': '/bin/cat', 05:16:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:48 INFO - 'PWD': '/builds/slave/test', 05:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:48 INFO - 'SHELL': '/bin/bash', 05:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:16:48 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:48 INFO - 'USER': 'cltbld', 05:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:48 INFO - 'XPC_FLAGS': '0x0', 05:16:48 INFO - 'XPC_SERVICE_NAME': '0', 05:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:16:49 INFO - Cleaning up... 05:16:49 INFO - Return code: 0 05:16:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16: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 05:16: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 05:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:49 INFO - 'HOME': '/Users/cltbld', 05:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:49 INFO - 'LOGNAME': 'cltbld', 05:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:49 INFO - 'MOZ_NO_REMOTE': '1', 05:16:49 INFO - 'NO_EM_RESTART': '1', 05:16:49 INFO - 'PAGER': '/bin/cat', 05:16:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:49 INFO - 'PWD': '/builds/slave/test', 05:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:49 INFO - 'SHELL': '/bin/bash', 05:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:16:49 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:49 INFO - 'USER': 'cltbld', 05:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:49 INFO - 'XPC_FLAGS': '0x0', 05:16:49 INFO - 'XPC_SERVICE_NAME': '0', 05:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:53 INFO - Downloading docopt-0.6.1.tar.gz 05:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:53 INFO - Running setup.py install for blobuploader 05:16:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:53 INFO - Running setup.py install for requests 05:16:54 INFO - Running setup.py install for docopt 05:16:54 INFO - Successfully installed blobuploader requests docopt 05:16:54 INFO - Cleaning up... 05:16:54 INFO - Return code: 0 05:16:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16: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 05:16: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 05:16:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:16:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:54 INFO - 'HOME': '/Users/cltbld', 05:16:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:54 INFO - 'LOGNAME': 'cltbld', 05:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:54 INFO - 'MOZ_NO_REMOTE': '1', 05:16:54 INFO - 'NO_EM_RESTART': '1', 05:16:54 INFO - 'PAGER': '/bin/cat', 05:16:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:54 INFO - 'PWD': '/builds/slave/test', 05:16:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:54 INFO - 'SHELL': '/bin/bash', 05:16:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:16:54 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:16:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:54 INFO - 'USER': 'cltbld', 05:16:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:54 INFO - 'XPC_FLAGS': '0x0', 05:16:54 INFO - 'XPC_SERVICE_NAME': '0', 05:16:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-7NKciA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Aybtjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:54 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-qH25dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-DP5tMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-N65upQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-TcyMXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-dlIETb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-9FgWZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-SFkoN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-9_f60f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-9LexxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-222N0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-bgEE4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-MXT1Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Z7sMDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-AyNVws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-GTolhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:56 INFO - Running setup.py install for manifestparser 05:16:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for mozcrash 05:16:56 INFO - Running setup.py install for mozdebug 05:16:56 INFO - Running setup.py install for mozdevice 05:16:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozfile 05:16:57 INFO - Running setup.py install for mozhttpd 05:16:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozinfo 05:16:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozInstall 05:16:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozleak 05:16:57 INFO - Running setup.py install for mozlog 05:16:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for moznetwork 05:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozprocess 05:16:58 INFO - Running setup.py install for mozprofile 05:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozrunner 05:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:58 INFO - Running setup.py install for mozscreenshot 05:16:58 INFO - Running setup.py install for moztest 05:16:58 INFO - Running setup.py install for mozversion 05:16:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:59 INFO - Cleaning up... 05:16:59 INFO - Return code: 0 05:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:16: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 05:16: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 05:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:59 INFO - 'HOME': '/Users/cltbld', 05:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:59 INFO - 'LOGNAME': 'cltbld', 05:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:59 INFO - 'MOZ_NO_REMOTE': '1', 05:16:59 INFO - 'NO_EM_RESTART': '1', 05:16:59 INFO - 'PAGER': '/bin/cat', 05:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:59 INFO - 'PWD': '/builds/slave/test', 05:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:59 INFO - 'SHELL': '/bin/bash', 05:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:16:59 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:59 INFO - 'USER': 'cltbld', 05:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:59 INFO - 'XPC_FLAGS': '0x0', 05:16:59 INFO - 'XPC_SERVICE_NAME': '0', 05:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-qfIrtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16: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)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-dC4B3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16: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)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-5oAyge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16: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)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-bF3xlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16: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)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-k65EvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16: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)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-yLJOsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:59 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)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-FIVWBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17: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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-b0zFml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17: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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-l695ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17: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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-1eaq7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17: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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-53BccN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17: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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-8xiI_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17: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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-2wuPse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17: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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-8MFLET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17: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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-8l5jo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:00 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)) 05:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-q5g8By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17: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)) 05:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-LUxqrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:03 INFO - Downloading blessings-1.6.tar.gz 05:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:03 INFO - Installing collected packages: blessings 05:17:03 INFO - Running setup.py install for blessings 05:17:03 INFO - Successfully installed blessings 05:17:03 INFO - Cleaning up... 05:17:03 INFO - Return code: 0 05:17:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:04 INFO - Reading from file tmpfile_stdout 05:17:04 INFO - Current package versions: 05:17:04 INFO - blessings == 1.6 05:17:04 INFO - blobuploader == 1.2.4 05:17:04 INFO - docopt == 0.6.1 05:17:04 INFO - functools32 == 3.2.3-2 05:17:04 INFO - jsonschema == 2.5.1 05:17:04 INFO - manifestparser == 1.1 05:17:04 INFO - mozInstall == 1.12 05:17:04 INFO - mozcrash == 0.17 05:17:04 INFO - mozdebug == 0.1 05:17:04 INFO - mozdevice == 0.48 05:17:04 INFO - mozfile == 1.2 05:17:04 INFO - mozhttpd == 0.7 05:17:04 INFO - mozinfo == 0.9 05:17:04 INFO - mozleak == 0.1 05:17:04 INFO - mozlog == 3.3 05:17:04 INFO - moznetwork == 0.27 05:17:04 INFO - mozprocess == 0.23 05:17:04 INFO - mozprofile == 0.28 05:17:04 INFO - mozrunner == 6.12 05:17:04 INFO - mozscreenshot == 0.1 05:17:04 INFO - mozsystemmonitor == 0.3 05:17:04 INFO - moztest == 0.7 05:17:04 INFO - mozversion == 1.4 05:17:04 INFO - psutil == 3.1.1 05:17:04 INFO - requests == 1.2.3 05:17:04 INFO - wsgiref == 0.1.2 05:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:17: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 05:17: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 05:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:04 INFO - 'HOME': '/Users/cltbld', 05:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PAGER': '/bin/cat', 05:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:17:04 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - 'XPC_FLAGS': '0x0', 05:17:04 INFO - 'XPC_SERVICE_NAME': '0', 05:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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 0x108af0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd2cd1db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, '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.fZGmPRzmEy/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.HqszsnMHul/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 05:17: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 05:17: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 05:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:04 INFO - 'HOME': '/Users/cltbld', 05:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PAGER': '/bin/cat', 05:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:17:04 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - 'XPC_FLAGS': '0x0', 05:17:04 INFO - 'XPC_SERVICE_NAME': '0', 05:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Running post-action listener: _resource_record_post_action 05:17:04 INFO - Running post-action listener: _start_resource_monitoring 05:17:04 INFO - Starting resource monitoring. 05:17:04 INFO - [mozharness: 2016-09-13 12:17:04.665004Z] Finished create-virtualenv step (success) 05:17:04 INFO - [mozharness: 2016-09-13 12:17:04.665987Z] Running install step. 05:17:04 INFO - Running pre-action listener: _resource_record_pre_action 05:17:04 INFO - Running main action method: install 05:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:04 INFO - Reading from file tmpfile_stdout 05:17:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:05 INFO - Reading from file tmpfile_stdout 05:17:05 INFO - Output received: 05:17:05 INFO - Usage: mozinstall [options] installer 05:17:05 INFO - Options: 05:17:05 INFO - -h, --help show this help message and exit 05:17:05 INFO - -d DEST, --destination=DEST 05:17:05 INFO - Directory to install application into. [default: 05:17:05 INFO - "/builds/slave/test"] 05:17:05 INFO - --app=APP Application being installed. [default: firefox] 05:17:05 INFO - mkdir: /builds/slave/test/build/application 05:17: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'] 05:17: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 05:17:39 INFO - Reading from file tmpfile_stdout 05:17:39 INFO - Output received: 05:17:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:17:39 INFO - Running post-action listener: _resource_record_post_action 05:17:39 INFO - [mozharness: 2016-09-13 12:17:39.492169Z] Finished install step (success) 05:17:39 INFO - [mozharness: 2016-09-13 12:17:39.492304Z] Running run-tests step. 05:17:39 INFO - Running pre-action listener: _resource_record_pre_action 05:17:39 INFO - Running main action method: run_tests 05:17:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:39 INFO - 2016-09-13 05:17:39.506 screenresolution[1644:7636] starting screenresolution argv=screenresolution get 05:17:39 INFO - 2016-09-13 05:17:39.509 screenresolution[1644:7636] Display 0: 1600x1200x32@60 05:17:39 INFO - 2016-09-13 05:17:39.515 screenresolution[1645:7638] starting screenresolution argv=screenresolution list 05:17:39 INFO - Available Modes on Display 0 05:17:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:39 INFO - Intel Iris: 05:17:39 INFO - Chipset Model: Intel Iris 05:17:39 INFO - Type: GPU 05:17:39 INFO - Bus: Built-In 05:17:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:39 INFO - Vendor: Intel (0x8086) 05:17:39 INFO - Device ID: 0x0a2e 05:17:39 INFO - Revision ID: 0x0009 05:17:39 INFO - Displays: 05:17:39 INFO - Display: 05:17:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:39 INFO - Display Serial Number: 1600x1200 60 05:17:39 INFO - Main Display: Yes 05:17:39 INFO - Mirror: Off 05:17:39 INFO - Online: Yes 05:17:39 INFO - Rotation: Supported 05:17:39 INFO - Return code: 0 05:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:39 INFO - Python 2.7.3 05:17:39 INFO - Return code: 0 05:17:39 INFO - grabbing minidump binary from tooltool 05:17: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')]} 05:17: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 0x108904d30>, '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 0x10872adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17: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 05:17: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 05:17: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 05:17:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:39 INFO - Return code: 0 05:17:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:17:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:17:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17: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/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--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 05:17: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/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0385 --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 05:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZGmPRzmEy/Render', 05:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:39 INFO - 'HOME': '/Users/cltbld', 05:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:39 INFO - 'LOGNAME': 'cltbld', 05:17:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:39 INFO - 'MOZ_NO_REMOTE': '1', 05:17:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:39 INFO - 'NO_EM_RESTART': '1', 05:17:39 INFO - 'PAGER': '/bin/cat', 05:17:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:39 INFO - 'PWD': '/builds/slave/test', 05:17:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:39 INFO - 'SHELL': '/bin/bash', 05:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqszsnMHul/Listeners', 05:17:39 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 05:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:39 INFO - 'USER': 'cltbld', 05:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:39 INFO - 'XPC_FLAGS': '0x0', 05:17:39 INFO - 'XPC_SERVICE_NAME': '0', 05:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17: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/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--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 05:17:40 INFO - mozversion application_buildid: 20160913032907 05:17:40 INFO - mozversion application_changeset: f5d043ce6d36a3c461cbd829d4a4a38394b7c436 05:17:40 INFO - mozversion application_display_name: Nightly 05:17:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:40 INFO - mozversion application_name: Firefox 05:17:40 INFO - mozversion application_remotingname: firefox 05:17:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:40 INFO - mozversion application_vendor: Mozilla 05:17:40 INFO - mozversion application_version: 51.0a1 05:17:40 INFO - mozversion platform_buildid: 20160913032907 05:17:40 INFO - mozversion platform_changeset: f5d043ce6d36a3c461cbd829d4a4a38394b7c436 05:17:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:40 INFO - mozversion platform_version: 51.0a1 05:17:40 INFO - using testdate: 1473769060 05:17:40 INFO - actual date: 1473769060 05:17:40 INFO - starting webserver on 'localhost:49276' 05:17:40 INFO - SUITE-START | Running 2 tests 05:17:40 INFO - TEST-START | dromaeo_css 05:17:40 INFO - operating with platform_type : mac_ 05:17:40 INFO - Initialising browser for dromaeo_css test... 05:17:40 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpKkQGme/profile http://localhost:49276/getInfo.html) 05:17:42 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 05:17:42 INFO - PROCESS | 1655 | colorDepth:24 05:17:42 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 05:17:42 INFO - PROCESS | 1655 | __metrics 05:17:42 INFO - PROCESS | 1655 | 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" 05:17:42 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:43 INFO - TEST-INFO | 1655: exit 0 05:17:43 INFO - Browser initialized. 05:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:43 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpKkQGme/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:55 INFO - PROCESS | 1657 | RSS: Main: 229462016 05:17:55 INFO - PROCESS | 1657 | 05:18:46 INFO - PROCESS | 1657 | 1473769126590 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] 05:20:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 05:21:00 INFO - PROCESS | 1657 | RSS: Main: 406368256 05:21:00 INFO - PROCESS | 1657 | 05:24:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 05:24:03 INFO - PROCESS | 1657 | RSS: Main: 380973056 05:24:03 INFO - PROCESS | 1657 | 05:27:06 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 05:27:06 INFO - PROCESS | 1657 | RSS: Main: 338001920 05:27:06 INFO - PROCESS | 1657 | 05:30:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 05:30:09 INFO - PROCESS | 1657 | RSS: Main: 326909952 05:30:09 INFO - PROCESS | 1657 | 05:33:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 05:33:13 INFO - PROCESS | 1657 | RSS: Main: 326819840 05:33:13 INFO - PROCESS | 1657 | 05:36:16 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 05:36:16 INFO - PROCESS | 1657 | RSS: Main: 549462016 05:36:16 INFO - PROCESS | 1657 | 05:36:16 INFO - PROCESS | 1657 | __start_tp_report 05:36:16 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 05:36:16 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 05:36:16 INFO - PROCESS | 1657 | |i|pagename|runs| 05:36:16 INFO - PROCESS | 1657 | |0;dojo.html;3335.7331413486922;3381.966180338196;3419.487076938459;3419.9316013679727;3440.19155498458;5702.344230413503;5772.942270577293;5803.593748437611;5899.734511946962;5959.463648271655;5831.562632802546;5849.268841394825;5855.560832937525;5862.149988251701;5876.8236952891375;5238.47615238475;5260.132078207092;5273.920891186616;5316.362036555619;5327.706976116312;5329.546988505982;5336.279602253685;5345.385280692732;5352.946470535284;5356.089464790975;5258.947410525903;5307.708076055816;5312.203169524583;5340.62615616907;5348.946510534904;5354.330708661418;5358.812441564526;5375.5162035417;5377.51602355786;5433.375161856397;5096.872578185538;5208.062548741225;5210.973945130288;5272.630915835893;5281.023010742986;5761.625494342854;5819.883602327972;5832.970835145839;5850.151727999459;5856.795012174553;6190.876182476371;6193.349698281706;6196.535259855529;6198.690065496708;6200.844978875519;5536.4186760390385;6119.988841954239;6146.78486252979;6323;6332.430081292659;5964.522838172936;6028.4272994065495;6038.909416358758;6098.734805259241;6136.7852125175405;6394.392532709385;6404.871902562016;6407.583507072025;6411.647359395278;6445.806625801233;6119.296280927661;6210.875782484325;6215.06773983906;6227.252729672377;6288.402601752826;6235.469985051322;6237.09562113491;6260.342664020303;6266.373362663697;6311.558190926683;6326.145970294044;6340.048992651047;6346.492280617539;6356.713947872357;6367.4906007519285;6295.842603934847;6308.432241098231;6342.873142537216;6350.269718982284;6353.491720662429;4963.6525443218625;5010.64925455222;5020.422651395063;5057.165567681365;5066.82266120684;4483.103379324149;4536.251518499476;4545.136424079415;4553.795079221443;4599.954000460019;5120.436751957282;5858.970705146447;5863.20846685692;5864.912026319608;5923.378045305267;5244.580433565306;6311.842203944938;6328.367163283727;6344.873102538016;6348.365163483615;5688.8862222755315;5717.456841600041;5737.3975732548315;5867.002609556385;5884.852878678067;4674.322223277606;5502.174673798962;5545.750441230154;5588;5620.662760234399;6310.432061114522;6314.336994615683;6359.300476947625;6365.045243213555;6384.138141350951;6303.2436107665535;6309.684515774285;6311.431971122621;6333.303336633059;6344.651044192614;6248.5313601479165;6290.937090629035;6299.559030867796;6321.747130114744;6340.048992651139;5221.399539053057;5245.475452454877;6280.497560195082;6311.779087731908;6334.1765570475545;6304.590201636879;6306.936930630818;6313.463355614824;6341.619502829845;6347.841303967253;5930.140129681258;6030.969845150747;6071.7571297147615;6153.938460615336;6243.750249990131;6095.468565591199;6129.725578588854;6134.650895842656;6155.1075094112;6251.093591429309;6171.290301615371;6186.845328866814;6211.223597050369;6218.129461875251;6228.096925945803;6280;6301.149344838572;6342.23893132827;6343.682815859281;6351.2060992375955;5977.372375900468;6006.759729610942;6032.6983650818165;6076.848078797889;6159.476444502088 05:36:16 INFO - PROCESS | 1657 | |1;ext.html;464.5656311348889;482.1369748150808;502.59792166267;515.8194631878843;541.8756081131653;29408;30621.08136755898;32201.033968980908;39467.40798888012;40705.796471017675;42859.78570107145;43159.78420107895;43233.567664323346;43283.3507497387;43419.565804341946;7379.704811807521;7458.627068646573;7470.813229669247;7470.925290747105;7488.737894173705;8852.203301702846;9047.050059743731;9672.468014259213;11864.644060678194;11984.340861252627;12073.698157546087;12111.697207569792;12151;12160.148789584733;12197.512099516009;12037.93981030098;12114.454849531792;12125.818112728317;12130.636080917586;12132.211406258564;12001.879981200163;12069.93965030178;12074.456649450796;12087.27476351413;12100.81848772269;40298.395524067164;40548.986275343355;40586;40628.59371406278;40640;3537.7346698997676;3591.4253719405033;3902.453656488094;3950.249452603996;3980.5024371953505;30678;31788.046358609277;31839.363212735847;31989.200269993205;32266.354672906644;3129.186411532995;3263.9347213055607;3319.2697606526526;3339.666033396665;3389.796612203276;486548;491657;493949;495516;495675;58426.41573584295;59043.40956590465;59123.704381477815;59149.70425147847;59168;60553.39446605566;60622.090668640005;60654.39345606576;60665.393346066856;60679.69660151671;16235.269412876449;16475.6704865902;16482.093484858447;16496.17519124039;16513.174341282887;11597.536098555964;12753.979681625447;12826.102172847812;12847.293398863152;12852.807207891889;14161.079529830527;14718;15952.361905523649;16344;16378.181090945405;5634.60557760961;6186.783462578788;6281.748730050838;6285.308616052231;6305.716242769086;848.9575521223915;970.9465979371203;1004.2869562610482;1005.8340373838234;1014.7666036811574;21618.783812161993;25825.741742582708;30432;30483.695163048087;30484.695153048186;1000.3797645459716;1049.994750026245;1051.3429106808244;1124.9887501125047;1144.4449442020614;11853.644390668294;14614.269286535631;15318.387264509294;15367.61580960485;15588.454404095803;631281;633624;633952;636995;638225;37928.810355948044;47155.46334024962;49522.50477495251;55776.72111639416;56301;1307.901907356952;1332.7201287729492;1363.1207870923001;1363.3319673359981;1364.2769332253922;26582.335441614116;30383.392332153675;31063.23419145214;31200;31680.524792127675;47992.28011579899;48369.27446088382;48385;48423.75788121037;48439;455925;834057;851832;851972;853226;37596.812015939744;37901.81049094737;37902.62097378991;38507.42238866363;38873.80563097166;45212.32181517214;45349.773251133534;45580.54419455763;45581.316280256484;46210;28137.71862281351;33258.66741332556;36884;37665.62334376621;38547;33740.66259337375;37227.06932326713;37581.06047348838;37685.81157094197;38568.807155965165;36516.45225321569;37276.813615931744;37400.251994959406;37462.31419586071;37587.87236382913;31556.52665209978;33238.00285991424;33577;34207;34270.657293426746;24848.130315438873;25022.62466063047;25194.118205862706;25298.620520691835;25562.744372556037 05:36:16 INFO - PROCESS | 1657 | |2;jquery.html;354.2313180398535;367.4323170701266;377.3076404797197;382.82964080983965;403.62664535304833;15251.466198683049;15254.771178432333;17041.57396065099;20641;20948.03049302363;19806.90096549515;20412;20456.795432045674;20650.86420246886;21446.24938127166;6006.099085137221;6035.185249991239;6213.658248796314;6249.843753906143;6266.342034086424;6018.8495287617725;6211.720472578722;6216.347283535231;6225.097360882669;6236.126942228092;4227.682923780713;4477.015056687524;6558.442532384753;6834.282400347966;6919.827004324882;6746.763863264811;6789.015592739025;6828.453723702141;6921.169459664848;6939.306069393071;5986.401359864022;6006.339302676702;6006.489448396892;6009.188759517453;6009.57932944694;22608.20871269514;25908.481830363286;25968.480630387287;26927.596086058726;27220.455590888072;1940.932067377635;2300.561741995669;2529.620556916459;2670.4792565449743;2865.899693510717;15818.288177032062;15876.52370428889;15978.961367511074;16146;16302.429414970418;1761.3042848074938;1820.708686610136;1826.9360572379903;1847.6858933981255;1890.8392786613153;66685.66657166684;92110;110541.89458105396;126332.73667263302;128695;8648.394612377073;11078.889211107948;11420.714482137846;11491.942540287246;11544.689442856212;14060.85939140616;14076.436942522389;14199.503017394341;14226.644333891736;14273.357698903366;7173.89239161413;8544.829103418022;8587.785305367292;8672.479651220821;8704.474687751344;6987.650617469106;8582.227599516074;8630.439021463584;8820.779480513038;8830.55847207637;6711.899321510181;6842.315768423217;6848.794536163923;6850.246472887979;6850.897236541456;1853.573678054055;1882.538777999399;1890.4045225754119;1892.8391086757504;1894.8105189481216;700.4606453031138;863.6977058029765;873.0396563779918;888.2760550151735;1001.7145113642576;20793.58412831735;21912.780872191393;22852;22867;23210.53578928412;826.7023871406288;934.8737920380662;959.2421986630484;980.9215262778961;993.2004736187439;10723.624673136403;11166.05088567481;11982.281063136239;11987.280763154238;12189.695257618454;468357;473285;473898;606609;611182;137961;146385;147428;147873.26063369613;152261;979.7599588100818;986.2011770465946;1035.7358873487212;1036.9688909332733;1038.1850247555633;19414.514637134183;19734.111964961325;19911.402657920287;19916.103775329855;19925.800741992396;55425.44574554203;56687.71656141693;56860.43139568551;57134.42865571291;57487.712561438595;86431.40705778837;86833.56583217044;87068;87894;88279.55860220658;5937.851553711192;7620.923790762243;8181.140980197231;8192.508449493049;8443.915560844312;10754.462276885968;12590.24458532491;12687.555935542212;12857.935710321388;13092.279924603858;11092.611758588411;11274.943625281821;11284.492197851281;11290.15323850698;11476.311421314747;11041.44792760375;11097.278676886299;11161.609343672932;11424.143189260672;11503.769924601294;9868.506574671093;11361;11422.600208992646;11708.590199342982;11808.114391420506;8145.511269323622;8156.429049966446;8253.79365515867;8267;8309.83380332402;9743.366681165986;11443.542258309908;11449.255798373079;11599.710007249887;11731.061515078944 05:36:17 INFO - PROCESS | 1657 | |3;mootools.html;1372.0464277327262;1402.8597140285972;1526.4581073718832;1686.8060173080091;1848.731933869589;7853.685852565897;8389.993200815903;8667.133286671338;8921.464712117278;8925.55372231389;8768.736937891857;8854.734357969272;8866.645334186642;8867.068957759438;8869.778255543599;2401.903923843044;2426.5268272686835;2426.8301218914685;2434.1358817619757;2434.464417828075;2370.4429459077105;2407.2296865003204;2409.6385542168728;2410.18053861687;2419.4072452249134;2375.679283296759;2392.964105538418;2394.0782798622567;2407.5064611754547;2407.518496300738;2366.491204391047;2378.2389635316704;2387.4747555537665;2389.545986262622;2396.017632770573;2294.621387471065;2363.8936247868887;2373.2405630198346;2373.667686523888;2376.370261880603;7977.242161994601;8193.09875913649;8943.463392196489;9005.50469724165;9026.277897768228;4927.753612319406;5099.286099945974;5114.079465696173;5115.82336062704;5238.633295669305;3648;3652.5799533053773;3698.5746639136305;3727.869524566627;3732.794696291703;985.6895078050392;1008.9848652270222;1757.66604345174;1818.1999920035141;1863.6272745450965;9924;11842.230255033395;11935.343556104412;11940.343281119534;11952.70118247042;4332.241857674894;4657.5575320344515;4700.341952126705;4706.95293047072;4716.669833111718;9235;9252.7686807829;9253;9259.30555208362;9275.072492750805;4394.231009573312;5297.549708274762;5299.12564426873;5311.123664595376;5317.627766056339;4885.926711099336;4923.48303428142;4932.802687892516;4954.331165292711;5008.424031236382;3093.9845300773354;3609.7473176877893;3676.9448458273146;3722.962770372316;3756.9060773480337;1143.7598104398169;1144.8511693479795;1149.3104137517423;1149.5172027748365;1153.140910022039;830.9750707478785;846.2933450568721;889.4440974391006;892.7321803458937;925.8750068740634;5691.4877661010705;5761.88476230473;5958.44453867455;6018.548608854266;6060.545459090586;916.867054277126;921.424109931293;938.7183844846519;942.8255772682076;982.2534873496195;3778.8677396290996;3906.5350493564915;3998.3602623580086;4063.756174629532;4087.3051581230666;10139;10892.346459212473;11042.889571104346;11060.225784195029;11070.169737269736;10415.68752937413;10990.395528245863;10996.615118470816;11001.284916480403;11060.059894909024;7936.928514650448;8332.125126861592;8343.457675251211;8351.415400921876;8352.248297653241;5940.6435613863305;5947.494462970696;6047.183630209865;6117.26592808848;6150.907736383869;9660.75848103803;10233.385996840214;10269.74325641865;10288.639897603547;10291.53688084053;10132.696019119438;10326.483675816029;10345.534450949875;10363.689089327332;10380.584776609154;7413.740519081806;7416.925830741624;7545.622718864144;7590.316871481372;7593.202713714981;8142.959285203536;8322.875156872773;8341.45780524264;8346.207110324509;8348.206920342558;7498.137714162941;7525.2098529653595;7618.8095297618;7651.273129052731;7778.533288002738;7224.349808517259;7276.272372762682;7277.126744790659;7348.669309881175;7349.04462419882;6881.793546193622;6913.827154321182;7008.053912721717;7022.473314501331;7022.473314501331;3875.748076375027;4981.153203955264;4990.575801056951;5001.4998500149695;5059.822906198266;4217.363324802811;5046.798128074983;5148.0476111919415;5184.326037615086;5194.7922083116255 05:36:17 INFO - PROCESS | 1657 | |4;prototype.html;299.98500074996247;306.662671061832;308.57262691172724;313.23882964396506;316.39252634940914;4315.4174186484815;4752.619790416771;5294.788208471661;5362.034833729927;5420.972895135519;5016.241067412927;5181.870453238671;5217.704210147533;5322.840314790553;5334.706591137496;3800.2589495048405;3816.5992570780086;3960.881173564798;4022.7787471689044;4076.7961601919933;3681.6134305897895;3920.901977450558;4038.2635466749284;4069.4332681917526;4102.774347410891;3158.3209609933974;3306.636270010297;3501.73736969727;3838.3282925488065;4051.817668204938;3240.8379581020854;3286.4905939579403;3390.627031026585;3967.9206415871663;3990.960090399117;2824.449232399683;3095.0250671038552;3228.9183123653606;3403.9319213615836;3456.395130852116;4189.664826813878;5081.568066714333;5091.847244582668;5124.4875512448825;5124.92312615311;4082.6527246008745;4231.91536169278;4516.570925762047;4530.3204519322035;4557.361969324297;4610.792514336863;5278.604104692164;5498.80754173606;5499.50504454601;5515.393306736256;2905.4043920996146;3812.923741525182;3828.2964080983975;3843.4811300474357;3890.988343030804;4738.099761045391;5709.371969083398;5734.569907256972;5776.093889016614;5780.682062486603;3388.254583991518;3598.5681718193982;3772.8115643572187;3833;3839.9808000959815;3275.9836200818845;3889.6888248940018;3896.181801821649;3897.7271590988926;3916.412538119248;4529.8641040768825;4538.909221815611;4546.795394207269;4566.74882881438;4571.519990401027;4648.163330600457;5282.603804714662;5586.469285417878;5594.13290939905;5627.634203776742;1107.4352080438873;1125.2348403085816;1326.3103186343048;1328.249539010456;1335.626024713082;785.6386062411241;787.2442455242916;808.6576283369578;810.9133760760609;811.7118422959883;4906.1414252505665;4985.5321615799685;5020.397552293748;5101.770420331094;5223.936545064678;4644.027822193799;4901.926471102936;5007.824726134568;5447.801483673586;5789.739461724233;4370.868873933787;4577.633789296849;4954.355933728592;5055.87360315995;5171.172612382001;2690.6636670416196;2885.350796070867;2962.9259268518026;2965.4958657028355;3003.594514740526;5122.590192784643;5837.532997360201;5849.397018326804;5850.635884366507;5876.647401155944;5447.319085114361;5776.480116789509;5786.681732504752;5824.37902943677;5859.129026776849;4712.704006398268;5831.504322132581;5850.912236316459;5903;5948.970255148696;5632.549396048388;5672.858178545404;5705.144228365778;5724.622472741103;5727.7422515986045;4361.5202327744555;5688.488036076773;5726.198332233407;5735.569832262514;5768.971155144198;4972.403311602631;5937.990541607851;5957.463828255478;5966.06239881676;5966.239959211956;3583.552055993001;3895.5520115187114;3908.8241029154324;3934.8622798201927;3936.606339366155;4792.640551958547;5152.943646552522;5698.347479230976;5743.74153163117;5751.971240143773;4631.976840115778;5571.913476871971;5575.637583557056;5585.748641311069;5590.580706446952;5205.505476979681;5327.493888080626;5573.405153675775;5592.189132575835;5594.1608758686525;5445.863853403696;5460.290162278879;5465.590080744039;5473.644213126134;5512.8147448298805;5265.78936842522;5485.451454854483;5487.804878048652;5539.8892022160135;5554.805581804618;3979.1047014421524;4888.486708895514;5039.445660977363;5113.565346945403;5476.780928762805 05:36:17 INFO - PROCESS | 1657 | |5;yui.html;710.9146902371715;737.5758938610301;740.4779630360596;748.7753673897829;788.2117882117882;14836.184009879453;16200.108994005324;16232.944858584184;16234.83765162351;16302.184890755445;14640.707185856276;14800.259987000634;14802.25988700566;14819.110853348806;14875.628109297246;689.7310049080837;693.5803838677577;697.2713514377488;833.3291700181352;844.4890841041174;851.9105493923141;854.2610641794834;864.0711235421916;865.7705707987388;867.7136544940187;932.2914584915479;932.3426983976315;932.4451951089092;933.1788026536672;933.6032186320821;729.4310437858479;746.5931067568189;920.5121285718579;922.6586163119655;924.1267002682467;662.3310456438983;682.3279070115932;685.5475386245055;685.5783693028801;688.6212583079287;14686.97191196606;14713.779293310608;14727.337269822883;14743.77884331736;14757.483488077865;13616.93191534046;13824.308784560832;14011.64970875726;14043;14464.566063018126;11097.223194376396;12801;12851.614451566467;12999.920568727863;13072.071130227816;3846.230753849213;3889.5138107736534;3899.2396482685886;4031.8992025199314;4065.9796701016603;109089.45455272673;110430.44784776025;111142.88857111406;111243;111738.76522469505;11247.606333778442;11297.548098075986;11511.769764604662;11718.648440546627;11784;19165.904170479058;22772;23576.402601492886;23657.053717851093;23755.7624423757;7786.221377862168;7993.520388776576;8021.157778433298;8134.877976830352;8140.715074972466;4408.977955110204;4462.598366147063;4467;4505.5719706627815;4591.931121033187;3572.428411454207;3662.7069834413182;3663.3222853772136;3693.5567731872347;3695.926081478355;613.0834402568189;615.1541630258395;617.5522746009108;620.5780069552748;625.2497003595703;564.2523656155611;660.9603423794588;662.5196732368994;671.0711899636178;672.4385138409385;9206.677766278148;9309.20871725911;9463.668771592962;9582.329236953487;9722.465264410384;606.3088079589272;645.9063435801877;666.5367569539221;674.5750177388214;681.8568100698809;3664.706823454117;4442.888927776831;4506.954930450654;4594.1730488512385;4661.580457758818;94938;132661;156741.43258567498;163613;164167;134557;141200;141524;142867;144201;75281.62359188279;75308;78675.60662196767;88685.9999999987;115582;8891.777705557413;8910.331725120772;8920.687775927812;8971.865422018544;9056.456612603264;65760;67393.6521269562;67501.64996700137;67598;69090.38195260176;102598;103510.48244758727;103582.48208758907;104195.4790226044;104828.04133607296;11377.601783937522;11624.535018599161;12033.518659253532;12359.752804943671;12485.87514124847;12701.237925724487;12997.870021300045;13151;13727.588172354845;13786.586402407944;11971.700707482383;12088.093392995384;12322.507099715911;12494.437750301076;12710.30093344838;12049.216800907912;12227.082968777555;12290.938545307215;12325.075619328407;12673.746525069631;11862.347570883685;12211.206271592318;12217.144799863925;12484.188527745668;12597.496100155891;7679.347255483346;9235.815283694423;9655.758606034906;9870.901290986998;9874.210063194783;8384.790380240298;8832.779180520281;9785.510724463891;9849.950750246202;9980.700578982642 05:36:17 INFO - PROCESS | 1657 | __end_tp_report 05:36:17 INFO - PROCESS | 1657 | __start_cc_report 05:36:17 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1484 05:36:17 INFO - PROCESS | 1657 | __end_cc_report 05:36:17 INFO - PROCESS | 1657 | __startTimestamp1473770176990__endTimestamp 05:36:17 INFO - PROCESS | 1657 | 05:36:17 INFO - PROCESS | 1657 | ------- Summary: start ------- 05:36:17 INFO - PROCESS | 1657 | Number of tests: 6 05:36:17 INFO - PROCESS | 1657 | 05:36:17 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5815.38 Median:6071.76 stddev:647.01 (10.7%) stddev-sans-first:619.06 05:36:17 INFO - PROCESS | 1657 | Values: 3335.7 3382.0 3419.5 3419.9 3440.2 5702.3 5772.9 5803.6 5899.7 5959.5 5831.6 5849.3 5855.6 5862.1 5876.8 5238.5 5260.1 5273.9 5316.4 5327.7 5329.5 5336.3 5345.4 5352.9 5356.1 5258.9 5307.7 5312.2 5340.6 5348.9 5354.3 5358.8 5375.5 5377.5 5433.4 5096.9 5208.1 5211.0 5272.6 5281.0 5761.6 5819.9 5833.0 5850.2 5856.8 6190.9 6193.3 6196.5 6198.7 6200.8 5536.4 6120.0 6146.8 6323.0 6332.4 5964.5 6028.4 6038.9 6098.7 6136.8 6394.4 6404.9 6407.6 6411.6 6445.8 6119.3 6210.9 6215.1 6227.3 6288.4 6235.5 6237.1 6260.3 6266.4 6311.6 6326.1 6340.0 6346.5 6356.7 6367.5 6295.8 6308.4 6342.9 6350.3 6353.5 4963.7 5010.6 5020.4 5057.2 5066.8 4483.1 4536.3 4545.1 4553.8 4600.0 5120.4 5859.0 5863.2 5864.9 5923.4 5244.6 6311.8 6328.4 6344.9 6348.4 5688.9 5717.5 5737.4 5867.0 5884.9 4674.3 5502.2 5545.8 5588.0 5620.7 6310.4 6314.3 6359.3 6365.0 6384.1 6303.2 6309.7 6311.4 6333.3 6344.7 6248.5 6290.9 6299.6 6321.7 6340.0 5221.4 5245.5 6280.5 6311.8 6334.2 6304.6 6306.9 6313.5 6341.6 6347.8 5930.1 6031.0 6071.8 6153.9 6243.8 6095.5 6129.7 6134.7 6155.1 6251.1 6171.3 6186.8 6211.2 6218.1 6228.1 6280.0 6301.1 6342.2 6343.7 6351.2 5977.4 6006.8 6032.7 6076.8 6159.5 05:36:17 INFO - PROCESS | 1657 | 05:36:17 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:75102.28 Median:37251.94 stddev:174450.09 (468.3%) stddev-sans-first:174849.46 05:36:17 INFO - PROCESS | 1657 | Values: 464.6 482.1 502.6 515.8 541.9 29408.0 30621.1 32201.0 39467.4 40705.8 42859.8 43159.8 43233.6 43283.4 43419.6 7379.7 7458.6 7470.8 7470.9 7488.7 8852.2 9047.1 9672.5 11864.6 11984.3 12073.7 12111.7 12151.0 12160.1 12197.5 12037.9 12114.5 12125.8 12130.6 12132.2 12001.9 12069.9 12074.5 12087.3 12100.8 40298.4 40549.0 40586.0 40628.6 40640.0 3537.7 3591.4 3902.5 3950.2 3980.5 30678.0 31788.0 31839.4 31989.2 32266.4 3129.2 3263.9 3319.3 3339.7 3389.8 486548.0 491657.0 493949.0 495516.0 495675.0 58426.4 59043.4 59123.7 59149.7 59168.0 60553.4 60622.1 60654.4 60665.4 60679.7 16235.3 16475.7 16482.1 16496.2 16513.2 11597.5 12754.0 12826.1 12847.3 12852.8 14161.1 14718.0 15952.4 16344.0 16378.2 5634.6 6186.8 6281.7 6285.3 6305.7 849.0 970.9 1004.3 1005.8 1014.8 21618.8 25825.7 30432.0 30483.7 30484.7 1000.4 1050.0 1051.3 1125.0 1144.4 11853.6 14614.3 15318.4 15367.6 15588.5 631281.0 633624.0 633952.0 636995.0 638225.0 37928.8 47155.5 49522.5 55776.7 56301.0 1307.9 1332.7 1363.1 1363.3 1364.3 26582.3 30383.4 31063.2 31200.0 31680.5 47992.3 48369.3 48385.0 48423.8 48439.0 455925.0 834057.0 851832.0 851972.0 853226.0 37596.8 37901.8 37902.6 38507.4 38873.8 45212.3 45349.8 45580.5 45581.3 46210.0 28137.7 33258.7 36884.0 37665.6 38547.0 33740.7 37227.1 37581.1 37685.8 38568.8 36516.5 37276.8 37400.3 37462.3 37587.9 31556.5 33238.0 33577.0 34207.0 34270.7 24848.1 25022.6 25194.1 25298.6 25562.7 05:36:17 INFO - PROCESS | 1657 | 05:36:17 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:33831.59 Median:14799.04 stddev:89802.39 (606.8%) stddev-sans-first:90019.13 05:36:17 INFO - PROCESS | 1657 | Values: 354.2 367.4 377.3 382.8 403.6 15251.5 15254.8 17041.6 20641.0 20948.0 19806.9 20412.0 20456.8 20650.9 21446.2 6006.1 6035.2 6213.7 6249.8 6266.3 6018.8 6211.7 6216.3 6225.1 6236.1 4227.7 4477.0 6558.4 6834.3 6919.8 6746.8 6789.0 6828.5 6921.2 6939.3 5986.4 6006.3 6006.5 6009.2 6009.6 22608.2 25908.5 25968.5 26927.6 27220.5 1940.9 2300.6 2529.6 2670.5 2865.9 15818.3 15876.5 15979.0 16146.0 16302.4 1761.3 1820.7 1826.9 1847.7 1890.8 66685.7 92110.0 110541.9 126332.7 128695.0 8648.4 11078.9 11420.7 11491.9 11544.7 14060.9 14076.4 14199.5 14226.6 14273.4 7173.9 8544.8 8587.8 8672.5 8704.5 6987.7 8582.2 8630.4 8820.8 8830.6 6711.9 6842.3 6848.8 6850.2 6850.9 1853.6 1882.5 1890.4 1892.8 1894.8 700.5 863.7 873.0 888.3 1001.7 20793.6 21912.8 22852.0 22867.0 23210.5 826.7 934.9 959.2 980.9 993.2 10723.6 11166.1 11982.3 11987.3 12189.7 468357.0 473285.0 473898.0 606609.0 611182.0 137961.0 146385.0 147428.0 147873.3 152261.0 979.8 986.2 1035.7 1037.0 1038.2 19414.5 19734.1 19911.4 19916.1 19925.8 55425.4 56687.7 56860.4 57134.4 57487.7 86431.4 86833.6 87068.0 87894.0 88279.6 5937.9 7620.9 8181.1 8192.5 8443.9 10754.5 12590.2 12687.6 12857.9 13092.3 11092.6 11274.9 11284.5 11290.2 11476.3 11041.4 11097.3 11161.6 11424.1 11503.8 9868.5 11361.0 11422.6 11708.6 11808.1 8145.5 8156.4 8253.8 8267.0 8309.8 9743.4 11443.5 11449.3 11599.7 11731.1 05:36:17 INFO - PROCESS | 1657 | 05:36:17 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5711.87 Median:4985.86 stddev:3196.50 (64.1%) stddev-sans-first:3188.82 05:36:17 INFO - PROCESS | 1657 | Values: 1372.0 1402.9 1526.5 1686.8 1848.7 7853.7 8390.0 8667.1 8921.5 8925.6 8768.7 8854.7 8866.6 8867.1 8869.8 2401.9 2426.5 2426.8 2434.1 2434.5 2370.4 2407.2 2409.6 2410.2 2419.4 2375.7 2393.0 2394.1 2407.5 2407.5 2366.5 2378.2 2387.5 2389.5 2396.0 2294.6 2363.9 2373.2 2373.7 2376.4 7977.2 8193.1 8943.5 9005.5 9026.3 4927.8 5099.3 5114.1 5115.8 5238.6 3648.0 3652.6 3698.6 3727.9 3732.8 985.7 1009.0 1757.7 1818.2 1863.6 9924.0 11842.2 11935.3 11940.3 11952.7 4332.2 4657.6 4700.3 4707.0 4716.7 9235.0 9252.8 9253.0 9259.3 9275.1 4394.2 5297.5 5299.1 5311.1 5317.6 4885.9 4923.5 4932.8 4954.3 5008.4 3094.0 3609.7 3676.9 3723.0 3756.9 1143.8 1144.9 1149.3 1149.5 1153.1 831.0 846.3 889.4 892.7 925.9 5691.5 5761.9 5958.4 6018.5 6060.5 916.9 921.4 938.7 942.8 982.3 3778.9 3906.5 3998.4 4063.8 4087.3 10139.0 10892.3 11042.9 11060.2 11070.2 10415.7 10990.4 10996.6 11001.3 11060.1 7936.9 8332.1 8343.5 8351.4 8352.2 5940.6 5947.5 6047.2 6117.3 6150.9 9660.8 10233.4 10269.7 10288.6 10291.5 10132.7 10326.5 10345.5 10363.7 10380.6 7413.7 7416.9 7545.6 7590.3 7593.2 8143.0 8322.9 8341.5 8346.2 8348.2 7498.1 7525.2 7618.8 7651.3 7778.5 7224.3 7276.3 7277.1 7348.7 7349.0 6881.8 6913.8 7008.1 7022.5 7022.5 3875.7 4981.2 4990.6 5001.5 5059.8 4217.4 5046.8 5148.0 5184.3 5194.8 05:36:17 INFO - PROCESS | 1657 | 05:36:17 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4441.70 Median:5012.03 stddev:1405.52 (28.0%) stddev-sans-first:1374.66 05:36:17 INFO - PROCESS | 1657 | Values: 300.0 306.7 308.6 313.2 316.4 4315.4 4752.6 5294.8 5362.0 5421.0 5016.2 5181.9 5217.7 5322.8 5334.7 3800.3 3816.6 3960.9 4022.8 4076.8 3681.6 3920.9 4038.3 4069.4 4102.8 3158.3 3306.6 3501.7 3838.3 4051.8 3240.8 3286.5 3390.6 3967.9 3991.0 2824.4 3095.0 3228.9 3403.9 3456.4 4189.7 5081.6 5091.8 5124.5 5124.9 4082.7 4231.9 4516.6 4530.3 4557.4 4610.8 5278.6 5498.8 5499.5 5515.4 2905.4 3812.9 3828.3 3843.5 3891.0 4738.1 5709.4 5734.6 5776.1 5780.7 3388.3 3598.6 3772.8 3833.0 3840.0 3276.0 3889.7 3896.2 3897.7 3916.4 4529.9 4538.9 4546.8 4566.7 4571.5 4648.2 5282.6 5586.5 5594.1 5627.6 1107.4 1125.2 1326.3 1328.2 1335.6 785.6 787.2 808.7 810.9 811.7 4906.1 4985.5 5020.4 5101.8 5223.9 4644.0 4901.9 5007.8 5447.8 5789.7 4370.9 4577.6 4954.4 5055.9 5171.2 2690.7 2885.4 2962.9 2965.5 3003.6 5122.6 5837.5 5849.4 5850.6 5876.6 5447.3 5776.5 5786.7 5824.4 5859.1 4712.7 5831.5 5850.9 5903.0 5949.0 5632.5 5672.9 5705.1 5724.6 5727.7 4361.5 5688.5 5726.2 5735.6 5769.0 4972.4 5938.0 5957.5 5966.1 5966.2 3583.6 3895.6 3908.8 3934.9 3936.6 4792.6 5152.9 5698.3 5743.7 5752.0 4632.0 5571.9 5575.6 5585.7 5590.6 5205.5 5327.5 5573.4 5592.2 5594.2 5445.9 5460.3 5465.6 5473.6 5512.8 5265.8 5485.5 5487.8 5539.9 5554.8 3979.1 4888.5 5039.4 5113.6 5476.8 05:36:17 INFO - PROCESS | 1657 | 05:36:17 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24680.03 Median:4237.48 stddev:39966.11 (943.2%) stddev-sans-first:40037.71 05:36:17 INFO - PROCESS | 1657 | Values: 710.9 737.6 740.5 748.8 788.2 14836.2 16200.1 16232.9 16234.8 16302.2 14640.7 14800.3 14802.3 14819.1 14875.6 689.7 693.6 697.3 833.3 844.5 851.9 854.3 864.1 865.8 867.7 932.3 932.3 932.4 933.2 933.6 729.4 746.6 920.5 922.7 924.1 662.3 682.3 685.5 685.6 688.6 14687.0 14713.8 14727.3 14743.8 14757.5 13616.9 13824.3 14011.6 14043.0 14464.6 11097.2 12801.0 12851.6 12999.9 13072.1 3846.2 3889.5 3899.2 4031.9 4066.0 109089.5 110430.4 111142.9 111243.0 111738.8 11247.6 11297.5 11511.8 11718.6 11784.0 19165.9 22772.0 23576.4 23657.1 23755.8 7786.2 7993.5 8021.2 8134.9 8140.7 4409.0 4462.6 4467.0 4505.6 4591.9 3572.4 3662.7 3663.3 3693.6 3695.9 613.1 615.2 617.6 620.6 625.2 564.3 661.0 662.5 671.1 672.4 9206.7 9309.2 9463.7 9582.3 9722.5 606.3 645.9 666.5 674.6 681.9 3664.7 4442.9 4507.0 4594.2 4661.6 94938.0 132661.0 156741.4 163613.0 164167.0 134557.0 141200.0 141524.0 142867.0 144201.0 75281.6 75308.0 78675.6 88686.0 115582.0 8891.8 8910.3 8920.7 8971.9 9056.5 65760.0 67393.7 67501.6 67598.0 69090.4 102598.0 103510.5 103582.5 104195.5 104828.0 11377.6 11624.5 12033.5 12359.8 12485.9 12701.2 12997.9 13151.0 13727.6 13786.6 11971.7 12088.1 12322.5 12494.4 12710.3 12049.2 12227.1 12290.9 12325.1 12673.7 11862.3 12211.2 12217.1 12484.2 12597.5 7679.3 9235.8 9655.8 9870.9 9874.2 8384.8 8832.8 9785.5 9850.0 9980.7 05:36:17 INFO - PROCESS | 1657 | -------- Summary: end -------- 05:36:17 INFO - PROCESS | 1657 | 05:36:17 INFO - TEST-INFO | 1657: exit 0 05:36:17 INFO - TEST-OK | dromaeo_css | took 1117527ms 05:36:17 INFO - TEST-START | kraken 05:36:17 INFO - operating with platform_type : mac_ 05:36:17 INFO - Initialising browser for kraken test... 05:36:17 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpkmIN7j/profile http://localhost:49276/getInfo.html) 05:36:19 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 05:36:19 INFO - PROCESS | 1664 | colorDepth:24 05:36:19 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 05:36:19 INFO - PROCESS | 1664 | __metrics 05:36:19 INFO - PROCESS | 1664 | 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" 05:36:19 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:20 INFO - TEST-INFO | 1664: exit 0 05:36:20 INFO - Browser initialized. 05:36:20 INFO - Running cycle 1/1 for kraken test... 05:36:20 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpkmIN7j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:32 INFO - PROCESS | 1665 | RSS: Main: 229556224 05:36:32 INFO - PROCESS | 1665 | 05:36:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:36 INFO - PROCESS | 1665 | RSS: Main: 291315712 05:36:36 INFO - PROCESS | 1665 | 05:36:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 05:36:39 INFO - PROCESS | 1665 | RSS: Main: 291434496 05:36:39 INFO - PROCESS | 1665 | 05:36:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 05:36:43 INFO - PROCESS | 1665 | RSS: Main: 382865408 05:36:43 INFO - PROCESS | 1665 | 05:36:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 05:36:45 INFO - PROCESS | 1665 | RSS: Main: 283107328 05:36:45 INFO - PROCESS | 1665 | 05:36:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:48 INFO - PROCESS | 1665 | RSS: Main: 287834112 05:36:48 INFO - PROCESS | 1665 | 05:36:51 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:51 INFO - PROCESS | 1665 | RSS: Main: 323829760 05:36:51 INFO - PROCESS | 1665 | 05:36:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:55 INFO - PROCESS | 1665 | RSS: Main: 327319552 05:36:55 INFO - PROCESS | 1665 | 05:36:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 05:36:58 INFO - PROCESS | 1665 | RSS: Main: 322318336 05:36:58 INFO - PROCESS | 1665 | 05:37:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:01 INFO - PROCESS | 1665 | RSS: Main: 302235648 05:37:01 INFO - PROCESS | 1665 | 05:37:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:03 INFO - PROCESS | 1665 | RSS: Main: 305475584 05:37:03 INFO - PROCESS | 1665 | 05:37:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:06 INFO - PROCESS | 1665 | RSS: Main: 303562752 05:37:06 INFO - PROCESS | 1665 | 05:37:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:10 INFO - PROCESS | 1665 | RSS: Main: 321290240 05:37:10 INFO - PROCESS | 1665 | 05:37:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:13 INFO - PROCESS | 1665 | RSS: Main: 317542400 05:37:13 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 05:37:15 INFO - PROCESS | 1665 | RSS: Main: 361177088 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | __start_tp_report 05:37:15 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 05:37:15 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 05:37:15 INFO - PROCESS | 1665 | |i|pagename|runs| 05:37:15 INFO - PROCESS | 1665 | |0;ai-astar;105;112;113;112;112;113;112;113;111;112 05:37:15 INFO - PROCESS | 1665 | |1;audio-beat-detection;158;111;111;147;106;113;140;120;139;108 05:37:15 INFO - PROCESS | 1665 | |2;audio-dft;183;183;182;184;182;181;179;183;180;182 05:37:15 INFO - PROCESS | 1665 | |3;audio-fft;82;59;57;87;64;58;57;57;81;54 05:37:15 INFO - PROCESS | 1665 | |4;audio-oscillator;85;71;93;71;69;68;92;68;69;93 05:37:15 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;88;85;89;86;88;84;88;86;88;85 05:37:15 INFO - PROCESS | 1665 | |6;imaging-darkroom;94;94;95;93;93;93;94;95;95;94 05:37:15 INFO - PROCESS | 1665 | |7;imaging-desaturate;86;84;86;84;86;84;85;103;139;136 05:37:15 INFO - PROCESS | 1665 | |8;json-parse-financial;58;53;52;52;55;73;82;82;54;54 05:37:15 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;65;76;78;76;71;70;69;71;69;70 05:37:15 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;86;87;86;85;87;83;84;84;83;87 05:37:15 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;137;137;138;168;151;146;134;136;195;152 05:37:15 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;168;166;169;167;166;187;169;167;168;168 05:37:15 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;68;67;67;68;68;71;83;86;86 05:37:15 INFO - PROCESS | 1665 | __end_tp_report 05:37:15 INFO - PROCESS | 1665 | __start_cc_report 05:37:15 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1960 05:37:15 INFO - PROCESS | 1665 | __end_cc_report 05:37:15 INFO - PROCESS | 1665 | __startTimestamp1473770235737__endTimestamp 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | ------- Summary: start ------- 05:37:15 INFO - PROCESS | 1665 | Number of tests: 14 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.37 (2.1%) stddev-sans-first:0.67 05:37:15 INFO - PROCESS | 1665 | Values: 105.0 112.0 113.0 112.0 112.0 113.0 112.0 113.0 111.0 112.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:129.50 stddev:18.87 (14.6%) stddev-sans-first:15.87 05:37:15 INFO - PROCESS | 1665 | Values: 158.0 111.0 111.0 147.0 106.0 113.0 140.0 120.0 139.0 108.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:181.90 Median:182.50 stddev:1.52 (0.8%) stddev-sans-first:1.56 05:37:15 INFO - PROCESS | 1665 | Values: 183.0 183.0 182.0 184.0 182.0 181.0 179.0 183.0 180.0 182.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:65.60 Median:61.50 stddev:12.58 (20.5%) stddev-sans-first:11.86 05:37:15 INFO - PROCESS | 1665 | Values: 82.0 59.0 57.0 87.0 64.0 58.0 57.0 57.0 81.0 54.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:11.33 (14.5%) stddev-sans-first:11.72 05:37:15 INFO - PROCESS | 1665 | Values: 85.0 71.0 93.0 71.0 69.0 68.0 92.0 68.0 69.0 93.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:1.70 (1.9%) stddev-sans-first:1.74 05:37:15 INFO - PROCESS | 1665 | Values: 88.0 85.0 89.0 86.0 88.0 84.0 88.0 86.0 88.0 85.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 05:37:15 INFO - PROCESS | 1665 | Values: 94.0 94.0 95.0 93.0 93.0 93.0 94.0 95.0 95.0 94.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:84.50 stddev:21.94 (26.0%) stddev-sans-first:22.89 05:37:15 INFO - PROCESS | 1665 | Values: 86.0 84.0 86.0 84.0 86.0 84.0 85.0 103.0 139.0 136.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:56.50 stddev:12.44 (22.0%) stddev-sans-first:13.13 05:37:15 INFO - PROCESS | 1665 | Values: 58.0 53.0 52.0 52.0 55.0 73.0 82.0 82.0 54.0 54.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:3.98 (5.6%) stddev-sans-first:3.46 05:37:15 INFO - PROCESS | 1665 | Values: 65.0 76.0 78.0 76.0 71.0 70.0 69.0 71.0 69.0 70.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:1.62 (1.9%) stddev-sans-first:1.69 05:37:15 INFO - PROCESS | 1665 | Values: 86.0 87.0 86.0 85.0 87.0 83.0 84.0 84.0 83.0 87.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:148.50 stddev:19.15 (12.9%) stddev-sans-first:19.78 05:37:15 INFO - PROCESS | 1665 | Values: 137.0 137.0 138.0 168.0 151.0 146.0 134.0 136.0 195.0 152.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:168.00 stddev:6.24 (3.7%) stddev-sans-first:6.60 05:37:15 INFO - PROCESS | 1665 | Values: 168.0 166.0 169.0 167.0 166.0 187.0 169.0 167.0 168.0 168.0 05:37:15 INFO - PROCESS | 1665 | 05:37:15 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:69.50 stddev:8.33 (12.0%) stddev-sans-first:8.54 05:37:15 INFO - PROCESS | 1665 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 71.0 83.0 86.0 86.0 05:37:15 INFO - PROCESS | 1665 | -------- Summary: end -------- 05:37:15 INFO - PROCESS | 1665 | 05:37:16 INFO - TEST-INFO | 1665: exit 0 05:37:16 INFO - TEST-OK | kraken | took 58954ms 05:37:16 INFO - SUITE-END | took 1176s 05:37:16 INFO - Completed test suite (00:19:36) 05:37:16 INFO - javascript benchmark 05:37:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.7331413486922, 3381.966180338196, 3419.487076938459, 3419.9316013679727, 3440.19155498458, 5702.344230413503, 5772.942270577293, 5803.593748437611, 5899.734511946962, 5959.463648271655, 5831.562632802546, 5849.268841394825, 5855.560832937525, 5862.149988251701, 5876.8236952891375, 5238.47615238475, 5260.132078207092, 5273.920891186616, 5316.362036555619, 5327.706976116312, 5329.546988505982, 5336.279602253685, 5345.385280692732, 5352.946470535284, 5356.089464790975, 5258.947410525903, 5307.708076055816, 5312.203169524583, 5340.62615616907, 5348.946510534904, 5354.330708661418, 5358.812441564526, 5375.5162035417, 5377.51602355786, 5433.375161856397, 5096.872578185538, 5208.062548741225, 5210.973945130288, 5272.630915835893, 5281.023010742986, 5761.625494342854, 5819.883602327972, 5832.970835145839, 5850.151727999459, 5856.795012174553, 6190.876182476371, 6193.349698281706, 6196.535259855529, 6198.690065496708, 6200.844978875519, 5536.4186760390385, 6119.988841954239, 6146.78486252979, 6323.0, 6332.430081292659, 5964.522838172936, 6028.4272994065495, 6038.909416358758, 6098.734805259241, 6136.7852125175405, 6394.392532709385, 6404.871902562016, 6407.583507072025, 6411.647359395278, 6445.806625801233, 6119.296280927661, 6210.875782484325, 6215.06773983906, 6227.252729672377, 6288.402601752826, 6235.469985051322, 6237.09562113491, 6260.342664020303, 6266.373362663697, 6311.558190926683, 6326.145970294044, 6340.048992651047, 6346.492280617539, 6356.713947872357, 6367.4906007519285, 6295.842603934847, 6308.432241098231, 6342.873142537216, 6350.269718982284, 6353.491720662429, 4963.6525443218625, 5010.64925455222, 5020.422651395063, 5057.165567681365, 5066.82266120684, 4483.103379324149, 4536.251518499476, 4545.136424079415, 4553.795079221443, 4599.954000460019, 5120.436751957282, 5858.970705146447, 5863.20846685692, 5864.912026319608, 5923.378045305267, 5244.580433565306, 6311.842203944938, 6328.367163283727, 6344.873102538016, 6348.365163483615, 5688.8862222755315, 5717.456841600041, 5737.3975732548315, 5867.002609556385, 5884.852878678067, 4674.322223277606, 5502.174673798962, 5545.750441230154, 5588.0, 5620.662760234399, 6310.432061114522, 6314.336994615683, 6359.300476947625, 6365.045243213555, 6384.138141350951, 6303.2436107665535, 6309.684515774285, 6311.431971122621, 6333.303336633059, 6344.651044192614, 6248.5313601479165, 6290.937090629035, 6299.559030867796, 6321.747130114744, 6340.048992651139, 5221.399539053057, 5245.475452454877, 6280.497560195082, 6311.779087731908, 6334.1765570475545, 6304.590201636879, 6306.936930630818, 6313.463355614824, 6341.619502829845, 6347.841303967253, 5930.140129681258, 6030.969845150747, 6071.7571297147615, 6153.938460615336, 6243.750249990131, 6095.468565591199, 6129.725578588854, 6134.650895842656, 6155.1075094112, 6251.093591429309, 6171.290301615371, 6186.845328866814, 6211.223597050369, 6218.129461875251, 6228.096925945803, 6280.0, 6301.149344838572, 6342.23893132827, 6343.682815859281, 6351.2060992375955, 5977.372375900468, 6006.759729610942, 6032.6983650818165, 6076.848078797889, 6159.476444502088], "value": 5775.0100870835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.5656311348889, 482.1369748150808, 502.59792166267, 515.8194631878843, 541.8756081131653, 29408.0, 30621.08136755898, 32201.033968980908, 39467.40798888012, 40705.796471017675, 42859.78570107145, 43159.78420107895, 43233.567664323346, 43283.3507497387, 43419.565804341946, 7379.704811807521, 7458.627068646573, 7470.813229669247, 7470.925290747105, 7488.737894173705, 8852.203301702846, 9047.050059743731, 9672.468014259213, 11864.644060678194, 11984.340861252627, 12073.698157546087, 12111.697207569792, 12151.0, 12160.148789584733, 12197.512099516009, 12037.93981030098, 12114.454849531792, 12125.818112728317, 12130.636080917586, 12132.211406258564, 12001.879981200163, 12069.93965030178, 12074.456649450796, 12087.27476351413, 12100.81848772269, 40298.395524067164, 40548.986275343355, 40586.0, 40628.59371406278, 40640.0, 3537.7346698997676, 3591.4253719405033, 3902.453656488094, 3950.249452603996, 3980.5024371953505, 30678.0, 31788.046358609277, 31839.363212735847, 31989.200269993205, 32266.354672906644, 3129.186411532995, 3263.9347213055607, 3319.2697606526526, 3339.666033396665, 3389.796612203276, 486548.0, 491657.0, 493949.0, 495516.0, 495675.0, 58426.41573584295, 59043.40956590465, 59123.704381477815, 59149.70425147847, 59168.0, 60553.39446605566, 60622.090668640005, 60654.39345606576, 60665.393346066856, 60679.69660151671, 16235.269412876449, 16475.6704865902, 16482.093484858447, 16496.17519124039, 16513.174341282887, 11597.536098555964, 12753.979681625447, 12826.102172847812, 12847.293398863152, 12852.807207891889, 14161.079529830527, 14718.0, 15952.361905523649, 16344.0, 16378.181090945405, 5634.60557760961, 6186.783462578788, 6281.748730050838, 6285.308616052231, 6305.716242769086, 848.9575521223915, 970.9465979371203, 1004.2869562610482, 1005.8340373838234, 1014.7666036811574, 21618.783812161993, 25825.741742582708, 30432.0, 30483.695163048087, 30484.695153048186, 1000.3797645459716, 1049.994750026245, 1051.3429106808244, 1124.9887501125047, 1144.4449442020614, 11853.644390668294, 14614.269286535631, 15318.387264509294, 15367.61580960485, 15588.454404095803, 631281.0, 633624.0, 633952.0, 636995.0, 638225.0, 37928.810355948044, 47155.46334024962, 49522.50477495251, 55776.72111639416, 56301.0, 1307.901907356952, 1332.7201287729492, 1363.1207870923001, 1363.3319673359981, 1364.2769332253922, 26582.335441614116, 30383.392332153675, 31063.23419145214, 31200.0, 31680.524792127675, 47992.28011579899, 48369.27446088382, 48385.0, 48423.75788121037, 48439.0, 455925.0, 834057.0, 851832.0, 851972.0, 853226.0, 37596.812015939744, 37901.81049094737, 37902.62097378991, 38507.42238866363, 38873.80563097166, 45212.32181517214, 45349.773251133534, 45580.54419455763, 45581.316280256484, 46210.0, 28137.71862281351, 33258.66741332556, 36884.0, 37665.62334376621, 38547.0, 33740.66259337375, 37227.06932326713, 37581.06047348838, 37685.81157094197, 38568.807155965165, 36516.45225321569, 37276.813615931744, 37400.251994959406, 37462.31419586071, 37587.87236382913, 31556.52665209978, 33238.00285991424, 33577.0, 34207.0, 34270.657293426746, 24848.130315438873, 25022.62466063047, 25194.118205862706, 25298.620520691835, 25562.744372556037], "value": 20079.587276770908, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2313180398535, 367.4323170701266, 377.3076404797197, 382.82964080983965, 403.62664535304833, 15251.466198683049, 15254.771178432333, 17041.57396065099, 20641.0, 20948.03049302363, 19806.90096549515, 20412.0, 20456.795432045674, 20650.86420246886, 21446.24938127166, 6006.099085137221, 6035.185249991239, 6213.658248796314, 6249.843753906143, 6266.342034086424, 6018.8495287617725, 6211.720472578722, 6216.347283535231, 6225.097360882669, 6236.126942228092, 4227.682923780713, 4477.015056687524, 6558.442532384753, 6834.282400347966, 6919.827004324882, 6746.763863264811, 6789.015592739025, 6828.453723702141, 6921.169459664848, 6939.306069393071, 5986.401359864022, 6006.339302676702, 6006.489448396892, 6009.188759517453, 6009.57932944694, 22608.20871269514, 25908.481830363286, 25968.480630387287, 26927.596086058726, 27220.455590888072, 1940.932067377635, 2300.561741995669, 2529.620556916459, 2670.4792565449743, 2865.899693510717, 15818.288177032062, 15876.52370428889, 15978.961367511074, 16146.0, 16302.429414970418, 1761.3042848074938, 1820.708686610136, 1826.9360572379903, 1847.6858933981255, 1890.8392786613153, 66685.66657166684, 92110.0, 110541.89458105396, 126332.73667263302, 128695.0, 8648.394612377073, 11078.889211107948, 11420.714482137846, 11491.942540287246, 11544.689442856212, 14060.85939140616, 14076.436942522389, 14199.503017394341, 14226.644333891736, 14273.357698903366, 7173.89239161413, 8544.829103418022, 8587.785305367292, 8672.479651220821, 8704.474687751344, 6987.650617469106, 8582.227599516074, 8630.439021463584, 8820.779480513038, 8830.55847207637, 6711.899321510181, 6842.315768423217, 6848.794536163923, 6850.246472887979, 6850.897236541456, 1853.573678054055, 1882.538777999399, 1890.4045225754119, 1892.8391086757504, 1894.8105189481216, 700.4606453031138, 863.6977058029765, 873.0396563779918, 888.2760550151735, 1001.7145113642576, 20793.58412831735, 21912.780872191393, 22852.0, 22867.0, 23210.53578928412, 826.7023871406288, 934.8737920380662, 959.2421986630484, 980.9215262778961, 993.2004736187439, 10723.624673136403, 11166.05088567481, 11982.281063136239, 11987.280763154238, 12189.695257618454, 468357.0, 473285.0, 473898.0, 606609.0, 611182.0, 137961.0, 146385.0, 147428.0, 147873.26063369613, 152261.0, 979.7599588100818, 986.2011770465946, 1035.7358873487212, 1036.9688909332733, 1038.1850247555633, 19414.514637134183, 19734.111964961325, 19911.402657920287, 19916.103775329855, 19925.800741992396, 55425.44574554203, 56687.71656141693, 56860.43139568551, 57134.42865571291, 57487.712561438595, 86431.40705778837, 86833.56583217044, 87068.0, 87894.0, 88279.55860220658, 5937.851553711192, 7620.923790762243, 8181.140980197231, 8192.508449493049, 8443.915560844312, 10754.462276885968, 12590.24458532491, 12687.555935542212, 12857.935710321388, 13092.279924603858, 11092.611758588411, 11274.943625281821, 11284.492197851281, 11290.15323850698, 11476.311421314747, 11041.44792760375, 11097.278676886299, 11161.609343672932, 11424.143189260672, 11503.769924601294, 9868.506574671093, 11361.0, 11422.600208992646, 11708.590199342982, 11808.114391420506, 8145.511269323622, 8156.429049966446, 8253.79365515867, 8267.0, 8309.83380332402, 9743.366681165986, 11443.542258309908, 11449.255798373079, 11599.710007249887, 11731.061515078944], "value": 9894.083738588808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.0464277327262, 1402.8597140285972, 1526.4581073718832, 1686.8060173080091, 1848.731933869589, 7853.685852565897, 8389.993200815903, 8667.133286671338, 8921.464712117278, 8925.55372231389, 8768.736937891857, 8854.734357969272, 8866.645334186642, 8867.068957759438, 8869.778255543599, 2401.903923843044, 2426.5268272686835, 2426.8301218914685, 2434.1358817619757, 2434.464417828075, 2370.4429459077105, 2407.2296865003204, 2409.6385542168728, 2410.18053861687, 2419.4072452249134, 2375.679283296759, 2392.964105538418, 2394.0782798622567, 2407.5064611754547, 2407.518496300738, 2366.491204391047, 2378.2389635316704, 2387.4747555537665, 2389.545986262622, 2396.017632770573, 2294.621387471065, 2363.8936247868887, 2373.2405630198346, 2373.667686523888, 2376.370261880603, 7977.242161994601, 8193.09875913649, 8943.463392196489, 9005.50469724165, 9026.277897768228, 4927.753612319406, 5099.286099945974, 5114.079465696173, 5115.82336062704, 5238.633295669305, 3648.0, 3652.5799533053773, 3698.5746639136305, 3727.869524566627, 3732.794696291703, 985.6895078050392, 1008.9848652270222, 1757.66604345174, 1818.1999920035141, 1863.6272745450965, 9924.0, 11842.230255033395, 11935.343556104412, 11940.343281119534, 11952.70118247042, 4332.241857674894, 4657.5575320344515, 4700.341952126705, 4706.95293047072, 4716.669833111718, 9235.0, 9252.7686807829, 9253.0, 9259.30555208362, 9275.072492750805, 4394.231009573312, 5297.549708274762, 5299.12564426873, 5311.123664595376, 5317.627766056339, 4885.926711099336, 4923.48303428142, 4932.802687892516, 4954.331165292711, 5008.424031236382, 3093.9845300773354, 3609.7473176877893, 3676.9448458273146, 3722.962770372316, 3756.9060773480337, 1143.7598104398169, 1144.8511693479795, 1149.3104137517423, 1149.5172027748365, 1153.140910022039, 830.9750707478785, 846.2933450568721, 889.4440974391006, 892.7321803458937, 925.8750068740634, 5691.4877661010705, 5761.88476230473, 5958.44453867455, 6018.548608854266, 6060.545459090586, 916.867054277126, 921.424109931293, 938.7183844846519, 942.8255772682076, 982.2534873496195, 3778.8677396290996, 3906.5350493564915, 3998.3602623580086, 4063.756174629532, 4087.3051581230666, 10139.0, 10892.346459212473, 11042.889571104346, 11060.225784195029, 11070.169737269736, 10415.68752937413, 10990.395528245863, 10996.615118470816, 11001.284916480403, 11060.059894909024, 7936.928514650448, 8332.125126861592, 8343.457675251211, 8351.415400921876, 8352.248297653241, 5940.6435613863305, 5947.494462970696, 6047.183630209865, 6117.26592808848, 6150.907736383869, 9660.75848103803, 10233.385996840214, 10269.74325641865, 10288.639897603547, 10291.53688084053, 10132.696019119438, 10326.483675816029, 10345.534450949875, 10363.689089327332, 10380.584776609154, 7413.740519081806, 7416.925830741624, 7545.622718864144, 7590.316871481372, 7593.202713714981, 8142.959285203536, 8322.875156872773, 8341.45780524264, 8346.207110324509, 8348.206920342558, 7498.137714162941, 7525.2098529653595, 7618.8095297618, 7651.273129052731, 7778.533288002738, 7224.349808517259, 7276.272372762682, 7277.126744790659, 7348.669309881175, 7349.04462419882, 6881.793546193622, 6913.827154321182, 7008.053912721717, 7022.473314501331, 7022.473314501331, 3875.748076375027, 4981.153203955264, 4990.575801056951, 5001.4998500149695, 5059.822906198266, 4217.363324802811, 5046.798128074983, 5148.0476111919415, 5184.326037615086, 5194.7922083116255], "value": 4610.454083224957, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.98500074996247, 306.662671061832, 308.57262691172724, 313.23882964396506, 316.39252634940914, 4315.4174186484815, 4752.619790416771, 5294.788208471661, 5362.034833729927, 5420.972895135519, 5016.241067412927, 5181.870453238671, 5217.704210147533, 5322.840314790553, 5334.706591137496, 3800.2589495048405, 3816.5992570780086, 3960.881173564798, 4022.7787471689044, 4076.7961601919933, 3681.6134305897895, 3920.901977450558, 4038.2635466749284, 4069.4332681917526, 4102.774347410891, 3158.3209609933974, 3306.636270010297, 3501.73736969727, 3838.3282925488065, 4051.817668204938, 3240.8379581020854, 3286.4905939579403, 3390.627031026585, 3967.9206415871663, 3990.960090399117, 2824.449232399683, 3095.0250671038552, 3228.9183123653606, 3403.9319213615836, 3456.395130852116, 4189.664826813878, 5081.568066714333, 5091.847244582668, 5124.4875512448825, 5124.92312615311, 4082.6527246008745, 4231.91536169278, 4516.570925762047, 4530.3204519322035, 4557.361969324297, 4610.792514336863, 5278.604104692164, 5498.80754173606, 5499.50504454601, 5515.393306736256, 2905.4043920996146, 3812.923741525182, 3828.2964080983975, 3843.4811300474357, 3890.988343030804, 4738.099761045391, 5709.371969083398, 5734.569907256972, 5776.093889016614, 5780.682062486603, 3388.254583991518, 3598.5681718193982, 3772.8115643572187, 3833.0, 3839.9808000959815, 3275.9836200818845, 3889.6888248940018, 3896.181801821649, 3897.7271590988926, 3916.412538119248, 4529.8641040768825, 4538.909221815611, 4546.795394207269, 4566.74882881438, 4571.519990401027, 4648.163330600457, 5282.603804714662, 5586.469285417878, 5594.13290939905, 5627.634203776742, 1107.4352080438873, 1125.2348403085816, 1326.3103186343048, 1328.249539010456, 1335.626024713082, 785.6386062411241, 787.2442455242916, 808.6576283369578, 810.9133760760609, 811.7118422959883, 4906.1414252505665, 4985.5321615799685, 5020.397552293748, 5101.770420331094, 5223.936545064678, 4644.027822193799, 4901.926471102936, 5007.824726134568, 5447.801483673586, 5789.739461724233, 4370.868873933787, 4577.633789296849, 4954.355933728592, 5055.87360315995, 5171.172612382001, 2690.6636670416196, 2885.350796070867, 2962.9259268518026, 2965.4958657028355, 3003.594514740526, 5122.590192784643, 5837.532997360201, 5849.397018326804, 5850.635884366507, 5876.647401155944, 5447.319085114361, 5776.480116789509, 5786.681732504752, 5824.37902943677, 5859.129026776849, 4712.704006398268, 5831.504322132581, 5850.912236316459, 5903.0, 5948.970255148696, 5632.549396048388, 5672.858178545404, 5705.144228365778, 5724.622472741103, 5727.7422515986045, 4361.5202327744555, 5688.488036076773, 5726.198332233407, 5735.569832262514, 5768.971155144198, 4972.403311602631, 5937.990541607851, 5957.463828255478, 5966.06239881676, 5966.239959211956, 3583.552055993001, 3895.5520115187114, 3908.8241029154324, 3934.8622798201927, 3936.606339366155, 4792.640551958547, 5152.943646552522, 5698.347479230976, 5743.74153163117, 5751.971240143773, 4631.976840115778, 5571.913476871971, 5575.637583557056, 5585.748641311069, 5590.580706446952, 5205.505476979681, 5327.493888080626, 5573.405153675775, 5592.189132575835, 5594.1608758686525, 5445.863853403696, 5460.290162278879, 5465.590080744039, 5473.644213126134, 5512.8147448298805, 5265.78936842522, 5485.451454854483, 5487.804878048652, 5539.8892022160135, 5554.805581804618, 3979.1047014421524, 4888.486708895514, 5039.445660977363, 5113.565346945403, 5476.780928762805], "value": 3992.2017194952114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9146902371715, 737.5758938610301, 740.4779630360596, 748.7753673897829, 788.2117882117882, 14836.184009879453, 16200.108994005324, 16232.944858584184, 16234.83765162351, 16302.184890755445, 14640.707185856276, 14800.259987000634, 14802.25988700566, 14819.110853348806, 14875.628109297246, 689.7310049080837, 693.5803838677577, 697.2713514377488, 833.3291700181352, 844.4890841041174, 851.9105493923141, 854.2610641794834, 864.0711235421916, 865.7705707987388, 867.7136544940187, 932.2914584915479, 932.3426983976315, 932.4451951089092, 933.1788026536672, 933.6032186320821, 729.4310437858479, 746.5931067568189, 920.5121285718579, 922.6586163119655, 924.1267002682467, 662.3310456438983, 682.3279070115932, 685.5475386245055, 685.5783693028801, 688.6212583079287, 14686.97191196606, 14713.779293310608, 14727.337269822883, 14743.77884331736, 14757.483488077865, 13616.93191534046, 13824.308784560832, 14011.64970875726, 14043.0, 14464.566063018126, 11097.223194376396, 12801.0, 12851.614451566467, 12999.920568727863, 13072.071130227816, 3846.230753849213, 3889.5138107736534, 3899.2396482685886, 4031.8992025199314, 4065.9796701016603, 109089.45455272673, 110430.44784776025, 111142.88857111406, 111243.0, 111738.76522469505, 11247.606333778442, 11297.548098075986, 11511.769764604662, 11718.648440546627, 11784.0, 19165.904170479058, 22772.0, 23576.402601492886, 23657.053717851093, 23755.7624423757, 7786.221377862168, 7993.520388776576, 8021.157778433298, 8134.877976830352, 8140.715074972466, 4408.977955110204, 4462.598366147063, 4467.0, 4505.5719706627815, 4591.931121033187, 3572.428411454207, 3662.7069834413182, 3663.3222853772136, 3693.5567731872347, 3695.926081478355, 613.0834402568189, 615.1541630258395, 617.5522746009108, 620.5780069552748, 625.2497003595703, 564.2523656155611, 660.9603423794588, 662.5196732368994, 671.0711899636178, 672.4385138409385, 9206.677766278148, 9309.20871725911, 9463.668771592962, 9582.329236953487, 9722.465264410384, 606.3088079589272, 645.9063435801877, 666.5367569539221, 674.5750177388214, 681.8568100698809, 3664.706823454117, 4442.888927776831, 4506.954930450654, 4594.1730488512385, 4661.580457758818, 94938.0, 132661.0, 156741.43258567498, 163613.0, 164167.0, 134557.0, 141200.0, 141524.0, 142867.0, 144201.0, 75281.62359188279, 75308.0, 78675.60662196767, 88685.9999999987, 115582.0, 8891.777705557413, 8910.331725120772, 8920.687775927812, 8971.865422018544, 9056.456612603264, 65760.0, 67393.6521269562, 67501.64996700137, 67598.0, 69090.38195260176, 102598.0, 103510.48244758727, 103582.48208758907, 104195.4790226044, 104828.04133607296, 11377.601783937522, 11624.535018599161, 12033.518659253532, 12359.752804943671, 12485.87514124847, 12701.237925724487, 12997.870021300045, 13151.0, 13727.588172354845, 13786.586402407944, 11971.700707482383, 12088.093392995384, 12322.507099715911, 12494.437750301076, 12710.30093344838, 12049.216800907912, 12227.082968777555, 12290.938545307215, 12325.075619328407, 12673.746525069631, 11862.347570883685, 12211.206271592318, 12217.144799863925, 12484.188527745668, 12597.496100155891, 7679.347255483346, 9235.815283694423, 9655.758606034906, 9870.901290986998, 9874.210063194783, 8384.790380240298, 8832.779180520281, 9785.510724463891, 9849.950750246202, 9980.700578982642], "value": 7674.164215547343, "unit": "score"}], "name": "dromaeo_css", "value": 7383.908298775034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0, 111.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 111.0, 111.0, 147.0, 106.0, 113.0, 140.0, 120.0, 139.0, 108.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 184.0, 182.0, 181.0, 179.0, 183.0, 180.0, 182.0], "value": 181.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 57.0, 87.0, 64.0, 58.0, 57.0, 57.0, 81.0, 54.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 93.0, 71.0, 69.0, 68.0, 92.0, 68.0, 69.0, 93.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 88.0, 84.0, 88.0, 86.0, 88.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 93.0, 93.0, 93.0, 94.0, 95.0, 95.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 84.0, 86.0, 84.0, 85.0, 103.0, 139.0, 136.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 52.0, 52.0, 55.0, 73.0, 82.0, 82.0, 54.0, 54.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 78.0, 76.0, 71.0, 70.0, 69.0, 71.0, 69.0, 70.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 85.0, 87.0, 83.0, 84.0, 84.0, 83.0, 87.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 138.0, 168.0, 151.0, 146.0, 134.0, 136.0, 195.0, 152.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 169.0, 167.0, 166.0, 187.0, 169.0, 167.0, 168.0, 168.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 71.0, 83.0, 86.0, 86.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1450.4, "alertThreshold": 2.0}]} 05:37:16 INFO - Return code: 0 05:37:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:17 INFO - # TBPL SUCCESS # 05:37:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:17 INFO - 2016-09-13 05:37:17.028 screenresolution[1669:9864] starting screenresolution argv=screenresolution get 05:37:17 INFO - 2016-09-13 05:37:17.031 screenresolution[1669:9864] Display 0: 1600x1200x32@60 05:37:17 INFO - 2016-09-13 05:37:17.037 screenresolution[1670:9867] starting screenresolution argv=screenresolution list 05:37:17 INFO - Available Modes on Display 0 05:37:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:17 INFO - Intel Iris: 05:37:17 INFO - Chipset Model: Intel Iris 05:37:17 INFO - Type: GPU 05:37:17 INFO - Bus: Built-In 05:37:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:17 INFO - Vendor: Intel (0x8086) 05:37:17 INFO - Device ID: 0x0a2e 05:37:17 INFO - Revision ID: 0x0009 05:37:17 INFO - Displays: 05:37:17 INFO - Display: 05:37:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:17 INFO - Display Serial Number: 1600x1200 60 05:37:17 INFO - Main Display: Yes 05:37:17 INFO - Mirror: Off 05:37:17 INFO - Online: Yes 05:37:17 INFO - Rotation: Supported 05:37:17 INFO - Return code: 0 05:37:17 INFO - Running post-action listener: _resource_record_post_action 05:37:17 INFO - [mozharness: 2016-09-13 12:37:17.269942Z] Finished run-tests step (success) 05:37:17 INFO - Running post-run listener: _resource_record_post_run 05:37:17 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37192704; Write bytes: 703784960; Read time: 248; Write time: 1942 05:37:17 INFO - TinderboxPrint: CPU usage
53.6% 05:37:17 INFO - TinderboxPrint: I/O read bytes / time
37,192,704 / 248 05:37:17 INFO - TinderboxPrint: I/O write bytes / time
703,784,960 / 1,942 05:37:17 INFO - TinderboxPrint: CPU idle
2,252.3 (46.4%) 05:37:17 INFO - TinderboxPrint: CPU system
971.6 (20.0%) 05:37:17 INFO - TinderboxPrint: CPU user
1,625.8 (33.5%) 05:37:17 INFO - TinderboxPrint: Swap in / out
441,520,128 / 0 05:37:17 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392362496; Write bytes: 381845504; Read time: 29123; Write time: 758 05:37:17 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31005696; Write bytes: 295651328; Read time: 183; Write time: 1121 05:37:17 INFO - Running post-run listener: _upload_blobber_files 05:37:17 INFO - Blob upload gear active. 05:37:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:17 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 05:37:17 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'] 05:37:17 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 05:37:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:20 INFO - (blobuploader) - INFO - Done attempting. 05:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:21 INFO - (blobuploader) - INFO - Done attempting. 05:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:24 INFO - (blobuploader) - INFO - Done attempting. 05:37:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:24 INFO - Return code: 0 05:37:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71dabb392786f83b1f3b84c36ed3c0b028425fcb9699eedec3a3d7c92329aee728d865913eb89b6896ed2d343eb2e502d2f239152efdd24e2439abe451cc0926", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/317c8fe0a908a6a92b1b4925c8771127e77f9c0389271bee982e9b8dcda60e28cce7dcef9449b2a5d7f3ef899a93286263876150cd29bf9e5f07ccbd89c4390f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88877ab8001bf72ff90456ea46fbb40b455328e12d7b2a83981d1b685d2dbc45684ec7e0289fb6b2fc853db040d87a93c983fc7473f30946c5de8ff71662d3cf"} 05:37:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:24 INFO - Contents: 05:37:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71dabb392786f83b1f3b84c36ed3c0b028425fcb9699eedec3a3d7c92329aee728d865913eb89b6896ed2d343eb2e502d2f239152efdd24e2439abe451cc0926", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/317c8fe0a908a6a92b1b4925c8771127e77f9c0389271bee982e9b8dcda60e28cce7dcef9449b2a5d7f3ef899a93286263876150cd29bf9e5f07ccbd89c4390f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88877ab8001bf72ff90456ea46fbb40b455328e12d7b2a83981d1b685d2dbc45684ec7e0289fb6b2fc853db040d87a93c983fc7473f30946c5de8ff71662d3cf"} 05:37:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:24 INFO - Copying logs to upload dir... 05:37:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.740286 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-13 05:37:24.141574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 05:37:24.145938) ========= 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.fZGmPRzmEy/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.HqszsnMHul/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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/71dabb392786f83b1f3b84c36ed3c0b028425fcb9699eedec3a3d7c92329aee728d865913eb89b6896ed2d343eb2e502d2f239152efdd24e2439abe451cc0926", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/317c8fe0a908a6a92b1b4925c8771127e77f9c0389271bee982e9b8dcda60e28cce7dcef9449b2a5d7f3ef899a93286263876150cd29bf9e5f07ccbd89c4390f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88877ab8001bf72ff90456ea46fbb40b455328e12d7b2a83981d1b685d2dbc45684ec7e0289fb6b2fc853db040d87a93c983fc7473f30946c5de8ff71662d3cf"} build_url:https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010792 build_url: 'https://queue.taskcluster.net/v1/task/emSSLssQTcyd-zCH77kp7w/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/71dabb392786f83b1f3b84c36ed3c0b028425fcb9699eedec3a3d7c92329aee728d865913eb89b6896ed2d343eb2e502d2f239152efdd24e2439abe451cc0926", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/317c8fe0a908a6a92b1b4925c8771127e77f9c0389271bee982e9b8dcda60e28cce7dcef9449b2a5d7f3ef899a93286263876150cd29bf9e5f07ccbd89c4390f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88877ab8001bf72ff90456ea46fbb40b455328e12d7b2a83981d1b685d2dbc45684ec7e0289fb6b2fc853db040d87a93c983fc7473f30946c5de8ff71662d3cf"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 05:37:24.182510) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 05:37:24.182867) ========= 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.fZGmPRzmEy/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.HqszsnMHul/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.005463 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 05:37:24.231697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 05:37:24.232019) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 05:37:24.232379) ========= ========= Total master_lag: 0.19 =========