builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0242 starttime: 1473711606.44 results: success (0) buildid: 20160912121915 builduid: 14c7da7a92db4a27ad267e506e81667f revision: 68be9a5221854bcb29884f648bcebc706125e943 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:06.441403) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:06.441865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:06.442141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:06.503108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:06.503467) ========= 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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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-12 13:20:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.9M=0s 2016-09-12 13:20:07 (23.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.573122 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:07.104906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:07.105231) ========= 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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.025636 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:07.156447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:07.156817) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 68be9a5221854bcb29884f648bcebc706125e943 --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 68be9a5221854bcb29884f648bcebc706125e943 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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-12 13:20:07,241 truncating revision to first 12 chars 2016-09-12 13:20:07,241 Setting DEBUG logging. 2016-09-12 13:20:07,241 attempt 1/10 2016-09-12 13:20:07,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/68be9a522185?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-12 13:20:07,930 unpacking tar archive at: fx-team-68be9a522185/testing/mozharness/ program finished with exit code 0 elapsedTime=0.974003 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:08.156093) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:08.156457) ========= script_repo_revision: 68be9a5221854bcb29884f648bcebc706125e943 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:08.156875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:08.157145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 13:20:08.175871) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-09-12 13:20:08.176267) ========= /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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:08 INFO - MultiFileLogger online at 20160912 13:20:08 in /builds/slave/test 13:20:08 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 13:20:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:20:08 INFO - {'append_to_log': False, 13:20:08 INFO - 'base_work_dir': '/builds/slave/test', 13:20:08 INFO - 'blob_upload_branch': 'Fx-Team', 13:20:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:20:08 INFO - 'branch': 'Fx-Team', 13:20:08 INFO - 'buildbot_json_path': 'buildprops.json', 13:20:08 INFO - 'config_files': ('talos/mac_config.py',), 13:20:08 INFO - 'default_actions': ('clobber', 13:20:08 INFO - 'read-buildbot-config', 13:20:08 INFO - 'download-and-extract', 13:20:08 INFO - 'populate-webroot', 13:20:08 INFO - 'create-virtualenv', 13:20:08 INFO - 'install', 13:20:08 INFO - 'run-tests'), 13:20:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:20:08 INFO - 'download_minidump_stackwalk': True, 13:20:08 INFO - 'download_symbols': 'ondemand', 13:20:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:20:08 INFO - 'tooltool.py': '/tools/tooltool.py', 13:20:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:20:08 INFO - '/tools/misc-python/virtualenv.py')}, 13:20:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:20:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:20:08 INFO - 'installer_path': 'installer.exe', 13:20:08 INFO - 'log_level': 'info', 13:20:08 INFO - 'log_name': 'talos', 13:20:08 INFO - 'log_to_console': True, 13:20:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:20:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:20:08 INFO - 'opt_config_files': (), 13:20:08 INFO - 'pip_index': False, 13:20:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:20:08 INFO - 'cmd': ('bash', 13:20:08 INFO - '-c', 13:20:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:20:08 INFO - 'enabled': True, 13:20:08 INFO - 'halt_on_failure': False, 13:20:08 INFO - 'name': 'check_screen_resolution'},), 13:20:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:20:08 INFO - 'cmd': ('bash', 13:20:08 INFO - '-c', 13:20:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:20:08 INFO - 'enabled': True, 13:20:08 INFO - 'halt_on_failure': False, 13:20:08 INFO - 'name': 'check_screen_resolution'},), 13:20:08 INFO - 'run_cmd_checks_enabled': True, 13:20:08 INFO - 'sps_profile': False, 13:20:08 INFO - 'sps_profile_interval': 0, 13:20:08 INFO - 'suite': 'dromaeojs', 13:20:08 INFO - 'system_bits': '32', 13:20:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:20:08 INFO - 'title': 't-yosemite-r7-0242', 13:20:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:20:08 INFO - 'use_talos_json': True, 13:20:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:20:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:20:08 INFO - 'work_dir': 'build'} 13:20:08 INFO - [mozharness: 2016-09-12 20:20:08.377041Z] Running clobber step. 13:20:08 INFO - Running pre-action listener: _resource_record_pre_action 13:20:08 INFO - Running main action method: clobber 13:20:08 INFO - rmtree: /builds/slave/test/build 13:20:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:20:10 INFO - Running post-action listener: _resource_record_post_action 13:20:10 INFO - [mozharness: 2016-09-12 20:20:10.520441Z] Finished clobber step (success) 13:20:10 INFO - [mozharness: 2016-09-12 20:20:10.520686Z] Running read-buildbot-config step. 13:20:10 INFO - Running pre-action listener: _resource_record_pre_action 13:20:10 INFO - Running main action method: read_buildbot_config 13:20:10 INFO - Using buildbot properties: 13:20:10 INFO - { 13:20:10 INFO - "project": "", 13:20:10 INFO - "product": "firefox", 13:20:10 INFO - "script_repo_revision": "production", 13:20:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:20:10 INFO - "repository": "", 13:20:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:20:10 INFO - "buildid": "20160912121915", 13:20:10 INFO - "pgo_build": "False", 13:20:10 INFO - "basedir": "/builds/slave/test", 13:20:10 INFO - "buildnumber": 155, 13:20:10 INFO - "slavename": "t-yosemite-r7-0242", 13:20:10 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:20:10 INFO - "platform": "yosemite_r7", 13:20:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:20:10 INFO - "branch": "fx-team", 13:20:10 INFO - "repo_path": "integration/fx-team", 13:20:10 INFO - "revision": "68be9a5221854bcb29884f648bcebc706125e943", 13:20:10 INFO - "stage_platform": "macosx64", 13:20:10 INFO - "builduid": "14c7da7a92db4a27ad267e506e81667f", 13:20:10 INFO - "slavebuilddir": "test" 13:20:10 INFO - } 13:20:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:20:10 INFO - Running post-action listener: _resource_record_post_action 13:20:10 INFO - [mozharness: 2016-09-12 20:20:10.526033Z] Finished read-buildbot-config step (success) 13:20:10 INFO - [mozharness: 2016-09-12 20:20:10.526238Z] Running download-and-extract step. 13:20:10 INFO - Running pre-action listener: _resource_record_pre_action 13:20:10 INFO - Running main action method: download_and_extract 13:20:10 INFO - mkdir: /builds/slave/test/build/tests 13:20:10 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')]} 13:20:10 INFO - trying https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:20:10 INFO - Downloading https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/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 13:20:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/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 13:20:11 INFO - Downloaded 1199 bytes. 13:20:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:20:11 INFO - Using the following test package requirements: 13:20:11 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:20:11 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:20:11 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:20:11 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:20:11 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:20:11 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:20:11 INFO - u'jsshell-mac.zip'], 13:20:11 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:20:11 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:20:11 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:20:11 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:20:11 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:20:11 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:20:11 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:20:11 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:20:11 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:20:11 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:20:11 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:20:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:20:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:20:12 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 13:20:19 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 13:20:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:20:19 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 13:20:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:20:27 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 13:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:20:28 INFO - trying https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:20:28 INFO - Downloading https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/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 13:20:31 INFO - Downloaded 111393949 bytes. 13:20:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:20:31 INFO - mkdir: /builds/slave/test/properties 13:20:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:20:31 INFO - Writing to file /builds/slave/test/properties/build_url 13:20:31 INFO - Contents: 13:20:31 INFO - build_url:https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:20:32 INFO - Running post-action listener: _resource_record_post_action 13:20:32 INFO - Running post-action listener: set_extra_try_arguments 13:20:32 INFO - [mozharness: 2016-09-12 20:20:32.004919Z] Finished download-and-extract step (success) 13:20:32 INFO - [mozharness: 2016-09-12 20:20:32.005035Z] Running populate-webroot step. 13:20:32 INFO - Running pre-action listener: _resource_record_pre_action 13:20:32 INFO - Running main action method: populate_webroot 13:20:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:20:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:20:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:20:32 INFO - '--tppagecycles', 13:20:32 INFO - '7'], 13:20:32 INFO - 'tests': ['tsvgm']}}, 13:20:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:20:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:20:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:20:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:20:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:32 INFO - 'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:20:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:20:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:32 INFO - 'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['damp', 'tps']}, 13:20:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:32 INFO - 'tests': ['damp', 'tps']}, 13:20:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['dromaeo_dom']}, 13:20:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:20:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['basic_compositor_video']}, 13:20:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:20:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['a11yr', 13:20:32 INFO - 'ts_paint', 13:20:32 INFO - 'tpaint', 13:20:32 INFO - 'sessionrestore', 13:20:32 INFO - 'sessionrestore_no_auto_restore', 13:20:32 INFO - 'tabpaint']}, 13:20:32 INFO - 'other-e10s': {'tests': ['a11yr', 13:20:32 INFO - 'ts_paint', 13:20:32 INFO - 'tpaint', 13:20:32 INFO - 'sessionrestore', 13:20:32 INFO - 'sessionrestore_no_auto_restore', 13:20:32 INFO - 'tabpaint']}, 13:20:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:20:32 INFO - 'ts_paint', 13:20:32 INFO - 'tpaint', 13:20:32 INFO - 'sessionrestore', 13:20:32 INFO - 'sessionrestore_no_auto_restore', 13:20:32 INFO - 'tabpaint']}, 13:20:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:20:32 INFO - 'ts_paint', 13:20:32 INFO - 'tpaint', 13:20:32 INFO - 'sessionrestore', 13:20:32 INFO - 'sessionrestore_no_auto_restore', 13:20:32 INFO - 'tabpaint']}, 13:20:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['a11yr', 13:20:32 INFO - 'ts_paint', 13:20:32 INFO - 'tpaint', 13:20:32 INFO - 'sessionrestore', 13:20:32 INFO - 'sessionrestore_no_auto_restore', 13:20:32 INFO - 'tabpaint']}, 13:20:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['a11yr', 13:20:32 INFO - 'ts_paint', 13:20:32 INFO - 'tpaint', 13:20:32 INFO - 'sessionrestore', 13:20:32 INFO - 'sessionrestore_no_auto_restore', 13:20:32 INFO - 'tabpaint']}, 13:20:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['tsvgx', 13:20:32 INFO - 'tsvgr_opacity', 13:20:32 INFO - 'tart', 13:20:32 INFO - 'tscrollx', 13:20:32 INFO - 'cart']}, 13:20:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:20:32 INFO - 'tsvgr_opacity', 13:20:32 INFO - 'tart', 13:20:32 INFO - 'tscrollx', 13:20:32 INFO - 'cart']}, 13:20:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:32 INFO - 'talos_options': ['--disable-e10s'], 13:20:32 INFO - 'tests': ['tp5o']}, 13:20:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:32 INFO - 'tests': ['tp5o']}, 13:20:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:32 INFO - 'talos_options': ['--disable-e10s', 13:20:32 INFO - '--xperf_path', 13:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:20:32 INFO - 'tests': ['tp5n']}, 13:20:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:20:32 INFO - 'talos_options': ['--xperf_path', 13:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:20:32 INFO - 'tests': ['tp5n']}}, 13:20:32 INFO - 'talos.zip': {'path': '', 13:20:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:20:32 INFO - Running post-action listener: _resource_record_post_action 13:20:32 INFO - [mozharness: 2016-09-12 20:20:32.023675Z] Finished populate-webroot step (success) 13:20:32 INFO - [mozharness: 2016-09-12 20:20:32.023787Z] Running create-virtualenv step. 13:20:32 INFO - Running pre-action listener: _resource_record_pre_action 13:20:32 INFO - Running main action method: create_virtualenv 13:20:32 INFO - Creating virtualenv /builds/slave/test/build/venv 13:20:32 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 13:20:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:20:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:20:32 INFO - Using real prefix '/tools/python27' 13:20:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:20:32 INFO - Installing distribute.............................................................................................................................................................................................done. 13:20:35 INFO - Installing pip.................done. 13:20:35 INFO - Return code: 0 13:20:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:20:35 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')]} 13:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:35 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')]} 13:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:35 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:35 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 13:20:35 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 13:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:35 INFO - 'HOME': '/Users/cltbld', 13:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:35 INFO - 'LOGNAME': 'cltbld', 13:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:35 INFO - 'MOZ_NO_REMOTE': '1', 13:20:35 INFO - 'NO_EM_RESTART': '1', 13:20:35 INFO - 'PAGER': '/bin/cat', 13:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:35 INFO - 'PWD': '/builds/slave/test', 13:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:35 INFO - 'SHELL': '/bin/bash', 13:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:20:35 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:35 INFO - 'USER': 'cltbld', 13:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:35 INFO - 'XPC_FLAGS': '0x0', 13:20:35 INFO - 'XPC_SERVICE_NAME': '0', 13:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:35 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 13:20:35 INFO - Cleaning up... 13:20:36 INFO - Return code: 0 13:20:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:36 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:36 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 13:20:36 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 13:20:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:20:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:36 INFO - 'HOME': '/Users/cltbld', 13:20:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:36 INFO - 'LOGNAME': 'cltbld', 13:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:36 INFO - 'MOZ_NO_REMOTE': '1', 13:20:36 INFO - 'NO_EM_RESTART': '1', 13:20:36 INFO - 'PAGER': '/bin/cat', 13:20:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:36 INFO - 'PWD': '/builds/slave/test', 13:20:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:36 INFO - 'SHELL': '/bin/bash', 13:20:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:20:36 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:20:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:36 INFO - 'USER': 'cltbld', 13:20:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:36 INFO - 'XPC_FLAGS': '0x0', 13:20:36 INFO - 'XPC_SERVICE_NAME': '0', 13:20:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:36 INFO - Downloading/unpacking psutil>=3.1.1 13:20:36 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 13:20:36 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 13:20:36 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 13:20:36 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 13:20:36 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 13:20:36 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 13:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:20:39 INFO - Installing collected packages: psutil 13:20:39 INFO - Running setup.py install for psutil 13:20:39 INFO - building 'psutil._psutil_osx' extension 13:20:39 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 13:20:39 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 13:20:39 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 13:20:39 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 13:20:40 INFO - building 'psutil._psutil_posix' extension 13:20:40 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 13:20:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:20:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:20:40 INFO - ^ 13:20:40 INFO - 1 warning generated. 13:20:40 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 13:20:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:20:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:20:40 INFO - Successfully installed psutil 13:20:40 INFO - Cleaning up... 13:20:40 INFO - Return code: 0 13:20:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:20:40 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')]} 13:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:40 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')]} 13:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:40 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:40 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 13:20:40 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 13:20:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:20:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:40 INFO - 'HOME': '/Users/cltbld', 13:20:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:40 INFO - 'LOGNAME': 'cltbld', 13:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:40 INFO - 'MOZ_NO_REMOTE': '1', 13:20:40 INFO - 'NO_EM_RESTART': '1', 13:20:40 INFO - 'PAGER': '/bin/cat', 13:20:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:40 INFO - 'PWD': '/builds/slave/test', 13:20:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:40 INFO - 'SHELL': '/bin/bash', 13:20:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:20:40 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:20:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:40 INFO - 'USER': 'cltbld', 13:20:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:40 INFO - 'XPC_FLAGS': '0x0', 13:20:40 INFO - 'XPC_SERVICE_NAME': '0', 13:20:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:20:43 INFO - Installing collected packages: mozsystemmonitor 13:20:43 INFO - Running setup.py install for mozsystemmonitor 13:20:43 INFO - Successfully installed mozsystemmonitor 13:20:43 INFO - Cleaning up... 13:20:43 INFO - Return code: 0 13:20:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:43 INFO - 'HOME': '/Users/cltbld', 13:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:43 INFO - 'LOGNAME': 'cltbld', 13:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:43 INFO - 'MOZ_NO_REMOTE': '1', 13:20:43 INFO - 'NO_EM_RESTART': '1', 13:20:43 INFO - 'PAGER': '/bin/cat', 13:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:43 INFO - 'PWD': '/builds/slave/test', 13:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:43 INFO - 'SHELL': '/bin/bash', 13:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:20:43 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:43 INFO - 'USER': 'cltbld', 13:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:43 INFO - 'XPC_FLAGS': '0x0', 13:20:43 INFO - 'XPC_SERVICE_NAME': '0', 13:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:43 INFO - Downloading/unpacking jsonschema==2.5.1 13:20:43 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 13:20:43 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 13:20:43 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 13:20:43 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 13:20:43 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 13:20:43 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 13:20:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:20:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:20:46 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 13:20:46 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 13:20:46 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 13:20:46 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 13:20:46 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 13:20:46 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 13:20:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:20:46 INFO - warning: no files found matching '*.txt' 13:20:46 INFO - no previously-included directories found matching 'build' 13:20:46 INFO - no previously-included directories found matching 'dist' 13:20:46 INFO - no previously-included directories found matching '.git*' 13:20:46 INFO - Installing collected packages: jsonschema, functools32 13:20:46 INFO - Running setup.py install for functools32 13:20:46 INFO - warning: no files found matching '*.txt' 13:20:46 INFO - no previously-included directories found matching 'build' 13:20:46 INFO - no previously-included directories found matching 'dist' 13:20:46 INFO - no previously-included directories found matching '.git*' 13:20:46 INFO - Successfully installed jsonschema functools32 13:20:46 INFO - Cleaning up... 13:20:46 INFO - Return code: 0 13:20:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:20:46 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')]} 13:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:46 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')]} 13:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:46 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:46 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 13:20:46 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 13:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:46 INFO - 'HOME': '/Users/cltbld', 13:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:46 INFO - 'LOGNAME': 'cltbld', 13:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:46 INFO - 'MOZ_NO_REMOTE': '1', 13:20:46 INFO - 'NO_EM_RESTART': '1', 13:20:46 INFO - 'PAGER': '/bin/cat', 13:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:46 INFO - 'PWD': '/builds/slave/test', 13:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:46 INFO - 'SHELL': '/bin/bash', 13:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:20:46 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:46 INFO - 'USER': 'cltbld', 13:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:46 INFO - 'XPC_FLAGS': '0x0', 13:20:46 INFO - 'XPC_SERVICE_NAME': '0', 13:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:20:47 INFO - Cleaning up... 13:20:47 INFO - Return code: 0 13:20:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:47 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:47 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 13:20:47 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 13:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:47 INFO - 'HOME': '/Users/cltbld', 13:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:47 INFO - 'LOGNAME': 'cltbld', 13:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:47 INFO - 'MOZ_NO_REMOTE': '1', 13:20:47 INFO - 'NO_EM_RESTART': '1', 13:20:47 INFO - 'PAGER': '/bin/cat', 13:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:47 INFO - 'PWD': '/builds/slave/test', 13:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:47 INFO - 'SHELL': '/bin/bash', 13:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:20:47 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:47 INFO - 'USER': 'cltbld', 13:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:47 INFO - 'XPC_FLAGS': '0x0', 13:20:47 INFO - 'XPC_SERVICE_NAME': '0', 13:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:47 INFO - Downloading/unpacking blobuploader==1.2.4 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20:49 INFO - Downloading blobuploader-1.2.4.tar.gz 13:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:20:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:20:50 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 13:20:50 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 13:20:50 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 13:20:50 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 13:20:50 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 13:20:50 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 13:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:20:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:20:50 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 13:20:50 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 13:20:50 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 13:20:50 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 13:20:50 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 13:20:50 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 13:20:51 INFO - Downloading docopt-0.6.1.tar.gz 13:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:20:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:20:51 INFO - Running setup.py install for blobuploader 13:20:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:20:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:20:51 INFO - Running setup.py install for requests 13:20:51 INFO - Running setup.py install for docopt 13:20:51 INFO - Successfully installed blobuploader requests docopt 13:20:51 INFO - Cleaning up... 13:20:52 INFO - Return code: 0 13:20:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:52 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')]} 13:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:52 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')]} 13:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:52 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:52 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 13:20:52 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 13:20:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:20:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:52 INFO - 'HOME': '/Users/cltbld', 13:20:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:52 INFO - 'LOGNAME': 'cltbld', 13:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:52 INFO - 'MOZ_NO_REMOTE': '1', 13:20:52 INFO - 'NO_EM_RESTART': '1', 13:20:52 INFO - 'PAGER': '/bin/cat', 13:20:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:52 INFO - 'PWD': '/builds/slave/test', 13:20:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:52 INFO - 'SHELL': '/bin/bash', 13:20:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:20:52 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:20:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:52 INFO - 'USER': 'cltbld', 13:20:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:52 INFO - 'XPC_FLAGS': '0x0', 13:20:52 INFO - 'XPC_SERVICE_NAME': '0', 13:20:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:52 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-8PQ4j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:52 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-JQQ8px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:52 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-2nBqt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:52 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-VIWcNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:52 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-V__F0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:52 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-4PTuMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:52 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-4ChECI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-95iGyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-3KYys2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-_Ju646-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-iY_DvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-XCz43Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-WW9AQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-bhWwHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-tKb6ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:53 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-LDuNgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:54 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-GwmsDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:20:54 INFO - Running setup.py install for manifestparser 13:20:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:20:54 INFO - Running setup.py install for mozcrash 13:20:54 INFO - Running setup.py install for mozdebug 13:20:54 INFO - Running setup.py install for mozdevice 13:20:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:20:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:20:54 INFO - Running setup.py install for mozfile 13:20:54 INFO - Running setup.py install for mozhttpd 13:20:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:20:55 INFO - Running setup.py install for mozinfo 13:20:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:20:55 INFO - Running setup.py install for mozInstall 13:20:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:20:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:20:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:20:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:20:55 INFO - Running setup.py install for mozleak 13:20:55 INFO - Running setup.py install for mozlog 13:20:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:20:55 INFO - Running setup.py install for moznetwork 13:20:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:20:55 INFO - Running setup.py install for mozprocess 13:20:55 INFO - Running setup.py install for mozprofile 13:20:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:20:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:20:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:20:56 INFO - Running setup.py install for mozrunner 13:20:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:20:56 INFO - Running setup.py install for mozscreenshot 13:20:56 INFO - Running setup.py install for moztest 13:20:56 INFO - Running setup.py install for mozversion 13:20:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:20:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:20:56 INFO - Cleaning up... 13:20:56 INFO - Return code: 0 13:20:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:56 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')]} 13:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:56 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')]} 13:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:56 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:20:56 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 13:20:56 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 13:20:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:20:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:56 INFO - 'HOME': '/Users/cltbld', 13:20:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:56 INFO - 'LOGNAME': 'cltbld', 13:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:56 INFO - 'MOZ_NO_REMOTE': '1', 13:20:56 INFO - 'NO_EM_RESTART': '1', 13:20:56 INFO - 'PAGER': '/bin/cat', 13:20:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:56 INFO - 'PWD': '/builds/slave/test', 13:20:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:56 INFO - 'SHELL': '/bin/bash', 13:20:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:20:56 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:20:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:56 INFO - 'USER': 'cltbld', 13:20:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:56 INFO - 'XPC_FLAGS': '0x0', 13:20:56 INFO - 'XPC_SERVICE_NAME': '0', 13:20:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-YwKLGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-e63fHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-h108cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-9mCzjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-8xhVQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-0JoIxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-exu2VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-FFNeQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-oHc7RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:57 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)) 13:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:57 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-b2vjCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:58 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)) 13:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-XSWEep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:58 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)) 13:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-AAsKOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:58 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)) 13:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-85YOfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:58 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)) 13:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-c2U0Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:58 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)) 13:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-j53PMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:58 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)) 13:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-eSsCOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:58 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)) 13:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:58 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-vEzCi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:58 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)) 13:20:58 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)) 13:20:58 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)) 13:20:58 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)) 13:20:58 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)) 13:20:58 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)) 13:20:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:20:58 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 13:20:58 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 13:20:58 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 13:20:58 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 13:20:58 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 13:20:58 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 13:21:01 INFO - Downloading blessings-1.6.tar.gz 13:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:21:01 INFO - Installing collected packages: blessings 13:21:01 INFO - Running setup.py install for blessings 13:21:01 INFO - Successfully installed blessings 13:21:01 INFO - Cleaning up... 13:21:01 INFO - Return code: 0 13:21:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:21:01 INFO - Reading from file tmpfile_stdout 13:21:01 INFO - Current package versions: 13:21:01 INFO - blessings == 1.6 13:21:01 INFO - blobuploader == 1.2.4 13:21:01 INFO - docopt == 0.6.1 13:21:01 INFO - functools32 == 3.2.3-2 13:21:01 INFO - jsonschema == 2.5.1 13:21:01 INFO - manifestparser == 1.1 13:21:01 INFO - mozInstall == 1.12 13:21:01 INFO - mozcrash == 0.17 13:21:01 INFO - mozdebug == 0.1 13:21:01 INFO - mozdevice == 0.48 13:21:01 INFO - mozfile == 1.2 13:21:01 INFO - mozhttpd == 0.7 13:21:01 INFO - mozinfo == 0.9 13:21:01 INFO - mozleak == 0.1 13:21:01 INFO - mozlog == 3.3 13:21:01 INFO - moznetwork == 0.27 13:21:01 INFO - mozprocess == 0.23 13:21:01 INFO - mozprofile == 0.28 13:21:01 INFO - mozrunner == 6.12 13:21:01 INFO - mozscreenshot == 0.1 13:21:01 INFO - mozsystemmonitor == 0.3 13:21:01 INFO - moztest == 0.7 13:21:01 INFO - mozversion == 1.4 13:21:01 INFO - psutil == 3.1.1 13:21:01 INFO - requests == 1.2.3 13:21:01 INFO - wsgiref == 0.1.2 13:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:01 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')]} 13:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:01 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')]} 13:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:01 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:21:01 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 13:21:01 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 13:21:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:21:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:01 INFO - 'HOME': '/Users/cltbld', 13:21:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:01 INFO - 'LOGNAME': 'cltbld', 13:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:01 INFO - 'MOZ_NO_REMOTE': '1', 13:21:01 INFO - 'NO_EM_RESTART': '1', 13:21:01 INFO - 'PAGER': '/bin/cat', 13:21:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:01 INFO - 'PWD': '/builds/slave/test', 13:21:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:01 INFO - 'SHELL': '/bin/bash', 13:21:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:21:01 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:21:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:01 INFO - 'USER': 'cltbld', 13:21:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:01 INFO - 'XPC_FLAGS': '0x0', 13:21:01 INFO - 'XPC_SERVICE_NAME': '0', 13:21:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 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)) 13:21:02 INFO - Cleaning up... 13:21:02 INFO - Return code: 0 13:21:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17a4d8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 13:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:21:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:21:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:02 INFO - 'HOME': '/Users/cltbld', 13:21:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:02 INFO - 'LOGNAME': 'cltbld', 13:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:02 INFO - 'MOZ_NO_REMOTE': '1', 13:21:02 INFO - 'NO_EM_RESTART': '1', 13:21:02 INFO - 'PAGER': '/bin/cat', 13:21:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:02 INFO - 'PWD': '/builds/slave/test', 13:21:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:02 INFO - 'SHELL': '/bin/bash', 13:21:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:21:02 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:21:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:02 INFO - 'USER': 'cltbld', 13:21:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:02 INFO - 'XPC_FLAGS': '0x0', 13:21:02 INFO - 'XPC_SERVICE_NAME': '0', 13:21:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:21:02 INFO - Cleaning up... 13:21:02 INFO - Return code: 0 13:21:02 INFO - Running post-action listener: _resource_record_post_action 13:21:02 INFO - Running post-action listener: _start_resource_monitoring 13:21:02 INFO - Starting resource monitoring. 13:21:02 INFO - [mozharness: 2016-09-12 20:21:02.442976Z] Finished create-virtualenv step (success) 13:21:02 INFO - [mozharness: 2016-09-12 20:21:02.443957Z] Running install step. 13:21:02 INFO - Running pre-action listener: _resource_record_pre_action 13:21:02 INFO - Running main action method: install 13:21:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:21:02 INFO - Reading from file tmpfile_stdout 13:21:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:21:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:21:02 INFO - Reading from file tmpfile_stdout 13:21:02 INFO - Output received: 13:21:02 INFO - Usage: mozinstall [options] installer 13:21:02 INFO - Options: 13:21:02 INFO - -h, --help show this help message and exit 13:21:02 INFO - -d DEST, --destination=DEST 13:21:02 INFO - Directory to install application into. [default: 13:21:02 INFO - "/builds/slave/test"] 13:21:02 INFO - --app=APP Application being installed. [default: firefox] 13:21:02 INFO - mkdir: /builds/slave/test/build/application 13:21:02 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'] 13:21:02 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 13:21:38 INFO - Reading from file tmpfile_stdout 13:21:38 INFO - Output received: 13:21:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:21:38 INFO - Running post-action listener: _resource_record_post_action 13:21:38 INFO - [mozharness: 2016-09-12 20:21:38.039356Z] Finished install step (success) 13:21:38 INFO - [mozharness: 2016-09-12 20:21:38.039457Z] Running run-tests step. 13:21:38 INFO - Running pre-action listener: _resource_record_pre_action 13:21:38 INFO - Running main action method: run_tests 13:21:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:21:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:21:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:21:38 INFO - 2016-09-12 13:21:38.052 screenresolution[1645:7885] starting screenresolution argv=screenresolution get 13:21:38 INFO - 2016-09-12 13:21:38.054 screenresolution[1645:7885] Display 0: 1600x1200x32@60 13:21:38 INFO - 2016-09-12 13:21:38.059 screenresolution[1646:7887] starting screenresolution argv=screenresolution list 13:21:38 INFO - Available Modes on Display 0 13:21:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:21:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:21:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:21:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:21:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:21:38 INFO - Intel Iris: 13:21:38 INFO - Chipset Model: Intel Iris 13:21:38 INFO - Type: GPU 13:21:38 INFO - Bus: Built-In 13:21:38 INFO - VRAM (Dynamic, Max): 1536 MB 13:21:38 INFO - Vendor: Intel (0x8086) 13:21:38 INFO - Device ID: 0x0a2e 13:21:38 INFO - Revision ID: 0x0009 13:21:38 INFO - Displays: 13:21:38 INFO - Display: 13:21:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:21:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:21:38 INFO - Display Serial Number: 1600x1200 60 13:21:38 INFO - Main Display: Yes 13:21:38 INFO - Mirror: Off 13:21:38 INFO - Online: Yes 13:21:38 INFO - Rotation: Supported 13:21:38 INFO - Return code: 0 13:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:21:38 INFO - Python 2.7.3 13:21:38 INFO - Return code: 0 13:21:38 INFO - grabbing minidump binary from tooltool 13:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:38 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 0x10d841d30>, '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 0x10d667db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:21:38 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 13:21:38 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 13:21:38 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 13:21:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:21:38 INFO - Return code: 0 13:21:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:21:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:21:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:21:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:21:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:21:38 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/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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 13:21:38 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/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0242 --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 13:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fWP6pWhFs8/Render', 13:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:38 INFO - 'HOME': '/Users/cltbld', 13:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:38 INFO - 'LOGNAME': 'cltbld', 13:21:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:21:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:38 INFO - 'MOZ_NO_REMOTE': '1', 13:21:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:21:38 INFO - 'NO_EM_RESTART': '1', 13:21:38 INFO - 'PAGER': '/bin/cat', 13:21:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:38 INFO - 'PWD': '/builds/slave/test', 13:21:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:38 INFO - 'SHELL': '/bin/bash', 13:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSQtnZ0YAA/Listeners', 13:21:38 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 13:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:38 INFO - 'USER': 'cltbld', 13:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:38 INFO - 'XPC_FLAGS': '0x0', 13:21:38 INFO - 'XPC_SERVICE_NAME': '0', 13:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:38 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/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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 13:21:38 INFO - mozversion application_buildid: 20160912121915 13:21:38 INFO - mozversion application_changeset: 68be9a5221854bcb29884f648bcebc706125e943 13:21:38 INFO - mozversion application_display_name: Nightly 13:21:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:21:38 INFO - mozversion application_name: Firefox 13:21:38 INFO - mozversion application_remotingname: firefox 13:21:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:21:38 INFO - mozversion application_vendor: Mozilla 13:21:38 INFO - mozversion application_version: 51.0a1 13:21:38 INFO - mozversion platform_buildid: 20160912121915 13:21:38 INFO - mozversion platform_changeset: 68be9a5221854bcb29884f648bcebc706125e943 13:21:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:21:38 INFO - mozversion platform_version: 51.0a1 13:21:38 INFO - using testdate: 1473711698 13:21:38 INFO - actual date: 1473711698 13:21:38 INFO - starting webserver on 'localhost:49273' 13:21:38 INFO - SUITE-START | Running 2 tests 13:21:38 INFO - TEST-START | dromaeo_css 13:21:38 INFO - operating with platform_type : mac_ 13:21:38 INFO - Initialising browser for dromaeo_css test... 13:21:38 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpl7o6xa/profile http://localhost:49273/getInfo.html) 13:21:41 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 13:21:41 INFO - PROCESS | 1657 | colorDepth:24 13:21:41 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 13:21:41 INFO - PROCESS | 1657 | __metrics 13:21:41 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:21:41 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:21:42 INFO - TEST-INFO | 1657: exit 0 13:21:42 INFO - Browser initialized. 13:21:42 INFO - Running cycle 1/1 for dromaeo_css test... 13:21:42 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpl7o6xa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:54 INFO - PROCESS | 1659 | RSS: Main: 232431616 13:21:54 INFO - PROCESS | 1659 | 13:22:45 INFO - PROCESS | 1659 | 1473711765171 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] 13:24:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 13:24:59 INFO - PROCESS | 1659 | RSS: Main: 399998976 13:24:59 INFO - PROCESS | 1659 | 13:28:02 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 13:28:02 INFO - PROCESS | 1659 | RSS: Main: 387915776 13:28:02 INFO - PROCESS | 1659 | 13:31:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 13:31:05 INFO - PROCESS | 1659 | RSS: Main: 325877760 13:31:05 INFO - PROCESS | 1659 | 13:34:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 13:34:08 INFO - PROCESS | 1659 | RSS: Main: 331296768 13:34:08 INFO - PROCESS | 1659 | 13:37:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 13:37:12 INFO - PROCESS | 1659 | RSS: Main: 326422528 13:37:12 INFO - PROCESS | 1659 | 13:40:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 13:40:16 INFO - PROCESS | 1659 | RSS: Main: 477954048 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - PROCESS | 1659 | __start_tp_report 13:40:16 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 13:40:16 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 13:40:16 INFO - PROCESS | 1659 | |i|pagename|runs| 13:40:16 INFO - PROCESS | 1659 | |0;dojo.html;3353.1952331440452;3381.9492707609384;3410.198603328219;3432.1248081739154;3451.7411194160427;5703.3156021277455;5703.429657034295;5792.1601367801695;5794.217780599618;5846.941530584698;5786.710664466781;5814.156947242658;5844.094165404358;5868.970655146729;5941.257342832146;5331.840044798643;5357.142857142858;5370.248165256867;5397.325334333208;5419.187121931703;5353.866153346158;5368.087425137716;5420.783168673268;5441.564674826024;5470.288862447876;4625.69865768138;5256.316678831747;5406.513413792758;5422.267993820843;5493.121100623881;5410.134378499461;5417.26866872971;5417.51242388183;5474.069408200596;5508.64193827404;5145.279660847485;5253.789848406059;5255.474452554752;5295.708736019517;5342.519173274424;5724.799632012901;5730.541556675456;5772.7113644317615;5786.450287222707;5815.941840581625;6275.69768596682;6282.151909492206;6290.811275661737;6316.652584107872;6351.491880649537;6200.627962322275;6251.031090181029;6302.432781049728;6304.464120549759;6323.778667746653;4741.952580474185;5772.769089236467;5844.912326315109;5848.88302233953;5916.7337469813965;6413.134226879405;6429.324920883333;6431.356864313531;6434.64609446485;6436.678166091677;6265.248170219603;6273.905891411541;6275;6276;6284.874302513924;5291.920621190685;5517.59301378146;5860.446981549892;6241.75032998684;6258.687065646699;6132.448079672761;6289.905651415233;6298.622082674962;6312.242530896322;6316.589421687576;6243.469305109026;6313.494920406357;6334.968325158345;6349.365063493614;6352.4918006559365;4968.627352948543;4993.650444468853;5004.349434573555;5071.594272458195;5078.542931136141;4481.327800829837;4504.594586487166;4524.47968483622;4555.794989225493;4584.4957054723955;5753.424657534213;5772.220750198753;5786.537077033827;5786.652800831964;5804.2744656917885;6209.316975132731;6233.812985610439;6279.4662453691035;6309.211348581427;6317.1156038154695;5676.659400435987;5708.571857110734;5740.741666625012;5766.336871259775;5775.884482310415;5504.697241651747;5539.390667026624;5581.246531718247;5628.127640215773;5632.5212356950115;6444.45222156122;6476.935230647633;6497.382748638872;6500.089987401768;6507.446867016167;6235.919978021574;6245.313015568193;6256.499480041677;6294.590851594632;6307.400796924285;6314.62112273265;6365.299817020216;6371.617702937653;6490.123833282447;6497.805065848032;6286.779962701284;6299.559030867796;6300.716467759054;6306.0225665022;6310.968445157745;6073.848153796191;6243.032329988859;6284.780032698834;6326.493880489457;6332.493400527855;6100.732564372456;6138.541671868701;6146.631202127886;6161.045038019114;6249.78125765596;6219.502439804714;6229.906551401823;6230.283517395376;6230.719617617127;6241.937580624317;6033.577649564489;6067.969660151671;6074.362191969956;6098;6114.847128821815;6088.543359247986;6120.0205129226715;6122.7244773984385;6143.082036032849;6153.630782153085;6042.1540984261355;6068.939310606837;6074.119252708244;6097.573169878244;6115.082737589397 13:40:16 INFO - PROCESS | 1659 | |1;ext.html;519.877828710253;526.1423879077104;532.1671583971088;537.2612657595806;546.344386735917;31020.914268000626;34245;41964.95087622811;42302.94242643928;42335.94160145998;44148.33777493332;44601.107977840424;44618.776906115505;44638.33042504365;44732;9420.63400806886;9832.36089654172;10030.9498452508;10031.097201251885;10042.949785251063;9048.683296084639;9971.900280997206;9978.251631127658;9985.051420115115;9993.700188994342;9959.651412200574;9977;10003.699889003341;10018.749531261741;10027.749306267366;9908.455034973074;9955;9970.351927124713;9972.401655900596;9977.600895964153;8295.709650162276;9754.122129008423;9808.754781130458;9846.212303015742;9870.654527091589;41414.37878431826;41743.582564174576;41787.582124178676;41811.372829407585;41838.163236735396;3267.754918381131;3359.428897087501;3428.211511352403;3542.468629705539;3646.6535679110443;30730.84634576835;31557.84221078903;32729.509057364157;32763.017109486755;33312.83343583291;3182.6658200889037;3213.3091385352263;3214.212517933098;3329.96670033299;3380.121168496184;498308;504285;504612;507213;508205;33326;62515.062274065924;63146.36853631497;63213.051804222974;63296.683516582125;33923.66076339205;35842.64157358445;35854.565817367016;35860.28279434397;35922;14701.897357698;14819.40722371093;14881.404743810126;14893.70212595742;14897.47858824936;12581.685457863443;12676.957530192873;12677.746445071047;12678;12691.49234030647;7824.9608751955875;7830.373570114377;7851.685932562747;7901.881471777928;7905.367570594339;2877.1512403840916;3223.7421006319437;3242.238074052596;3254.3494290440167;3297.1427428868187;944.3389627260945;997.4663554998041;1061.570064124031;1064.1539975719322;1125.8209110809971;26652.866735666197;27963.440731185263;31317.68682313193;32117.03648890537;32376.315672052493;1036.730450082984;1045.6862941117633;1064.3667018124204;1065.350136416785;1084.1706094837455;15841.366345346058;15881;15891.967022143524;15937.760933586005;16263.674726505404;696852;700634;701575;702502;703807;59473.10790338148;59981;60045;60053.39946600478;60063.69968150131;1067.5676351077982;1238.2261086820738;1353.5803900790786;1368.9178649280875;1398.0213850304826;29558.852205738833;29654.406911862072;31818.36363272768;31872;32364.901814566245;47393.52606473891;53406;53456;53508.929821404134;53532;588031;594359;594383;594565;594906;22590;23687.1709490167;23998.40003999914;27001;27028.32429189286;48097;49253.50746492489;49558;49634.802953570805;49691.75770605764;35264.64735352614;39835.40246896357;40015.79992100021;40207.396889046104;42294.36558451687;39018.6098139015;39468.60531394649;39631.60368396279;39672.60327396689;41511.169776604904;38258.42612360761;39488.80255598704;39654.80172599119;39673;39790;25991.610125848507;28162;34257.65742342644;35208.943731688094;35459.82270088633;25602.487950240517;25691.35771605725;25715.971361145344;26142.73215848019;26147.215583532525 13:40:16 INFO - PROCESS | 1659 | |2;jquery.html;340.76812323450736;361.3387500873402;369.058899805496;378.93179227739006;396.5617992118709;13976.860231397683;14955.700885982274;16027.919860400682;20580.588388232227;20901.895490522526;19296.131674074666;19762.604747905032;20250.69623955642;20452;20965.790342096574;5879.970600146993;5958.136070269819;6119.755209791625;6152.784652537162;6163.876722465548;4814.566688997989;6113.724882380281;6169.660668663222;6179.258488981329;6190.473809726179;5815.73829177688;5977.8206653800235;6132.386761323876;6135.539834512407;6138.386161383871;6022.247219097613;6065.8180254592435;6081.574289799716;6084.817455476321;6096.298925623566;5119.692818430869;5172.732680493304;5290.682559046431;5414.729263536847;5498;12520.624381268577;12757.42591583381;12777;13683.589492315246;24314.513709725885;2116.724825772655;2165.7834216578217;2381.475855452512;2442.010985550837;2704.837709737422;9516.429014259167;9569.521523923777;9657.951710241474;9987.500624968796;10142.087212150867;1577.37693611023;1804.8736588438815;1870.251899240301;1882.8681992260547;1914.626647803679;110603.44698276457;112856;119859;121122;121254.39372803167;11083.224174307721;11172.664820055412;11237.60668376603;11308.943455282835;11445.542178312775;14074.507392241223;14077.788833167511;14090.436382544789;14103.85896141046;14108.788368174486;8308.210719981593;8452.450590711584;8474.237318641352;8611.440256383315;8625.827483450295;8110.3511719062335;8178.223068808454;8205.302549283258;8294.792630184294;8591.312694984386;4338.3709362142945;4408.933865992013;4417.580329868657;4491.842785502492;4541.296099104644;1336.4520546576052;1813.4015774794286;1831.44141036985;1877.5963167918962;1883.161992913168;370.38146295686266;374.096556815288;386.8607301371504;795.8766391209372;898.2589363774912;11528.308301501937;11616.651500455;11643.88356116445;11734.178607497564;11876.931076203184;412.6966679490572;417.1510975165584;432.1292595420231;433.20290665176225;451.96610254231064;5604.271444712243;5731.140328950691;5913.497352725067;6054.091886217103;6125.9693701531205;593970;606645.5680380762;617128;624834.7516524867;626752;79267;84917.15082849216;113927;137992.31003844916;141610.79529830528;418.39541862009105;439.7691212113602;440.7509756987292;440.7663938112805;441.44818976280294;7476.962615186889;8661.307095432476;9623.807523849624;9974.40153590787;10337.793244134924;52199;53343.4665653354;53412.39762807122;54914.45085549093;55464.44535554754;77016;78159.60920195363;78824;81131.5943420279;89082.55458722665;8867.91132088671;11177.497012634614;11324.773504530029;11584.304941703525;11759.235649682743;11019.779604407706;13139.73720525565;13252.933735331262;13305.53430629962;13560.59318220455;11142.442877855912;11361.02364172566;11443.771124577628;11491.195616306779;11701.356425396685;11098.334099953705;11249.943750281196;11308.547658093585;11695.88304116948;11794.056475482112;10804.891951080703;11208.88791112111;11239.157063220127;11827.763444731228;11948.701282468008;11784.941075294912;11930.701732456759;11961.282323060645;12009.459574319351;12086;7641.732539361318;7675.309222170032;11023.83464248021;11376.54493820238;11518.314139475287 13:40:16 INFO - PROCESS | 1659 | |3;mootools.html;1497.1989985357832;1547.3269127929352;1723.4484964811259;1832.3403574713109;1892.2620178130533;7958.840823183533;8173.632186551605;8386.62260198291;8921.241694455972;8923.419977701446;8013.599320034004;8529.275011624004;8684.609192586333;8696.652133914651;8828.60271287792;2284.18911286493;2315.4674424882287;2318.826088043395;2320.2923108451914;2321.1759825261956;1960.7353007343968;2004.1782869023702;2218.5784700906775;2314.259436980167;2318.7565305642834;2096.3815674376096;2099.464636517686;2254.9098036078535;2321.5240875620457;2325.720913490375;1932.6134773045376;2021.0501064499808;2307.861528308307;2311.2026350909077;2314.1784666443423;1968.9507762305914;2136.83973701973;2295.8737269450176;2297.1959814065112;2297.3682237384687;7669.6932122715025;8861.468311901242;8876.068012858686;8886.777830554223;8887.24458421035;5093.592512598983;5270.604704647167;5272.2355258487305;5284.471552844723;5300.761465734051;2899.623049003616;3406.7615266931325;3407.727381809449;3612.5123108380294;3623.2028953630424;1083.2417307884512;1089.2647462962468;1094.162965331522;1114.1922106472823;1115.0354942974268;11537.653870383901;11669.299842009506;11690.883091169064;11691.41542922859;11711.297322160612;4438.334249862482;4477;4649.279361698942;4658.697184683053;4658.720476771405;9933.850992235122;9946;9950.203983681287;9956.203503719686;9971.102600765966;5253.343332083489;5264.526192642604;5265.236540701577;5268.473152684701;5272.736363181903;4700.153972284953;4739.360186374795;4834.540718631724;4843.709377437365;4851.902961940741;3886.7279290449396;3893.9415908761393;3911.902202444962;3975.403689446606;4027.6979226558124;1282.7755142849965;1298.7142828577698;1299.5581502289267;1315.953941612039;1318.406716977364;644.4844124700221;780.5589841739512;818.2635627934907;858.5149390594295;882.580774132282;5619.690916999522;5757.107648314518;5956.13636022783;5986.431289027535;6019.849503762353;792.6762306947412;895.2837729816121;968.4092703450889;983.5573991703762;999.7900440907491;3332.783369081002;3672.687821535146;3968.3849003404516;3995.001249687578;4070.2673518766314;10412.271141020208;10650.360978341168;10720.785584288427;10752.569897204025;10801.189910756724;10686.412247326316;10698.251122421356;10713;10726;10729.463526823627;8137.511749295061;8259.050209226016;8265.214804593554;8266.04940431858;8299.917000829915;5197.648611360998;5211.635185536976;5260.974110048657;5521.365043020104;5889.676067816311;9486.620535178792;9931.056549627774;9979;10041.49792510357;10148.391096534231;9776.657816976372;9819.16537094355;10129.290949633454;10142.847857282295;10293.691189264335;5912.408759124053;7356.889646655198;7410.036695229801;7486;7497.137829149718;7967.56178410193;8128.83742325162;8132.390070744599;8135.30849877767;8135.83728325442;7278.890816637649;7445.329920307198;7449;7498;7568.659410326439;7218.386437152691;7231.023811785341;7258.818529536804;7354.558726476428;7443.032405787213;6716;6844.076049733421;6943.756968506078;6946.37482626566;6983.546069505466;4957.851264462072;4977.9751101244265;5038.798448062036;5055.87360315995;5108.56577190943;3885.378339465672;4978.014762937461;5051.898962020812;5190.688558686491;5219.034478621315 13:40:16 INFO - PROCESS | 1659 | |4;prototype.html;295.9541271102979;298.05813628932566;304.5203804008687;308.1771669642055;308.3570754975874;5145.614078944075;5180.844574662766;5334.146536554152;5388.0570900092525;5420;4846.903061938768;5356.437574054727;5367.46325367463;5373.408925018245;5375.6774593524415;3188.4260833050043;3353.7758718067853;3936.4488971544006;4038.8788336349958;4117.238310912491;4089.20260549193;4096.5903409659095;4111.280525907954;4146.5853414658595;4179.226843034034;3756.8685096021645;3900.2004589059175;4067.6542493888055;4068.6745060395247;4122;3858.2862170498265;4048.1903619275968;4105.527864295599;4109.2808758467145;4122.525909520414;2697.8651067446744;3448.5689288838894;3519.665631764978;3529;3533.8939831805087;4783.354247176621;5160.535551800356;5233.319668443078;5256.658317209369;5278.996990571779;4310.44823863409;4368.864095335204;4618.676692631517;4618.792154353062;4628.675992680513;4340.435743353375;4931.301523857107;5499.7250137493365;5639.492445679908;5677.233573467571;3827.8660246891504;3832.5784163741964;3841.308564458396;3843.481130047464;3847.8653247136494;4975.601951843843;5609.551235901159;5747.540196784247;5838.328592211908;5871.500922421556;3447.5690538682666;3650.361186792301;3893.610638936084;3913.1412579025305;3914.7668484427313;3576.302620988934;3716.4611131385795;3978.602139785998;3979.9403008954887;3980.2238563479846;4397.560243975577;4621.237495813153;4623.676342655982;4642.65180111493;4650.139724150975;4756.524347565216;5356.3127614801215;5516.724163791794;5656.575756818255;5781.277340332458;1336.9304556354878;1347.3128704360847;1350.4598160735588;1354.5936219134417;1362.271184916065;681.4582406986458;699.762080892499;781.5935713428985;822.5358861227025;835.4319063037071;4379.4525684289465;4473.2842745160615;4921.876953076202;5106.7191304477865;5223.582113430993;5820.76716931318;5822.563307751935;5824.708764561755;5833.50415214703;5850.385709500526;4891.413030436371;5140.485951404904;5210.348706411699;5253.789848406021;5265.315508983807;2669.826461280011;3022.712842280024;3041.0420717473926;3052.725254727085;3061.525463553153;6020.367861374581;6027.969860150759;6032.577719559588;6067.483129217696;6114.205153330038;5465.726713664301;5496.065668836308;5745.971270143623;5921.430820832483;6059.48494377974;4933.901321973541;4956.628252880976;5308.336457942757;5381.416919878402;5856.297244330623;4468.374427580206;5092.955944031539;5262.605304602093;5455.754491047833;5794.246747922743;5648.80842324102;5697.601167918206;5778.36437991829;5782.277215348082;5790.392008839011;6077.331493535796;6078.331383547717;6080.628554863695;6090.390960903874;6091.725872335667;3462.9826850865584;3677.2461645363173;3811.904702382463;3841.193349396658;3874.9225015500097;5234.7906083756225;5791.9131213031;5832.650040997553;5848.590598658053;5850.869784665184;5298.377303234924;5693.9430605693415;5709.65742055478;5709.8287051388525;5750.856228594319;4677.836275730333;5386.48828361305;5589.385167631639;5608.383077861514;5733.989655430765;5434.880396645232;5511.724413779375;5522.696251706195;5525.309336332958;5572.554195664418;5367.745546870402;5393.8921221574565;5514.726087282388;5659.849257282206;5692.669788173965;4984.925226121683;5290.624437646163;5465.207544906046;5501.587380946525;5589.329280486368 13:40:16 INFO - PROCESS | 1659 | |5;yui.html;712.9465290103242;727.6798208788136;732.8570928668912;794.3922898982283;816.5468165168332;15242.771358429618;16280.83719162808;16304;16304.673906521863;16349;14473.42106315746;14556;14571.19858407787;14574.489892853751;14609.707805843904;664.4153145232189;683.8187880211748;686.2005763285791;835.862082756346;841.1126261793805;845.3997661660229;848.3382961290173;856.4604299291437;857.2327766648846;858.8754630578562;917.2616044084509;923.1091996223643;925.2274350916992;925.3476299209042;925.8240934222476;920.516728717422;920.6363486422858;920.7237828651445;920.7744102694849;924.1451657217048;525.3065952942118;542.3708498142175;658.7233361987977;677.857649893523;682.1405029662611;14912.17983010934;14929.328180231916;14929.477468288558;14932.701345973128;14978.325975331136;12856.421461034182;12900.935495322557;12916.935415322958;13119.147255428463;13470.932645336808;10851.83722244159;12049.397530123459;12719.936400318033;13080.018998575146;13214;4323.647991102474;4483.170613436492;4509.7970591323465;4618.838340658061;4637;82534;114274.42862785632;114887;115021;124448.75551244462;10879.184061195441;10980.835287470534;11414.600488983011;11503.76992460163;11611.361375124281;22513;22521.662175067388;22562.435939101655;22566.548669026855;22578.548429031656;7823.2567906048835;7850.56821874791;7865.606719663994;8126.2686358226865;8151.144129866398;4318.157959197989;4386.605205531454;4413.315936029856;4536.092781443725;4591.770411479412;3131.921701957424;3204.1188673114616;3210.1172177651333;3213.935721285561;3220.1949512621845;634.7587916591758;641.5701480008405;653.7809833705667;667.4993754683987;671.4024518178825;588.4204059001879;619.1301221783401;621.3103455164763;627.50427162542;639.0956796133512;8534.530600817016;8784.736457906272;8925.509096999727;8927.866082008775;9058.728238152866;598.775459202799;600.5465873265744;620.7858288890326;623.1894157350292;635.5900444213456;3681.006128345385;4047.352423612208;4375.496817865923;4464.419625448736;4509.751963642031;122297.38851305687;135573;139554.30222849024;176588;177207;147408;147592.2620386891;148894.25552872167;151202;151302;79070.81393779213;97726;99500.03499754948;122578;128768;8396.622152003052;9363.896676311291;9524.952375238357;9811.705648830546;9969.95315491892;48958;57152.142067924695;63409;65179;65827.67086164538;60730.39269607247;61210;63458.730825384155;89703.10296896947;100616.49075264024;12815.551455699006;12832.871671283541;12929.224246545238;13056.34718264102;13075.82602798469;14540.200288983784;14815.703685926437;15023.924880375529;15091.54725358241;15329.38682452734;9915.950420247853;11828.70428239301;12102.455389507317;12172.817407738714;12403;13459.730805384033;13622;13706.109102908278;13800.93099534496;13851.722965540834;13014.674633134247;13320.800187997382;13676.521321753691;13866.43896820796;13962.441502339792;9108.998010218738;9502;10200.897991020292;10459.372437653461;11002.559897604006;10920.617778377718;10943.671689849318;11070.335779853234;11230.55077796879;11267.380294083903 13:40:16 INFO - PROCESS | 1659 | __end_tp_report 13:40:16 INFO - PROCESS | 1659 | __start_cc_report 13:40:16 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1628 13:40:16 INFO - PROCESS | 1659 | __end_cc_report 13:40:16 INFO - PROCESS | 1659 | __startTimestamp1473712816186__endTimestamp 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - PROCESS | 1659 | ------- Summary: start ------- 13:40:16 INFO - PROCESS | 1659 | Number of tests: 6 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5822.88 Median:6073.85 stddev:641.26 (10.6%) stddev-sans-first:613.26 13:40:16 INFO - PROCESS | 1659 | Values: 3353.2 3381.9 3410.2 3432.1 3451.7 5703.3 5703.4 5792.2 5794.2 5846.9 5786.7 5814.2 5844.1 5869.0 5941.3 5331.8 5357.1 5370.2 5397.3 5419.2 5353.9 5368.1 5420.8 5441.6 5470.3 4625.7 5256.3 5406.5 5422.3 5493.1 5410.1 5417.3 5417.5 5474.1 5508.6 5145.3 5253.8 5255.5 5295.7 5342.5 5724.8 5730.5 5772.7 5786.5 5815.9 6275.7 6282.2 6290.8 6316.7 6351.5 6200.6 6251.0 6302.4 6304.5 6323.8 4742.0 5772.8 5844.9 5848.9 5916.7 6413.1 6429.3 6431.4 6434.6 6436.7 6265.2 6273.9 6275.0 6276.0 6284.9 5291.9 5517.6 5860.4 6241.8 6258.7 6132.4 6289.9 6298.6 6312.2 6316.6 6243.5 6313.5 6335.0 6349.4 6352.5 4968.6 4993.7 5004.3 5071.6 5078.5 4481.3 4504.6 4524.5 4555.8 4584.5 5753.4 5772.2 5786.5 5786.7 5804.3 6209.3 6233.8 6279.5 6309.2 6317.1 5676.7 5708.6 5740.7 5766.3 5775.9 5504.7 5539.4 5581.2 5628.1 5632.5 6444.5 6476.9 6497.4 6500.1 6507.4 6235.9 6245.3 6256.5 6294.6 6307.4 6314.6 6365.3 6371.6 6490.1 6497.8 6286.8 6299.6 6300.7 6306.0 6311.0 6073.8 6243.0 6284.8 6326.5 6332.5 6100.7 6138.5 6146.6 6161.0 6249.8 6219.5 6229.9 6230.3 6230.7 6241.9 6033.6 6068.0 6074.4 6098.0 6114.8 6088.5 6120.0 6122.7 6143.1 6153.6 6042.2 6068.9 6074.1 6097.6 6115.1 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:71844.98 Median:39478.70 stddev:162211.56 (410.9%) stddev-sans-first:162578.21 13:40:16 INFO - PROCESS | 1659 | Values: 519.9 526.1 532.2 537.3 546.3 31020.9 34245.0 41965.0 42302.9 42335.9 44148.3 44601.1 44618.8 44638.3 44732.0 9420.6 9832.4 10030.9 10031.1 10042.9 9048.7 9971.9 9978.3 9985.1 9993.7 9959.7 9977.0 10003.7 10018.7 10027.7 9908.5 9955.0 9970.4 9972.4 9977.6 8295.7 9754.1 9808.8 9846.2 9870.7 41414.4 41743.6 41787.6 41811.4 41838.2 3267.8 3359.4 3428.2 3542.5 3646.7 30730.8 31557.8 32729.5 32763.0 33312.8 3182.7 3213.3 3214.2 3330.0 3380.1 498308.0 504285.0 504612.0 507213.0 508205.0 33326.0 62515.1 63146.4 63213.1 63296.7 33923.7 35842.6 35854.6 35860.3 35922.0 14701.9 14819.4 14881.4 14893.7 14897.5 12581.7 12677.0 12677.7 12678.0 12691.5 7825.0 7830.4 7851.7 7901.9 7905.4 2877.2 3223.7 3242.2 3254.3 3297.1 944.3 997.5 1061.6 1064.2 1125.8 26652.9 27963.4 31317.7 32117.0 32376.3 1036.7 1045.7 1064.4 1065.4 1084.2 15841.4 15881.0 15892.0 15937.8 16263.7 696852.0 700634.0 701575.0 702502.0 703807.0 59473.1 59981.0 60045.0 60053.4 60063.7 1067.6 1238.2 1353.6 1368.9 1398.0 29558.9 29654.4 31818.4 31872.0 32364.9 47393.5 53406.0 53456.0 53508.9 53532.0 588031.0 594359.0 594383.0 594565.0 594906.0 22590.0 23687.2 23998.4 27001.0 27028.3 48097.0 49253.5 49558.0 49634.8 49691.8 35264.6 39835.4 40015.8 40207.4 42294.4 39018.6 39468.6 39631.6 39672.6 41511.2 38258.4 39488.8 39654.8 39673.0 39790.0 25991.6 28162.0 34257.7 35208.9 35459.8 25602.5 25691.4 25716.0 26142.7 26147.2 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34165.27 Median:372.24 stddev:102235.29 (27465.0%) stddev-sans-first:102490.54 13:40:16 INFO - PROCESS | 1659 | Values: 340.8 361.3 369.1 378.9 396.6 13976.9 14955.7 16027.9 20580.6 20901.9 19296.1 19762.6 20250.7 20452.0 20965.8 5880.0 5958.1 6119.8 6152.8 6163.9 4814.6 6113.7 6169.7 6179.3 6190.5 5815.7 5977.8 6132.4 6135.5 6138.4 6022.2 6065.8 6081.6 6084.8 6096.3 5119.7 5172.7 5290.7 5414.7 5498.0 12520.6 12757.4 12777.0 13683.6 24314.5 2116.7 2165.8 2381.5 2442.0 2704.8 9516.4 9569.5 9658.0 9987.5 10142.1 1577.4 1804.9 1870.3 1882.9 1914.6 110603.4 112856.0 119859.0 121122.0 121254.4 11083.2 11172.7 11237.6 11308.9 11445.5 14074.5 14077.8 14090.4 14103.9 14108.8 8308.2 8452.5 8474.2 8611.4 8625.8 8110.4 8178.2 8205.3 8294.8 8591.3 4338.4 4408.9 4417.6 4491.8 4541.3 1336.5 1813.4 1831.4 1877.6 1883.2 370.4 374.1 386.9 795.9 898.3 11528.3 11616.7 11643.9 11734.2 11876.9 412.7 417.2 432.1 433.2 452.0 5604.3 5731.1 5913.5 6054.1 6126.0 593970.0 606645.6 617128.0 624834.8 626752.0 79267.0 84917.2 113927.0 137992.3 141610.8 418.4 439.8 440.8 440.8 441.4 7477.0 8661.3 9623.8 9974.4 10337.8 52199.0 53343.5 53412.4 54914.5 55464.4 77016.0 78159.6 78824.0 81131.6 89082.6 8867.9 11177.5 11324.8 11584.3 11759.2 11019.8 13139.7 13252.9 13305.5 13560.6 11142.4 11361.0 11443.8 11491.2 11701.4 11098.3 11249.9 11308.5 11695.9 11794.1 10804.9 11208.9 11239.2 11827.8 11948.7 11784.9 11930.7 11961.3 12009.5 12086.0 7641.7 7675.3 11023.8 11376.5 11518.3 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5633.42 Median:5053.89 stddev:3201.74 (63.4%) stddev-sans-first:3195.64 13:40:16 INFO - PROCESS | 1659 | Values: 1497.2 1547.3 1723.4 1832.3 1892.3 7958.8 8173.6 8386.6 8921.2 8923.4 8013.6 8529.3 8684.6 8696.7 8828.6 2284.2 2315.5 2318.8 2320.3 2321.2 1960.7 2004.2 2218.6 2314.3 2318.8 2096.4 2099.5 2254.9 2321.5 2325.7 1932.6 2021.1 2307.9 2311.2 2314.2 1969.0 2136.8 2295.9 2297.2 2297.4 7669.7 8861.5 8876.1 8886.8 8887.2 5093.6 5270.6 5272.2 5284.5 5300.8 2899.6 3406.8 3407.7 3612.5 3623.2 1083.2 1089.3 1094.2 1114.2 1115.0 11537.7 11669.3 11690.9 11691.4 11711.3 4438.3 4477.0 4649.3 4658.7 4658.7 9933.9 9946.0 9950.2 9956.2 9971.1 5253.3 5264.5 5265.2 5268.5 5272.7 4700.2 4739.4 4834.5 4843.7 4851.9 3886.7 3893.9 3911.9 3975.4 4027.7 1282.8 1298.7 1299.6 1316.0 1318.4 644.5 780.6 818.3 858.5 882.6 5619.7 5757.1 5956.1 5986.4 6019.8 792.7 895.3 968.4 983.6 999.8 3332.8 3672.7 3968.4 3995.0 4070.3 10412.3 10650.4 10720.8 10752.6 10801.2 10686.4 10698.3 10713.0 10726.0 10729.5 8137.5 8259.1 8265.2 8266.0 8299.9 5197.6 5211.6 5261.0 5521.4 5889.7 9486.6 9931.1 9979.0 10041.5 10148.4 9776.7 9819.2 10129.3 10142.8 10293.7 5912.4 7356.9 7410.0 7486.0 7497.1 7967.6 8128.8 8132.4 8135.3 8135.8 7278.9 7445.3 7449.0 7498.0 7568.7 7218.4 7231.0 7258.8 7354.6 7443.0 6716.0 6844.1 6943.8 6946.4 6983.5 4957.9 4978.0 5038.8 5055.9 5108.6 3885.4 4978.0 5051.9 5190.7 5219.0 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4552.86 Median:5195.60 stddev:1419.04 (27.3%) stddev-sans-first:1386.59 13:40:16 INFO - PROCESS | 1659 | Values: 296.0 298.1 304.5 308.2 308.4 5145.6 5180.8 5334.1 5388.1 5420.0 4846.9 5356.4 5367.5 5373.4 5375.7 3188.4 3353.8 3936.4 4038.9 4117.2 4089.2 4096.6 4111.3 4146.6 4179.2 3756.9 3900.2 4067.7 4068.7 4122.0 3858.3 4048.2 4105.5 4109.3 4122.5 2697.9 3448.6 3519.7 3529.0 3533.9 4783.4 5160.5 5233.3 5256.7 5279.0 4310.4 4368.9 4618.7 4618.8 4628.7 4340.4 4931.3 5499.7 5639.5 5677.2 3827.9 3832.6 3841.3 3843.5 3847.9 4975.6 5609.6 5747.5 5838.3 5871.5 3447.6 3650.4 3893.6 3913.1 3914.8 3576.3 3716.5 3978.6 3979.9 3980.2 4397.6 4621.2 4623.7 4642.7 4650.1 4756.5 5356.3 5516.7 5656.6 5781.3 1336.9 1347.3 1350.5 1354.6 1362.3 681.5 699.8 781.6 822.5 835.4 4379.5 4473.3 4921.9 5106.7 5223.6 5820.8 5822.6 5824.7 5833.5 5850.4 4891.4 5140.5 5210.3 5253.8 5265.3 2669.8 3022.7 3041.0 3052.7 3061.5 6020.4 6028.0 6032.6 6067.5 6114.2 5465.7 5496.1 5746.0 5921.4 6059.5 4933.9 4956.6 5308.3 5381.4 5856.3 4468.4 5093.0 5262.6 5455.8 5794.2 5648.8 5697.6 5778.4 5782.3 5790.4 6077.3 6078.3 6080.6 6090.4 6091.7 3463.0 3677.2 3811.9 3841.2 3874.9 5234.8 5791.9 5832.7 5848.6 5850.9 5298.4 5693.9 5709.7 5709.8 5750.9 4677.8 5386.5 5589.4 5608.4 5734.0 5434.9 5511.7 5522.7 5525.3 5572.6 5367.7 5393.9 5514.7 5659.8 5692.7 4984.9 5290.6 5465.2 5501.6 5589.3 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:24796.44 Median:4182.76 stddev:40840.99 (976.4%) stddev-sans-first:40915.53 13:40:16 INFO - PROCESS | 1659 | Values: 712.9 727.7 732.9 794.4 816.5 15242.8 16280.8 16304.0 16304.7 16349.0 14473.4 14556.0 14571.2 14574.5 14609.7 664.4 683.8 686.2 835.9 841.1 845.4 848.3 856.5 857.2 858.9 917.3 923.1 925.2 925.3 925.8 920.5 920.6 920.7 920.8 924.1 525.3 542.4 658.7 677.9 682.1 14912.2 14929.3 14929.5 14932.7 14978.3 12856.4 12900.9 12916.9 13119.1 13470.9 10851.8 12049.4 12719.9 13080.0 13214.0 4323.6 4483.2 4509.8 4618.8 4637.0 82534.0 114274.4 114887.0 115021.0 124448.8 10879.2 10980.8 11414.6 11503.8 11611.4 22513.0 22521.7 22562.4 22566.5 22578.5 7823.3 7850.6 7865.6 8126.3 8151.1 4318.2 4386.6 4413.3 4536.1 4591.8 3131.9 3204.1 3210.1 3213.9 3220.2 634.8 641.6 653.8 667.5 671.4 588.4 619.1 621.3 627.5 639.1 8534.5 8784.7 8925.5 8927.9 9058.7 598.8 600.5 620.8 623.2 635.6 3681.0 4047.4 4375.5 4464.4 4509.8 122297.4 135573.0 139554.3 176588.0 177207.0 147408.0 147592.3 148894.3 151202.0 151302.0 79070.8 97726.0 99500.0 122578.0 128768.0 8396.6 9363.9 9525.0 9811.7 9970.0 48958.0 57152.1 63409.0 65179.0 65827.7 60730.4 61210.0 63458.7 89703.1 100616.5 12815.6 12832.9 12929.2 13056.3 13075.8 14540.2 14815.7 15023.9 15091.5 15329.4 9916.0 11828.7 12102.5 12172.8 12403.0 13459.7 13622.0 13706.1 13800.9 13851.7 13014.7 13320.8 13676.5 13866.4 13962.4 9109.0 9502.0 10200.9 10459.4 11002.6 10920.6 10943.7 11070.3 11230.6 11267.4 13:40:16 INFO - PROCESS | 1659 | -------- Summary: end -------- 13:40:16 INFO - PROCESS | 1659 | 13:40:16 INFO - TEST-INFO | 1659: exit 0 13:40:16 INFO - TEST-OK | dromaeo_css | took 1118149ms 13:40:16 INFO - TEST-START | kraken 13:40:16 INFO - operating with platform_type : mac_ 13:40:16 INFO - Initialising browser for kraken test... 13:40:16 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmp2QLLGe/profile http://localhost:49273/getInfo.html) 13:40:18 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 13:40:18 INFO - PROCESS | 1666 | colorDepth:24 13:40:18 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 13:40:18 INFO - PROCESS | 1666 | __metrics 13:40:19 INFO - PROCESS | 1666 | 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" 13:40:19 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:40:19 INFO - TEST-INFO | 1666: exit 0 13:40:19 INFO - Browser initialized. 13:40:19 INFO - Running cycle 1/1 for kraken test... 13:40:19 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmp2QLLGe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:31 INFO - PROCESS | 1667 | RSS: Main: 232460288 13:40:31 INFO - PROCESS | 1667 | 13:40:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 13:40:35 INFO - PROCESS | 1667 | RSS: Main: 291340288 13:40:35 INFO - PROCESS | 1667 | 13:40:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 13:40:38 INFO - PROCESS | 1667 | RSS: Main: 287318016 13:40:38 INFO - PROCESS | 1667 | 13:40:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 13:40:42 INFO - PROCESS | 1667 | RSS: Main: 375951360 13:40:42 INFO - PROCESS | 1667 | 13:40:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 13:40:45 INFO - PROCESS | 1667 | RSS: Main: 276807680 13:40:45 INFO - PROCESS | 1667 | 13:40:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:40:47 INFO - PROCESS | 1667 | RSS: Main: 281350144 13:40:47 INFO - PROCESS | 1667 | 13:40:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 13:40:51 INFO - PROCESS | 1667 | RSS: Main: 321175552 13:40:51 INFO - PROCESS | 1667 | 13:40:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 13:40:55 INFO - PROCESS | 1667 | RSS: Main: 323313664 13:40:55 INFO - PROCESS | 1667 | 13:40:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 13:40:58 INFO - PROCESS | 1667 | RSS: Main: 321720320 13:40:58 INFO - PROCESS | 1667 | 13:41:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:41:00 INFO - PROCESS | 1667 | RSS: Main: 297844736 13:41:00 INFO - PROCESS | 1667 | 13:41:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:41:03 INFO - PROCESS | 1667 | RSS: Main: 304549888 13:41:03 INFO - PROCESS | 1667 | 13:41:05 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:41:06 INFO - PROCESS | 1667 | RSS: Main: 299339776 13:41:06 INFO - PROCESS | 1667 | 13:41:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:41:09 INFO - PROCESS | 1667 | RSS: Main: 316534784 13:41:09 INFO - PROCESS | 1667 | 13:41:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:41:13 INFO - PROCESS | 1667 | RSS: Main: 312913920 13:41:13 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 13:41:15 INFO - PROCESS | 1667 | RSS: Main: 356478976 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | __start_tp_report 13:41:15 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 13:41:15 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 13:41:15 INFO - PROCESS | 1667 | |i|pagename|runs| 13:41:15 INFO - PROCESS | 1667 | |0;ai-astar;113;112;116;112;113;113;113;113;113;122 13:41:15 INFO - PROCESS | 1667 | |1;audio-beat-detection;145;110;130;162;107;132;131;111;159;108 13:41:15 INFO - PROCESS | 1667 | |2;audio-dft;184;211;256;185;183;183;183;183;181;181 13:41:15 INFO - PROCESS | 1667 | |3;audio-fft;74;75;76;148;57;57;57;67;139;57 13:41:15 INFO - PROCESS | 1667 | |4;audio-oscillator;82;82;136;70;78;79;116;69;70;119 13:41:15 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;99;132;136;89;91;89;92;88;91;88 13:41:15 INFO - PROCESS | 1667 | |6;imaging-darkroom;95;96;96;96;95;96;101;144;95;102 13:41:15 INFO - PROCESS | 1667 | |7;imaging-desaturate;85;83;85;84;83;85;95;137;144;95 13:41:15 INFO - PROCESS | 1667 | |8;json-parse-financial;55;52;52;54;73;82;82;82;53;54 13:41:15 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;63;65;69;73;75;76;69;93;68;70 13:41:15 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;85;85;83;75;96;97;75;86;96;107 13:41:15 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;136;141;136;134;139;135;139;138;184;142 13:41:15 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;168;166;170;237;201;167;167;172;167;168 13:41:15 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;66;67;67;66;68;64;65;61;64;83 13:41:15 INFO - PROCESS | 1667 | __end_tp_report 13:41:15 INFO - PROCESS | 1667 | __start_cc_report 13:41:15 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2154 13:41:15 INFO - PROCESS | 1667 | __end_cc_report 13:41:15 INFO - PROCESS | 1667 | __startTimestamp1473712875593__endTimestamp 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | ------- Summary: start ------- 13:41:15 INFO - PROCESS | 1667 | Number of tests: 14 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:3.02 (2.7%) stddev-sans-first:3.18 13:41:15 INFO - PROCESS | 1667 | Values: 113.0 112.0 116.0 112.0 113.0 113.0 113.0 113.0 113.0 122.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:131.50 stddev:20.73 (15.8%) stddev-sans-first:21.21 13:41:15 INFO - PROCESS | 1667 | Values: 145.0 110.0 130.0 162.0 107.0 132.0 131.0 111.0 159.0 108.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:193.00 Median:183.50 stddev:23.87 (13.0%) stddev-sans-first:25.09 13:41:15 INFO - PROCESS | 1667 | Values: 184.0 211.0 256.0 185.0 183.0 183.0 183.0 183.0 181.0 181.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:80.70 Median:62.00 stddev:34.09 (55.0%) stddev-sans-first:36.08 13:41:15 INFO - PROCESS | 1667 | Values: 74.0 75.0 76.0 148.0 57.0 57.0 57.0 67.0 139.0 57.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:74.00 stddev:24.19 (32.7%) stddev-sans-first:25.48 13:41:15 INFO - PROCESS | 1667 | Values: 82.0 82.0 136.0 70.0 78.0 79.0 116.0 69.0 70.0 119.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:90.00 stddev:18.48 (20.5%) stddev-sans-first:19.60 13:41:15 INFO - PROCESS | 1667 | Values: 99.0 132.0 136.0 89.0 91.0 89.0 92.0 88.0 91.0 88.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:95.50 stddev:15.11 (15.8%) stddev-sans-first:15.84 13:41:15 INFO - PROCESS | 1667 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 101.0 144.0 95.0 102.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:85.00 stddev:23.11 (27.2%) stddev-sans-first:24.06 13:41:15 INFO - PROCESS | 1667 | Values: 85.0 83.0 85.0 84.0 83.0 85.0 95.0 137.0 144.0 95.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:13.92 (21.7%) stddev-sans-first:14.38 13:41:15 INFO - PROCESS | 1667 | Values: 55.0 52.0 52.0 54.0 73.0 82.0 82.0 82.0 53.0 54.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:71.50 stddev:8.40 (11.7%) stddev-sans-first:8.24 13:41:15 INFO - PROCESS | 1667 | Values: 63.0 65.0 69.0 73.0 75.0 76.0 69.0 93.0 68.0 70.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.50 stddev:10.29 (12.0%) stddev-sans-first:10.83 13:41:15 INFO - PROCESS | 1667 | Values: 85.0 85.0 83.0 75.0 96.0 97.0 75.0 86.0 96.0 107.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:139.00 stddev:14.84 (10.7%) stddev-sans-first:15.56 13:41:15 INFO - PROCESS | 1667 | Values: 136.0 141.0 136.0 134.0 139.0 135.0 139.0 138.0 184.0 142.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:169.00 stddev:23.13 (13.7%) stddev-sans-first:24.23 13:41:15 INFO - PROCESS | 1667 | Values: 168.0 166.0 170.0 237.0 201.0 167.0 167.0 172.0 167.0 168.0 13:41:15 INFO - PROCESS | 1667 | 13:41:15 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.50 stddev:5.93 (8.9%) stddev-sans-first:6.28 13:41:15 INFO - PROCESS | 1667 | Values: 66.0 67.0 67.0 66.0 68.0 64.0 65.0 61.0 64.0 83.0 13:41:15 INFO - PROCESS | 1667 | -------- Summary: end -------- 13:41:15 INFO - PROCESS | 1667 | 13:41:16 INFO - TEST-INFO | 1667: exit 0 13:41:16 INFO - TEST-OK | kraken | took 59622ms 13:41:16 INFO - SUITE-END | took 1177s 13:41:16 INFO - Completed test suite (00:19:38) 13:41:16 INFO - javascript benchmark 13:41:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.1952331440452, 3381.9492707609384, 3410.198603328219, 3432.1248081739154, 3451.7411194160427, 5703.3156021277455, 5703.429657034295, 5792.1601367801695, 5794.217780599618, 5846.941530584698, 5786.710664466781, 5814.156947242658, 5844.094165404358, 5868.970655146729, 5941.257342832146, 5331.840044798643, 5357.142857142858, 5370.248165256867, 5397.325334333208, 5419.187121931703, 5353.866153346158, 5368.087425137716, 5420.783168673268, 5441.564674826024, 5470.288862447876, 4625.69865768138, 5256.316678831747, 5406.513413792758, 5422.267993820843, 5493.121100623881, 5410.134378499461, 5417.26866872971, 5417.51242388183, 5474.069408200596, 5508.64193827404, 5145.279660847485, 5253.789848406059, 5255.474452554752, 5295.708736019517, 5342.519173274424, 5724.799632012901, 5730.541556675456, 5772.7113644317615, 5786.450287222707, 5815.941840581625, 6275.69768596682, 6282.151909492206, 6290.811275661737, 6316.652584107872, 6351.491880649537, 6200.627962322275, 6251.031090181029, 6302.432781049728, 6304.464120549759, 6323.778667746653, 4741.952580474185, 5772.769089236467, 5844.912326315109, 5848.88302233953, 5916.7337469813965, 6413.134226879405, 6429.324920883333, 6431.356864313531, 6434.64609446485, 6436.678166091677, 6265.248170219603, 6273.905891411541, 6275.0, 6276.0, 6284.874302513924, 5291.920621190685, 5517.59301378146, 5860.446981549892, 6241.75032998684, 6258.687065646699, 6132.448079672761, 6289.905651415233, 6298.622082674962, 6312.242530896322, 6316.589421687576, 6243.469305109026, 6313.494920406357, 6334.968325158345, 6349.365063493614, 6352.4918006559365, 4968.627352948543, 4993.650444468853, 5004.349434573555, 5071.594272458195, 5078.542931136141, 4481.327800829837, 4504.594586487166, 4524.47968483622, 4555.794989225493, 4584.4957054723955, 5753.424657534213, 5772.220750198753, 5786.537077033827, 5786.652800831964, 5804.2744656917885, 6209.316975132731, 6233.812985610439, 6279.4662453691035, 6309.211348581427, 6317.1156038154695, 5676.659400435987, 5708.571857110734, 5740.741666625012, 5766.336871259775, 5775.884482310415, 5504.697241651747, 5539.390667026624, 5581.246531718247, 5628.127640215773, 5632.5212356950115, 6444.45222156122, 6476.935230647633, 6497.382748638872, 6500.089987401768, 6507.446867016167, 6235.919978021574, 6245.313015568193, 6256.499480041677, 6294.590851594632, 6307.400796924285, 6314.62112273265, 6365.299817020216, 6371.617702937653, 6490.123833282447, 6497.805065848032, 6286.779962701284, 6299.559030867796, 6300.716467759054, 6306.0225665022, 6310.968445157745, 6073.848153796191, 6243.032329988859, 6284.780032698834, 6326.493880489457, 6332.493400527855, 6100.732564372456, 6138.541671868701, 6146.631202127886, 6161.045038019114, 6249.78125765596, 6219.502439804714, 6229.906551401823, 6230.283517395376, 6230.719617617127, 6241.937580624317, 6033.577649564489, 6067.969660151671, 6074.362191969956, 6098.0, 6114.847128821815, 6088.543359247986, 6120.0205129226715, 6122.7244773984385, 6143.082036032849, 6153.630782153085, 6042.1540984261355, 6068.939310606837, 6074.119252708244, 6097.573169878244, 6115.082737589397], "value": 5782.406079607918, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.877828710253, 526.1423879077104, 532.1671583971088, 537.2612657595806, 546.344386735917, 31020.914268000626, 34245.0, 41964.95087622811, 42302.94242643928, 42335.94160145998, 44148.33777493332, 44601.107977840424, 44618.776906115505, 44638.33042504365, 44732.0, 9420.63400806886, 9832.36089654172, 10030.9498452508, 10031.097201251885, 10042.949785251063, 9048.683296084639, 9971.900280997206, 9978.251631127658, 9985.051420115115, 9993.700188994342, 9959.651412200574, 9977.0, 10003.699889003341, 10018.749531261741, 10027.749306267366, 9908.455034973074, 9955.0, 9970.351927124713, 9972.401655900596, 9977.600895964153, 8295.709650162276, 9754.122129008423, 9808.754781130458, 9846.212303015742, 9870.654527091589, 41414.37878431826, 41743.582564174576, 41787.582124178676, 41811.372829407585, 41838.163236735396, 3267.754918381131, 3359.428897087501, 3428.211511352403, 3542.468629705539, 3646.6535679110443, 30730.84634576835, 31557.84221078903, 32729.509057364157, 32763.017109486755, 33312.83343583291, 3182.6658200889037, 3213.3091385352263, 3214.212517933098, 3329.96670033299, 3380.121168496184, 498308.0, 504285.0, 504612.0, 507213.0, 508205.0, 33326.0, 62515.062274065924, 63146.36853631497, 63213.051804222974, 63296.683516582125, 33923.66076339205, 35842.64157358445, 35854.565817367016, 35860.28279434397, 35922.0, 14701.897357698, 14819.40722371093, 14881.404743810126, 14893.70212595742, 14897.47858824936, 12581.685457863443, 12676.957530192873, 12677.746445071047, 12678.0, 12691.49234030647, 7824.9608751955875, 7830.373570114377, 7851.685932562747, 7901.881471777928, 7905.367570594339, 2877.1512403840916, 3223.7421006319437, 3242.238074052596, 3254.3494290440167, 3297.1427428868187, 944.3389627260945, 997.4663554998041, 1061.570064124031, 1064.1539975719322, 1125.8209110809971, 26652.866735666197, 27963.440731185263, 31317.68682313193, 32117.03648890537, 32376.315672052493, 1036.730450082984, 1045.6862941117633, 1064.3667018124204, 1065.350136416785, 1084.1706094837455, 15841.366345346058, 15881.0, 15891.967022143524, 15937.760933586005, 16263.674726505404, 696852.0, 700634.0, 701575.0, 702502.0, 703807.0, 59473.10790338148, 59981.0, 60045.0, 60053.39946600478, 60063.69968150131, 1067.5676351077982, 1238.2261086820738, 1353.5803900790786, 1368.9178649280875, 1398.0213850304826, 29558.852205738833, 29654.406911862072, 31818.36363272768, 31872.0, 32364.901814566245, 47393.52606473891, 53406.0, 53456.0, 53508.929821404134, 53532.0, 588031.0, 594359.0, 594383.0, 594565.0, 594906.0, 22590.0, 23687.1709490167, 23998.40003999914, 27001.0, 27028.32429189286, 48097.0, 49253.50746492489, 49558.0, 49634.802953570805, 49691.75770605764, 35264.64735352614, 39835.40246896357, 40015.79992100021, 40207.396889046104, 42294.36558451687, 39018.6098139015, 39468.60531394649, 39631.60368396279, 39672.60327396689, 41511.169776604904, 38258.42612360761, 39488.80255598704, 39654.80172599119, 39673.0, 39790.0, 25991.610125848507, 28162.0, 34257.65742342644, 35208.943731688094, 35459.82270088633, 25602.487950240517, 25691.35771605725, 25715.971361145344, 26142.73215848019, 26147.215583532525], "value": 18980.077822686584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.76812323450736, 361.3387500873402, 369.058899805496, 378.93179227739006, 396.5617992118709, 13976.860231397683, 14955.700885982274, 16027.919860400682, 20580.588388232227, 20901.895490522526, 19296.131674074666, 19762.604747905032, 20250.69623955642, 20452.0, 20965.790342096574, 5879.970600146993, 5958.136070269819, 6119.755209791625, 6152.784652537162, 6163.876722465548, 4814.566688997989, 6113.724882380281, 6169.660668663222, 6179.258488981329, 6190.473809726179, 5815.73829177688, 5977.8206653800235, 6132.386761323876, 6135.539834512407, 6138.386161383871, 6022.247219097613, 6065.8180254592435, 6081.574289799716, 6084.817455476321, 6096.298925623566, 5119.692818430869, 5172.732680493304, 5290.682559046431, 5414.729263536847, 5498.0, 12520.624381268577, 12757.42591583381, 12777.0, 13683.589492315246, 24314.513709725885, 2116.724825772655, 2165.7834216578217, 2381.475855452512, 2442.010985550837, 2704.837709737422, 9516.429014259167, 9569.521523923777, 9657.951710241474, 9987.500624968796, 10142.087212150867, 1577.37693611023, 1804.8736588438815, 1870.251899240301, 1882.8681992260547, 1914.626647803679, 110603.44698276457, 112856.0, 119859.0, 121122.0, 121254.39372803167, 11083.224174307721, 11172.664820055412, 11237.60668376603, 11308.943455282835, 11445.542178312775, 14074.507392241223, 14077.788833167511, 14090.436382544789, 14103.85896141046, 14108.788368174486, 8308.210719981593, 8452.450590711584, 8474.237318641352, 8611.440256383315, 8625.827483450295, 8110.3511719062335, 8178.223068808454, 8205.302549283258, 8294.792630184294, 8591.312694984386, 4338.3709362142945, 4408.933865992013, 4417.580329868657, 4491.842785502492, 4541.296099104644, 1336.4520546576052, 1813.4015774794286, 1831.44141036985, 1877.5963167918962, 1883.161992913168, 370.38146295686266, 374.096556815288, 386.8607301371504, 795.8766391209372, 898.2589363774912, 11528.308301501937, 11616.651500455, 11643.88356116445, 11734.178607497564, 11876.931076203184, 412.6966679490572, 417.1510975165584, 432.1292595420231, 433.20290665176225, 451.96610254231064, 5604.271444712243, 5731.140328950691, 5913.497352725067, 6054.091886217103, 6125.9693701531205, 593970.0, 606645.5680380762, 617128.0, 624834.7516524867, 626752.0, 79267.0, 84917.15082849216, 113927.0, 137992.31003844916, 141610.79529830528, 418.39541862009105, 439.7691212113602, 440.7509756987292, 440.7663938112805, 441.44818976280294, 7476.962615186889, 8661.307095432476, 9623.807523849624, 9974.40153590787, 10337.793244134924, 52199.0, 53343.4665653354, 53412.39762807122, 54914.45085549093, 55464.44535554754, 77016.0, 78159.60920195363, 78824.0, 81131.5943420279, 89082.55458722665, 8867.91132088671, 11177.497012634614, 11324.773504530029, 11584.304941703525, 11759.235649682743, 11019.779604407706, 13139.73720525565, 13252.933735331262, 13305.53430629962, 13560.59318220455, 11142.442877855912, 11361.02364172566, 11443.771124577628, 11491.195616306779, 11701.356425396685, 11098.334099953705, 11249.943750281196, 11308.547658093585, 11695.88304116948, 11794.056475482112, 10804.891951080703, 11208.88791112111, 11239.157063220127, 11827.763444731228, 11948.701282468008, 11784.941075294912, 11930.701732456759, 11961.282323060645, 12009.459574319351, 12086.0, 7641.732539361318, 7675.309222170032, 11023.83464248021, 11376.54493820238, 11518.314139475287], "value": 8498.516286122627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.1989985357832, 1547.3269127929352, 1723.4484964811259, 1832.3403574713109, 1892.2620178130533, 7958.840823183533, 8173.632186551605, 8386.62260198291, 8921.241694455972, 8923.419977701446, 8013.599320034004, 8529.275011624004, 8684.609192586333, 8696.652133914651, 8828.60271287792, 2284.18911286493, 2315.4674424882287, 2318.826088043395, 2320.2923108451914, 2321.1759825261956, 1960.7353007343968, 2004.1782869023702, 2218.5784700906775, 2314.259436980167, 2318.7565305642834, 2096.3815674376096, 2099.464636517686, 2254.9098036078535, 2321.5240875620457, 2325.720913490375, 1932.6134773045376, 2021.0501064499808, 2307.861528308307, 2311.2026350909077, 2314.1784666443423, 1968.9507762305914, 2136.83973701973, 2295.8737269450176, 2297.1959814065112, 2297.3682237384687, 7669.6932122715025, 8861.468311901242, 8876.068012858686, 8886.777830554223, 8887.24458421035, 5093.592512598983, 5270.604704647167, 5272.2355258487305, 5284.471552844723, 5300.761465734051, 2899.623049003616, 3406.7615266931325, 3407.727381809449, 3612.5123108380294, 3623.2028953630424, 1083.2417307884512, 1089.2647462962468, 1094.162965331522, 1114.1922106472823, 1115.0354942974268, 11537.653870383901, 11669.299842009506, 11690.883091169064, 11691.41542922859, 11711.297322160612, 4438.334249862482, 4477.0, 4649.279361698942, 4658.697184683053, 4658.720476771405, 9933.850992235122, 9946.0, 9950.203983681287, 9956.203503719686, 9971.102600765966, 5253.343332083489, 5264.526192642604, 5265.236540701577, 5268.473152684701, 5272.736363181903, 4700.153972284953, 4739.360186374795, 4834.540718631724, 4843.709377437365, 4851.902961940741, 3886.7279290449396, 3893.9415908761393, 3911.902202444962, 3975.403689446606, 4027.6979226558124, 1282.7755142849965, 1298.7142828577698, 1299.5581502289267, 1315.953941612039, 1318.406716977364, 644.4844124700221, 780.5589841739512, 818.2635627934907, 858.5149390594295, 882.580774132282, 5619.690916999522, 5757.107648314518, 5956.13636022783, 5986.431289027535, 6019.849503762353, 792.6762306947412, 895.2837729816121, 968.4092703450889, 983.5573991703762, 999.7900440907491, 3332.783369081002, 3672.687821535146, 3968.3849003404516, 3995.001249687578, 4070.2673518766314, 10412.271141020208, 10650.360978341168, 10720.785584288427, 10752.569897204025, 10801.189910756724, 10686.412247326316, 10698.251122421356, 10713.0, 10726.0, 10729.463526823627, 8137.511749295061, 8259.050209226016, 8265.214804593554, 8266.04940431858, 8299.917000829915, 5197.648611360998, 5211.635185536976, 5260.974110048657, 5521.365043020104, 5889.676067816311, 9486.620535178792, 9931.056549627774, 9979.0, 10041.49792510357, 10148.391096534231, 9776.657816976372, 9819.16537094355, 10129.290949633454, 10142.847857282295, 10293.691189264335, 5912.408759124053, 7356.889646655198, 7410.036695229801, 7486.0, 7497.137829149718, 7967.56178410193, 8128.83742325162, 8132.390070744599, 8135.30849877767, 8135.83728325442, 7278.890816637649, 7445.329920307198, 7449.0, 7498.0, 7568.659410326439, 7218.386437152691, 7231.023811785341, 7258.818529536804, 7354.558726476428, 7443.032405787213, 6716.0, 6844.076049733421, 6943.756968506078, 6946.37482626566, 6983.546069505466, 4957.851264462072, 4977.9751101244265, 5038.798448062036, 5055.87360315995, 5108.56577190943, 3885.378339465672, 4978.014762937461, 5051.898962020812, 5190.688558686491, 5219.034478621315], "value": 4503.87292759491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9541271102979, 298.05813628932566, 304.5203804008687, 308.1771669642055, 308.3570754975874, 5145.614078944075, 5180.844574662766, 5334.146536554152, 5388.0570900092525, 5420.0, 4846.903061938768, 5356.437574054727, 5367.46325367463, 5373.408925018245, 5375.6774593524415, 3188.4260833050043, 3353.7758718067853, 3936.4488971544006, 4038.8788336349958, 4117.238310912491, 4089.20260549193, 4096.5903409659095, 4111.280525907954, 4146.5853414658595, 4179.226843034034, 3756.8685096021645, 3900.2004589059175, 4067.6542493888055, 4068.6745060395247, 4122.0, 3858.2862170498265, 4048.1903619275968, 4105.527864295599, 4109.2808758467145, 4122.525909520414, 2697.8651067446744, 3448.5689288838894, 3519.665631764978, 3529.0, 3533.8939831805087, 4783.354247176621, 5160.535551800356, 5233.319668443078, 5256.658317209369, 5278.996990571779, 4310.44823863409, 4368.864095335204, 4618.676692631517, 4618.792154353062, 4628.675992680513, 4340.435743353375, 4931.301523857107, 5499.7250137493365, 5639.492445679908, 5677.233573467571, 3827.8660246891504, 3832.5784163741964, 3841.308564458396, 3843.481130047464, 3847.8653247136494, 4975.601951843843, 5609.551235901159, 5747.540196784247, 5838.328592211908, 5871.500922421556, 3447.5690538682666, 3650.361186792301, 3893.610638936084, 3913.1412579025305, 3914.7668484427313, 3576.302620988934, 3716.4611131385795, 3978.602139785998, 3979.9403008954887, 3980.2238563479846, 4397.560243975577, 4621.237495813153, 4623.676342655982, 4642.65180111493, 4650.139724150975, 4756.524347565216, 5356.3127614801215, 5516.724163791794, 5656.575756818255, 5781.277340332458, 1336.9304556354878, 1347.3128704360847, 1350.4598160735588, 1354.5936219134417, 1362.271184916065, 681.4582406986458, 699.762080892499, 781.5935713428985, 822.5358861227025, 835.4319063037071, 4379.4525684289465, 4473.2842745160615, 4921.876953076202, 5106.7191304477865, 5223.582113430993, 5820.76716931318, 5822.563307751935, 5824.708764561755, 5833.50415214703, 5850.385709500526, 4891.413030436371, 5140.485951404904, 5210.348706411699, 5253.789848406021, 5265.315508983807, 2669.826461280011, 3022.712842280024, 3041.0420717473926, 3052.725254727085, 3061.525463553153, 6020.367861374581, 6027.969860150759, 6032.577719559588, 6067.483129217696, 6114.205153330038, 5465.726713664301, 5496.065668836308, 5745.971270143623, 5921.430820832483, 6059.48494377974, 4933.901321973541, 4956.628252880976, 5308.336457942757, 5381.416919878402, 5856.297244330623, 4468.374427580206, 5092.955944031539, 5262.605304602093, 5455.754491047833, 5794.246747922743, 5648.80842324102, 5697.601167918206, 5778.36437991829, 5782.277215348082, 5790.392008839011, 6077.331493535796, 6078.331383547717, 6080.628554863695, 6090.390960903874, 6091.725872335667, 3462.9826850865584, 3677.2461645363173, 3811.904702382463, 3841.193349396658, 3874.9225015500097, 5234.7906083756225, 5791.9131213031, 5832.650040997553, 5848.590598658053, 5850.869784665184, 5298.377303234924, 5693.9430605693415, 5709.65742055478, 5709.8287051388525, 5750.856228594319, 4677.836275730333, 5386.48828361305, 5589.385167631639, 5608.383077861514, 5733.989655430765, 5434.880396645232, 5511.724413779375, 5522.696251706195, 5525.309336332958, 5572.554195664418, 5367.745546870402, 5393.8921221574565, 5514.726087282388, 5659.849257282206, 5692.669788173965, 4984.925226121683, 5290.624437646163, 5465.207544906046, 5501.587380946525, 5589.329280486368], "value": 4088.1747018218934, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.9465290103242, 727.6798208788136, 732.8570928668912, 794.3922898982283, 816.5468165168332, 15242.771358429618, 16280.83719162808, 16304.0, 16304.673906521863, 16349.0, 14473.42106315746, 14556.0, 14571.19858407787, 14574.489892853751, 14609.707805843904, 664.4153145232189, 683.8187880211748, 686.2005763285791, 835.862082756346, 841.1126261793805, 845.3997661660229, 848.3382961290173, 856.4604299291437, 857.2327766648846, 858.8754630578562, 917.2616044084509, 923.1091996223643, 925.2274350916992, 925.3476299209042, 925.8240934222476, 920.516728717422, 920.6363486422858, 920.7237828651445, 920.7744102694849, 924.1451657217048, 525.3065952942118, 542.3708498142175, 658.7233361987977, 677.857649893523, 682.1405029662611, 14912.17983010934, 14929.328180231916, 14929.477468288558, 14932.701345973128, 14978.325975331136, 12856.421461034182, 12900.935495322557, 12916.935415322958, 13119.147255428463, 13470.932645336808, 10851.83722244159, 12049.397530123459, 12719.936400318033, 13080.018998575146, 13214.0, 4323.647991102474, 4483.170613436492, 4509.7970591323465, 4618.838340658061, 4637.0, 82534.0, 114274.42862785632, 114887.0, 115021.0, 124448.75551244462, 10879.184061195441, 10980.835287470534, 11414.600488983011, 11503.76992460163, 11611.361375124281, 22513.0, 22521.662175067388, 22562.435939101655, 22566.548669026855, 22578.548429031656, 7823.2567906048835, 7850.56821874791, 7865.606719663994, 8126.2686358226865, 8151.144129866398, 4318.157959197989, 4386.605205531454, 4413.315936029856, 4536.092781443725, 4591.770411479412, 3131.921701957424, 3204.1188673114616, 3210.1172177651333, 3213.935721285561, 3220.1949512621845, 634.7587916591758, 641.5701480008405, 653.7809833705667, 667.4993754683987, 671.4024518178825, 588.4204059001879, 619.1301221783401, 621.3103455164763, 627.50427162542, 639.0956796133512, 8534.530600817016, 8784.736457906272, 8925.509096999727, 8927.866082008775, 9058.728238152866, 598.775459202799, 600.5465873265744, 620.7858288890326, 623.1894157350292, 635.5900444213456, 3681.006128345385, 4047.352423612208, 4375.496817865923, 4464.419625448736, 4509.751963642031, 122297.38851305687, 135573.0, 139554.30222849024, 176588.0, 177207.0, 147408.0, 147592.2620386891, 148894.25552872167, 151202.0, 151302.0, 79070.81393779213, 97726.0, 99500.03499754948, 122578.0, 128768.0, 8396.622152003052, 9363.896676311291, 9524.952375238357, 9811.705648830546, 9969.95315491892, 48958.0, 57152.142067924695, 63409.0, 65179.0, 65827.67086164538, 60730.39269607247, 61210.0, 63458.730825384155, 89703.10296896947, 100616.49075264024, 12815.551455699006, 12832.871671283541, 12929.224246545238, 13056.34718264102, 13075.82602798469, 14540.200288983784, 14815.703685926437, 15023.924880375529, 15091.54725358241, 15329.38682452734, 9915.950420247853, 11828.70428239301, 12102.455389507317, 12172.817407738714, 12403.0, 13459.730805384033, 13622.0, 13706.109102908278, 13800.93099534496, 13851.722965540834, 13014.674633134247, 13320.800187997382, 13676.521321753691, 13866.43896820796, 13962.441502339792, 9108.998010218738, 9502.0, 10200.897991020292, 10459.372437653461, 11002.559897604006, 10920.617778377718, 10943.671689849318, 11070.335779853234, 11230.55077796879, 11267.380294083903], "value": 7720.761009084332, "unit": "score"}], "name": "dromaeo_css", "value": 7141.0390804569315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 116.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 122.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 130.0, 162.0, 107.0, 132.0, 131.0, 111.0, 159.0, 108.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 211.0, 256.0, 185.0, 183.0, 183.0, 183.0, 183.0, 181.0, 181.0], "value": 193.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 148.0, 57.0, 57.0, 57.0, 67.0, 139.0, 57.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 136.0, 70.0, 78.0, 79.0, 116.0, 69.0, 70.0, 119.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 132.0, 136.0, 89.0, 91.0, 89.0, 92.0, 88.0, 91.0, 88.0], "value": 99.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 101.0, 144.0, 95.0, 102.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 85.0, 84.0, 83.0, 85.0, 95.0, 137.0, 144.0, 95.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 54.0, 73.0, 82.0, 82.0, 82.0, 53.0, 54.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 69.0, 73.0, 75.0, 76.0, 69.0, 93.0, 68.0, 70.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 75.0, 96.0, 97.0, 75.0, 86.0, 96.0, 107.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 136.0, 134.0, 139.0, 135.0, 139.0, 138.0, 184.0, 142.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 170.0, 237.0, 201.0, 167.0, 167.0, 172.0, 167.0, 168.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 68.0, 64.0, 65.0, 61.0, 64.0, 83.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1518.3, "alertThreshold": 2.0}]} 13:41:16 INFO - Return code: 0 13:41:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:41:16 INFO - # TBPL SUCCESS # 13:41:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:41:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:41:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:41:16 INFO - 2016-09-12 13:41:16.899 screenresolution[1671:10327] starting screenresolution argv=screenresolution get 13:41:16 INFO - 2016-09-12 13:41:16.901 screenresolution[1671:10327] Display 0: 1600x1200x32@60 13:41:16 INFO - 2016-09-12 13:41:16.907 screenresolution[1672:10331] starting screenresolution argv=screenresolution list 13:41:16 INFO - Available Modes on Display 0 13:41:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:41:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:41:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:41:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:41:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:41:17 INFO - Intel Iris: 13:41:17 INFO - Chipset Model: Intel Iris 13:41:17 INFO - Type: GPU 13:41:17 INFO - Bus: Built-In 13:41:17 INFO - VRAM (Dynamic, Max): 1536 MB 13:41:17 INFO - Vendor: Intel (0x8086) 13:41:17 INFO - Device ID: 0x0a2e 13:41:17 INFO - Revision ID: 0x0009 13:41:17 INFO - Displays: 13:41:17 INFO - Display: 13:41:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:41:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:41:17 INFO - Display Serial Number: 1600x1200 60 13:41:17 INFO - Main Display: Yes 13:41:17 INFO - Mirror: Off 13:41:17 INFO - Online: Yes 13:41:17 INFO - Rotation: Supported 13:41:17 INFO - Return code: 0 13:41:17 INFO - Running post-action listener: _resource_record_post_action 13:41:17 INFO - [mozharness: 2016-09-12 20:41:17.142046Z] Finished run-tests step (success) 13:41:17 INFO - Running post-run listener: _resource_record_post_run 13:41:17 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 31951872; Write bytes: 704641024; Read time: 199; Write time: 2025 13:41:17 INFO - TinderboxPrint: CPU usage
53.5% 13:41:17 INFO - TinderboxPrint: I/O read bytes / time
31,951,872 / 199 13:41:17 INFO - TinderboxPrint: I/O write bytes / time
704,641,024 / 2,025 13:41:17 INFO - TinderboxPrint: CPU idle
2,256.6 (46.5%) 13:41:17 INFO - TinderboxPrint: CPU system
975.8 (20.1%) 13:41:17 INFO - TinderboxPrint: CPU user
1,625.3 (33.5%) 13:41:17 INFO - TinderboxPrint: Swap in / out
432,984,064 / 0 13:41:17 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 393288192; Write bytes: 391552512; Read time: 29951; Write time: 872 13:41:17 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30182400; Write bytes: 295451136; Read time: 184; Write time: 1114 13:41:17 INFO - Running post-run listener: _upload_blobber_files 13:41:17 INFO - Blob upload gear active. 13:41:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:41: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 13:41: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'] 13:41: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 13:41:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:41:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:19 INFO - (blobuploader) - INFO - Done attempting. 13:41:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:41:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:41:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:20 INFO - (blobuploader) - INFO - Done attempting. 13:41:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:41:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:41:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:23 INFO - (blobuploader) - INFO - Done attempting. 13:41:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:41:23 INFO - Return code: 0 13:41:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:41:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:41:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be0a99fa5d0c8312e390d18c15ef633209be0ebfcc49c9f582e050047bbb044c907f2286527976149862eb8122125ad0b248225bcf1b2cb92754de68e5dca456", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fde64dadb5dd5a42afd5128209d3e192ad243f9f04f7725316dc4e6fa1858f96f8da69d85c692a48ea3681c18a1d3853822d35a456443788775c743316acbd00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61f92b9e83e3437eff4a7d74a6fb99a087ca32cb33a21db97090b7974683ede2721c16979a45ee6a97cae1cea2b8500cf8b1ec04a8d0b37ed075f1d91803df57"} 13:41:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:41:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:41:23 INFO - Contents: 13:41:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be0a99fa5d0c8312e390d18c15ef633209be0ebfcc49c9f582e050047bbb044c907f2286527976149862eb8122125ad0b248225bcf1b2cb92754de68e5dca456", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fde64dadb5dd5a42afd5128209d3e192ad243f9f04f7725316dc4e6fa1858f96f8da69d85c692a48ea3681c18a1d3853822d35a456443788775c743316acbd00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61f92b9e83e3437eff4a7d74a6fb99a087ca32cb33a21db97090b7974683ede2721c16979a45ee6a97cae1cea2b8500cf8b1ec04a8d0b37ed075f1d91803df57"} 13:41:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:41:23 INFO - Copying logs to upload dir... 13:41:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:41:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.524284 ========= master_lag: 1.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-09-12 13:41:25.593720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 13:41:25.598029) ========= 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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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/be0a99fa5d0c8312e390d18c15ef633209be0ebfcc49c9f582e050047bbb044c907f2286527976149862eb8122125ad0b248225bcf1b2cb92754de68e5dca456", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fde64dadb5dd5a42afd5128209d3e192ad243f9f04f7725316dc4e6fa1858f96f8da69d85c692a48ea3681c18a1d3853822d35a456443788775c743316acbd00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61f92b9e83e3437eff4a7d74a6fb99a087ca32cb33a21db97090b7974683ede2721c16979a45ee6a97cae1cea2b8500cf8b1ec04a8d0b37ed075f1d91803df57"} build_url:https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011032 build_url: 'https://queue.taskcluster.net/v1/task/J6Li83LnTVmvbR1OHYL_KA/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/be0a99fa5d0c8312e390d18c15ef633209be0ebfcc49c9f582e050047bbb044c907f2286527976149862eb8122125ad0b248225bcf1b2cb92754de68e5dca456", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fde64dadb5dd5a42afd5128209d3e192ad243f9f04f7725316dc4e6fa1858f96f8da69d85c692a48ea3681c18a1d3853822d35a456443788775c743316acbd00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61f92b9e83e3437eff4a7d74a6fb99a087ca32cb33a21db97090b7974683ede2721c16979a45ee6a97cae1cea2b8500cf8b1ec04a8d0b37ed075f1d91803df57"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 13:41:25.639278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 13:41:25.639693) ========= 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.fWP6pWhFs8/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.JSQtnZ0YAA/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.005087 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 13:41:25.688402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 13:41:25.690422) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 13:41:25.690801) ========= ========= Total master_lag: 2.05 =========