builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0119 starttime: 1473767335.34 results: success (0) buildid: 20160913025909 builduid: d5bb5d1a2c48440cb41d9eec6131c1d7 revision: f5d043ce6d36a3c461cbd829d4a4a38394b7c436 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:55.338612) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:55.338995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:55.339288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:55.363654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:55.364347) ========= 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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-13 04:48:55-- 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% 9.71M=0.001s 2016-09-13 04:48:55 (9.71 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098244 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:55.489966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:55.490688) ========= 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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.026898 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:55.544101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 04:48:55.544483) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f5d043ce6d36a3c461cbd829d4a4a38394b7c436 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f5d043ce6d36a3c461cbd829d4a4a38394b7c436 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vIb6RvHg3O/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.0pwNuDOUDu/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-13 04:48:55,620 truncating revision to first 12 chars 2016-09-13 04:48:55,621 Setting DEBUG logging. 2016-09-13 04:48:55,621 attempt 1/10 2016-09-13 04:48:55,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f5d043ce6d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 04:48:57,061 unpacking tar archive at: mozilla-central-f5d043ce6d36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.713902 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 04:48:57.284950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:57.285676) ========= script_repo_revision: f5d043ce6d36a3c461cbd829d4a4a38394b7c436 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:57.286565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:57.287189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 04:48:57.308916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-13 04:48:57.309609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vIb6RvHg3O/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.0pwNuDOUDu/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:48:57 INFO - MultiFileLogger online at 20160913 04:48:57 in /builds/slave/test 04:48:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:48:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:57 INFO - {'append_to_log': False, 04:48:57 INFO - 'base_work_dir': '/builds/slave/test', 04:48:57 INFO - 'blob_upload_branch': 'Firefox', 04:48:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:57 INFO - 'branch': 'Firefox', 04:48:57 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:57 INFO - 'config_files': ('talos/mac_config.py',), 04:48:57 INFO - 'default_actions': ('clobber', 04:48:57 INFO - 'read-buildbot-config', 04:48:57 INFO - 'download-and-extract', 04:48:57 INFO - 'populate-webroot', 04:48:57 INFO - 'create-virtualenv', 04:48:57 INFO - 'install', 04:48:57 INFO - 'run-tests'), 04:48:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:57 INFO - 'download_minidump_stackwalk': True, 04:48:57 INFO - 'download_symbols': 'ondemand', 04:48:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:57 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:57 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:57 INFO - 'installer_path': 'installer.exe', 04:48:57 INFO - 'log_level': 'info', 04:48:57 INFO - 'log_name': 'talos', 04:48:57 INFO - 'log_to_console': True, 04:48:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:48:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:48:57 INFO - 'opt_config_files': (), 04:48:57 INFO - 'pip_index': False, 04:48:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:57 INFO - 'cmd': ('bash', 04:48:57 INFO - '-c', 04:48:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:57 INFO - 'enabled': True, 04:48:57 INFO - 'halt_on_failure': False, 04:48:57 INFO - 'name': 'check_screen_resolution'},), 04:48:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:57 INFO - 'cmd': ('bash', 04:48:57 INFO - '-c', 04:48:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:57 INFO - 'enabled': True, 04:48:57 INFO - 'halt_on_failure': False, 04:48:57 INFO - 'name': 'check_screen_resolution'},), 04:48:57 INFO - 'run_cmd_checks_enabled': True, 04:48:57 INFO - 'sps_profile': False, 04:48:57 INFO - 'sps_profile_interval': 0, 04:48:57 INFO - 'suite': 'dromaeojs', 04:48:57 INFO - 'system_bits': '32', 04:48:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:57 INFO - 'title': 't-yosemite-r7-0119', 04:48:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:57 INFO - 'use_talos_json': True, 04:48:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:57 INFO - 'work_dir': 'build'} 04:48:57 INFO - [mozharness: 2016-09-13 11:48:57.526521Z] Running clobber step. 04:48:57 INFO - Running pre-action listener: _resource_record_pre_action 04:48:57 INFO - Running main action method: clobber 04:48:57 INFO - rmtree: /builds/slave/test/build 04:48:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:59 INFO - Running post-action listener: _resource_record_post_action 04:48:59 INFO - [mozharness: 2016-09-13 11:48:59.769597Z] Finished clobber step (success) 04:48:59 INFO - [mozharness: 2016-09-13 11:48:59.769787Z] Running read-buildbot-config step. 04:48:59 INFO - Running pre-action listener: _resource_record_pre_action 04:48:59 INFO - Running main action method: read_buildbot_config 04:48:59 INFO - Using buildbot properties: 04:48:59 INFO - { 04:48:59 INFO - "project": "", 04:48:59 INFO - "product": "firefox", 04:48:59 INFO - "script_repo_revision": "production", 04:48:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:48:59 INFO - "repository": "", 04:48:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:48:59 INFO - "buildid": "20160913025909", 04:48:59 INFO - "pgo_build": "False", 04:48:59 INFO - "basedir": "/builds/slave/test", 04:48:59 INFO - "buildnumber": 57, 04:48:59 INFO - "slavename": "t-yosemite-r7-0119", 04:48:59 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:48:59 INFO - "platform": "yosemite_r7", 04:48:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:48:59 INFO - "branch": "mozilla-central", 04:48:59 INFO - "repo_path": "mozilla-central", 04:48:59 INFO - "revision": "f5d043ce6d36a3c461cbd829d4a4a38394b7c436", 04:48:59 INFO - "stage_platform": "macosx64", 04:48:59 INFO - "builduid": "d5bb5d1a2c48440cb41d9eec6131c1d7", 04:48:59 INFO - "slavebuilddir": "test" 04:48:59 INFO - } 04:48:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:48:59 INFO - Running post-action listener: _resource_record_post_action 04:48:59 INFO - [mozharness: 2016-09-13 11:48:59.773112Z] Finished read-buildbot-config step (success) 04:48:59 INFO - [mozharness: 2016-09-13 11:48:59.773246Z] Running download-and-extract step. 04:48:59 INFO - Running pre-action listener: _resource_record_pre_action 04:48:59 INFO - Running main action method: download_and_extract 04:48:59 INFO - mkdir: /builds/slave/test/build/tests 04:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:59 INFO - trying https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:48:59 INFO - Downloading https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/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 04:48:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/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 04:49:01 INFO - Downloaded 1199 bytes. 04:49:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:49:01 INFO - Using the following test package requirements: 04:49:01 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:49:01 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:49:01 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:49:01 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:49:01 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:49:01 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:49:01 INFO - u'jsshell-mac.zip'], 04:49:01 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:49:01 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:49:01 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:49:01 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:49:01 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:49:01 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:49:01 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:49:01 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:49:01 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:49:01 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:49:01 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:49:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:49:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:49:01 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 04:49:08 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 04:49:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:49:09 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 04:49:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:49:17 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 04:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:17 INFO - trying https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:49:17 INFO - Downloading https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/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 04:49:20 INFO - Downloaded 111403283 bytes. 04:49:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:49:20 INFO - mkdir: /builds/slave/test/properties 04:49:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:20 INFO - Contents: 04:49:20 INFO - build_url:https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:49:21 INFO - Running post-action listener: _resource_record_post_action 04:49:21 INFO - Running post-action listener: set_extra_try_arguments 04:49:21 INFO - [mozharness: 2016-09-13 11:49:21.246991Z] Finished download-and-extract step (success) 04:49:21 INFO - [mozharness: 2016-09-13 11:49:21.247137Z] Running populate-webroot step. 04:49:21 INFO - Running pre-action listener: _resource_record_pre_action 04:49:21 INFO - Running main action method: populate_webroot 04:49:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:21 INFO - '--tppagecycles', 04:49:21 INFO - '7'], 04:49:21 INFO - 'tests': ['tsvgm']}}, 04:49:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:21 INFO - 'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:21 INFO - 'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['damp', 'tps']}, 04:49:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:21 INFO - 'tests': ['damp', 'tps']}, 04:49:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['dromaeo_dom']}, 04:49:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['basic_compositor_video']}, 04:49:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:49:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['a11yr', 04:49:21 INFO - 'ts_paint', 04:49:21 INFO - 'tpaint', 04:49:21 INFO - 'sessionrestore', 04:49:21 INFO - 'sessionrestore_no_auto_restore', 04:49:21 INFO - 'tabpaint']}, 04:49:21 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:21 INFO - 'ts_paint', 04:49:21 INFO - 'tpaint', 04:49:21 INFO - 'sessionrestore', 04:49:21 INFO - 'sessionrestore_no_auto_restore', 04:49:21 INFO - 'tabpaint']}, 04:49:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:21 INFO - 'ts_paint', 04:49:21 INFO - 'tpaint', 04:49:21 INFO - 'sessionrestore', 04:49:21 INFO - 'sessionrestore_no_auto_restore', 04:49:21 INFO - 'tabpaint']}, 04:49:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:21 INFO - 'ts_paint', 04:49:21 INFO - 'tpaint', 04:49:21 INFO - 'sessionrestore', 04:49:21 INFO - 'sessionrestore_no_auto_restore', 04:49:21 INFO - 'tabpaint']}, 04:49:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['a11yr', 04:49:21 INFO - 'ts_paint', 04:49:21 INFO - 'tpaint', 04:49:21 INFO - 'sessionrestore', 04:49:21 INFO - 'sessionrestore_no_auto_restore', 04:49:21 INFO - 'tabpaint']}, 04:49:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['a11yr', 04:49:21 INFO - 'ts_paint', 04:49:21 INFO - 'tpaint', 04:49:21 INFO - 'sessionrestore', 04:49:21 INFO - 'sessionrestore_no_auto_restore', 04:49:21 INFO - 'tabpaint']}, 04:49:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['tsvgx', 04:49:21 INFO - 'tsvgr_opacity', 04:49:21 INFO - 'tart', 04:49:21 INFO - 'tscrollx', 04:49:21 INFO - 'cart']}, 04:49:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:21 INFO - 'tsvgr_opacity', 04:49:21 INFO - 'tart', 04:49:21 INFO - 'tscrollx', 04:49:21 INFO - 'cart']}, 04:49:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:21 INFO - 'talos_options': ['--disable-e10s'], 04:49:21 INFO - 'tests': ['tp5o']}, 04:49:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:21 INFO - 'tests': ['tp5o']}, 04:49:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:21 INFO - 'talos_options': ['--disable-e10s', 04:49:21 INFO - '--xperf_path', 04:49:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:21 INFO - 'tests': ['tp5n']}, 04:49:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:21 INFO - 'talos_options': ['--xperf_path', 04:49:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:21 INFO - 'tests': ['tp5n']}}, 04:49:21 INFO - 'talos.zip': {'path': '', 04:49:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:21 INFO - Running post-action listener: _resource_record_post_action 04:49:21 INFO - [mozharness: 2016-09-13 11:49:21.265880Z] Finished populate-webroot step (success) 04:49:21 INFO - [mozharness: 2016-09-13 11:49:21.265997Z] Running create-virtualenv step. 04:49:21 INFO - Running pre-action listener: _resource_record_pre_action 04:49:21 INFO - Running main action method: create_virtualenv 04:49:21 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:21 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 04:49:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:21 INFO - Using real prefix '/tools/python27' 04:49:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:22 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:24 INFO - Installing pip.................done. 04:49:24 INFO - Return code: 0 04:49:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:49:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:24 INFO - 'HOME': '/Users/cltbld', 04:49:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:24 INFO - 'LOGNAME': 'cltbld', 04:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:24 INFO - 'MOZ_NO_REMOTE': '1', 04:49:24 INFO - 'NO_EM_RESTART': '1', 04:49:24 INFO - 'PAGER': '/bin/cat', 04:49:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:24 INFO - 'PWD': '/builds/slave/test', 04:49:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:24 INFO - 'SHELL': '/bin/bash', 04:49:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:24 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:24 INFO - 'USER': 'cltbld', 04:49:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:24 INFO - 'XPC_FLAGS': '0x0', 04:49:24 INFO - 'XPC_SERVICE_NAME': '0', 04:49:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:25 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 04:49:25 INFO - Cleaning up... 04:49:25 INFO - Return code: 0 04:49:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49:25 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')]} 04:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:25 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')]} 04:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:25 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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49:25 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 04:49:25 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 04:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:25 INFO - 'HOME': '/Users/cltbld', 04:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:25 INFO - 'LOGNAME': 'cltbld', 04:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:25 INFO - 'MOZ_NO_REMOTE': '1', 04:49:25 INFO - 'NO_EM_RESTART': '1', 04:49:25 INFO - 'PAGER': '/bin/cat', 04:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:25 INFO - 'PWD': '/builds/slave/test', 04:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:25 INFO - 'SHELL': '/bin/bash', 04:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:25 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:25 INFO - 'USER': 'cltbld', 04:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:25 INFO - 'XPC_FLAGS': '0x0', 04:49:25 INFO - 'XPC_SERVICE_NAME': '0', 04:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:25 INFO - Downloading/unpacking psutil>=3.1.1 04:49:25 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 04:49:25 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 04:49:25 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 04:49:25 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 04:49:25 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 04:49:25 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 04:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:28 INFO - Installing collected packages: psutil 04:49:28 INFO - Running setup.py install for psutil 04:49:28 INFO - building 'psutil._psutil_osx' extension 04:49:28 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 04:49:29 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 04:49:29 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 04:49:29 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 04:49:29 INFO - building 'psutil._psutil_posix' extension 04:49:29 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 04:49:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:49:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:49:29 INFO - ^ 04:49:29 INFO - 1 warning generated. 04:49:29 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 04:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:30 INFO - Successfully installed psutil 04:49:30 INFO - Cleaning up... 04:49:30 INFO - Return code: 0 04:49:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:30 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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49:30 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 04:49:30 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 04:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:30 INFO - 'HOME': '/Users/cltbld', 04:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:30 INFO - 'LOGNAME': 'cltbld', 04:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:30 INFO - 'MOZ_NO_REMOTE': '1', 04:49:30 INFO - 'NO_EM_RESTART': '1', 04:49:30 INFO - 'PAGER': '/bin/cat', 04:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:30 INFO - 'PWD': '/builds/slave/test', 04:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:30 INFO - 'SHELL': '/bin/bash', 04:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:30 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:30 INFO - 'USER': 'cltbld', 04:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:30 INFO - 'XPC_FLAGS': '0x0', 04:49:30 INFO - 'XPC_SERVICE_NAME': '0', 04:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49:30 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 04:49:30 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 04:49:30 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 04:49:30 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 04:49:30 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 04:49:30 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 04:49:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:32 INFO - Installing collected packages: mozsystemmonitor 04:49:32 INFO - Running setup.py install for mozsystemmonitor 04:49:33 INFO - Successfully installed mozsystemmonitor 04:49:33 INFO - Cleaning up... 04:49:33 INFO - Return code: 0 04:49:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:33 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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49:33 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 04:49:33 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 04:49:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:33 INFO - 'HOME': '/Users/cltbld', 04:49:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:33 INFO - 'LOGNAME': 'cltbld', 04:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:33 INFO - 'MOZ_NO_REMOTE': '1', 04:49:33 INFO - 'NO_EM_RESTART': '1', 04:49:33 INFO - 'PAGER': '/bin/cat', 04:49:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:33 INFO - 'PWD': '/builds/slave/test', 04:49:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:33 INFO - 'SHELL': '/bin/bash', 04:49:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:33 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:33 INFO - 'USER': 'cltbld', 04:49:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:33 INFO - 'XPC_FLAGS': '0x0', 04:49:33 INFO - 'XPC_SERVICE_NAME': '0', 04:49:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:33 INFO - Downloading/unpacking jsonschema==2.5.1 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49:35 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 04:49:35 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 04:49:35 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 04:49:35 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 04:49:35 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 04:49:35 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 04:49:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:36 INFO - warning: no files found matching '*.txt' 04:49:36 INFO - no previously-included directories found matching 'build' 04:49:36 INFO - no previously-included directories found matching 'dist' 04:49:36 INFO - no previously-included directories found matching '.git*' 04:49:36 INFO - Installing collected packages: jsonschema, functools32 04:49:36 INFO - Running setup.py install for functools32 04:49:36 INFO - warning: no files found matching '*.txt' 04:49:36 INFO - no previously-included directories found matching 'build' 04:49:36 INFO - no previously-included directories found matching 'dist' 04:49:36 INFO - no previously-included directories found matching '.git*' 04:49:36 INFO - Successfully installed jsonschema functools32 04:49:36 INFO - Cleaning up... 04:49:36 INFO - Return code: 0 04:49:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', '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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:49: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 functools32==3.2.3-2 04:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:36 INFO - 'HOME': '/Users/cltbld', 04:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:36 INFO - 'LOGNAME': 'cltbld', 04:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:36 INFO - 'MOZ_NO_REMOTE': '1', 04:49:36 INFO - 'NO_EM_RESTART': '1', 04:49:36 INFO - 'PAGER': '/bin/cat', 04:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:36 INFO - 'PWD': '/builds/slave/test', 04:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:36 INFO - 'SHELL': '/bin/bash', 04:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:36 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:36 INFO - 'USER': 'cltbld', 04:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:36 INFO - 'XPC_FLAGS': '0x0', 04:49:36 INFO - 'XPC_SERVICE_NAME': '0', 04:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:49:36 INFO - Cleaning up... 04:49:36 INFO - Return code: 0 04:49:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', '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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:49: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 blobuploader==1.2.4 04:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:36 INFO - 'HOME': '/Users/cltbld', 04:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:36 INFO - 'LOGNAME': 'cltbld', 04:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:36 INFO - 'MOZ_NO_REMOTE': '1', 04:49:36 INFO - 'NO_EM_RESTART': '1', 04:49:36 INFO - 'PAGER': '/bin/cat', 04:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:36 INFO - 'PWD': '/builds/slave/test', 04:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:36 INFO - 'SHELL': '/bin/bash', 04:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:36 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:36 INFO - 'USER': 'cltbld', 04:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:36 INFO - 'XPC_FLAGS': '0x0', 04:49:36 INFO - 'XPC_SERVICE_NAME': '0', 04:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:37 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:37 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 04:49:37 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 04:49:37 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 04:49:37 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 04:49:37 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 04:49:37 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 04:49:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:40 INFO - Downloading docopt-0.6.1.tar.gz 04:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:40 INFO - Running setup.py install for blobuploader 04:49:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:41 INFO - Running setup.py install for requests 04:49:41 INFO - Running setup.py install for docopt 04:49:41 INFO - Successfully installed blobuploader requests docopt 04:49:41 INFO - Cleaning up... 04:49:41 INFO - Return code: 0 04:49:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49:41 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 04:49:41 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 04:49:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:41 INFO - 'HOME': '/Users/cltbld', 04:49:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:41 INFO - 'LOGNAME': 'cltbld', 04:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:41 INFO - 'MOZ_NO_REMOTE': '1', 04:49:41 INFO - 'NO_EM_RESTART': '1', 04:49:41 INFO - 'PAGER': '/bin/cat', 04:49:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:41 INFO - 'PWD': '/builds/slave/test', 04:49:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:41 INFO - 'SHELL': '/bin/bash', 04:49:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:41 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:41 INFO - 'USER': 'cltbld', 04:49:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:41 INFO - 'XPC_FLAGS': '0x0', 04:49:41 INFO - 'XPC_SERVICE_NAME': '0', 04:49:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-C64dBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-QBECxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-jig7Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Np61gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-E6XXBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-jfl3IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-tLhSDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-YqQNVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:42 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-nx08zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:43 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-9OOHHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:43 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-TY6UxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:43 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-YKFApI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:43 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-syewsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:43 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-DIbodl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:43 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Zgyzg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:43 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-unhoMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:43 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-zUX9zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:43 INFO - Running setup.py install for manifestparser 04:49:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozcrash 04:49:44 INFO - Running setup.py install for mozdebug 04:49:44 INFO - Running setup.py install for mozdevice 04:49:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozfile 04:49:44 INFO - Running setup.py install for mozhttpd 04:49:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozinfo 04:49:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozInstall 04:49:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Running setup.py install for mozleak 04:49:45 INFO - Running setup.py install for mozlog 04:49:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Running setup.py install for moznetwork 04:49:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Running setup.py install for mozprocess 04:49:45 INFO - Running setup.py install for mozprofile 04:49:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Running setup.py install for mozrunner 04:49:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:46 INFO - Running setup.py install for mozscreenshot 04:49:46 INFO - Running setup.py install for moztest 04:49:46 INFO - Running setup.py install for mozversion 04:49:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:46 INFO - Cleaning up... 04:49:46 INFO - Return code: 0 04:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:46 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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49:46 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 04:49:46 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 04:49:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:46 INFO - 'HOME': '/Users/cltbld', 04:49:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:46 INFO - 'LOGNAME': 'cltbld', 04:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:46 INFO - 'MOZ_NO_REMOTE': '1', 04:49:46 INFO - 'NO_EM_RESTART': '1', 04:49:46 INFO - 'PAGER': '/bin/cat', 04:49:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:46 INFO - 'PWD': '/builds/slave/test', 04:49:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:46 INFO - 'SHELL': '/bin/bash', 04:49:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:46 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:46 INFO - 'USER': 'cltbld', 04:49:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:46 INFO - 'XPC_FLAGS': '0x0', 04:49:46 INFO - 'XPC_SERVICE_NAME': '0', 04:49:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:46 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-vWsv7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:46 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-G7wNtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:46 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-3oF8GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-tp1x55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-votXVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Xe8JQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-CrCucj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Kl811e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-RbKKzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-l5kehK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Pqncdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-jxGU_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:48 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)) 04:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-OxkwPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:48 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)) 04:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-VkJecZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:48 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)) 04:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-0q88XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:48 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)) 04:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-s0GqaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:48 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)) 04:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-WPekor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:48 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)) 04:49:48 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)) 04:49:48 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)) 04:49:48 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)) 04:49:48 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)) 04:49:48 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)) 04:49:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:50 INFO - Downloading blessings-1.6.tar.gz 04:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:51 INFO - Installing collected packages: blessings 04:49:51 INFO - Running setup.py install for blessings 04:49:51 INFO - Successfully installed blessings 04:49:51 INFO - Cleaning up... 04:49:51 INFO - Return code: 0 04:49:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:51 INFO - Reading from file tmpfile_stdout 04:49:51 INFO - Current package versions: 04:49:51 INFO - blessings == 1.6 04:49:51 INFO - blobuploader == 1.2.4 04:49:51 INFO - docopt == 0.6.1 04:49:51 INFO - functools32 == 3.2.3-2 04:49:51 INFO - jsonschema == 2.5.1 04:49:51 INFO - manifestparser == 1.1 04:49:51 INFO - mozInstall == 1.12 04:49:51 INFO - mozcrash == 0.17 04:49:51 INFO - mozdebug == 0.1 04:49:51 INFO - mozdevice == 0.48 04:49:51 INFO - mozfile == 1.2 04:49:51 INFO - mozhttpd == 0.7 04:49:51 INFO - mozinfo == 0.9 04:49:51 INFO - mozleak == 0.1 04:49:51 INFO - mozlog == 3.3 04:49:51 INFO - moznetwork == 0.27 04:49:51 INFO - mozprocess == 0.23 04:49:51 INFO - mozprofile == 0.28 04:49:51 INFO - mozrunner == 6.12 04:49:51 INFO - mozscreenshot == 0.1 04:49:51 INFO - mozsystemmonitor == 0.3 04:49:51 INFO - moztest == 0.7 04:49:51 INFO - mozversion == 1.4 04:49:51 INFO - psutil == 3.1.1 04:49:51 INFO - requests == 1.2.3 04:49:51 INFO - wsgiref == 0.1.2 04:49:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:51 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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49:51 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 04:49:51 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 04:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:51 INFO - 'HOME': '/Users/cltbld', 04:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:51 INFO - 'LOGNAME': 'cltbld', 04:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:51 INFO - 'MOZ_NO_REMOTE': '1', 04:49:51 INFO - 'NO_EM_RESTART': '1', 04:49:51 INFO - 'PAGER': '/bin/cat', 04:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:51 INFO - 'PWD': '/builds/slave/test', 04:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:51 INFO - 'SHELL': '/bin/bash', 04:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:51 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:51 INFO - 'USER': 'cltbld', 04:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:51 INFO - 'XPC_FLAGS': '0x0', 04:49:51 INFO - 'XPC_SERVICE_NAME': '0', 04:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 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)) 04:49:52 INFO - Cleaning up... 04:49:52 INFO - Return code: 0 04:49:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:52 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 0x106c53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f833bc99660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, '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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 04:49:52 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 04:49:52 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 04:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:52 INFO - 'HOME': '/Users/cltbld', 04:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:52 INFO - 'LOGNAME': 'cltbld', 04:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:52 INFO - 'MOZ_NO_REMOTE': '1', 04:49:52 INFO - 'NO_EM_RESTART': '1', 04:49:52 INFO - 'PAGER': '/bin/cat', 04:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:52 INFO - 'PWD': '/builds/slave/test', 04:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:52 INFO - 'SHELL': '/bin/bash', 04:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:49:52 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:52 INFO - 'USER': 'cltbld', 04:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:52 INFO - 'XPC_FLAGS': '0x0', 04:49:52 INFO - 'XPC_SERVICE_NAME': '0', 04:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:49:52 INFO - Cleaning up... 04:49:52 INFO - Return code: 0 04:49:52 INFO - Running post-action listener: _resource_record_post_action 04:49:52 INFO - Running post-action listener: _start_resource_monitoring 04:49:52 INFO - Starting resource monitoring. 04:49:52 INFO - [mozharness: 2016-09-13 11:49:52.503966Z] Finished create-virtualenv step (success) 04:49:52 INFO - [mozharness: 2016-09-13 11:49:52.504969Z] Running install step. 04:49:52 INFO - Running pre-action listener: _resource_record_pre_action 04:49:52 INFO - Running main action method: install 04:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:52 INFO - Reading from file tmpfile_stdout 04:49:52 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:52 INFO - Reading from file tmpfile_stdout 04:49:52 INFO - Output received: 04:49:52 INFO - Usage: mozinstall [options] installer 04:49:52 INFO - Options: 04:49:52 INFO - -h, --help show this help message and exit 04:49:52 INFO - -d DEST, --destination=DEST 04:49:52 INFO - Directory to install application into. [default: 04:49:52 INFO - "/builds/slave/test"] 04:49:52 INFO - --app=APP Application being installed. [default: firefox] 04:49:52 INFO - mkdir: /builds/slave/test/build/application 04:49:52 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'] 04:49:52 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 04:50:26 INFO - Reading from file tmpfile_stdout 04:50:26 INFO - Output received: 04:50:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:50:26 INFO - Running post-action listener: _resource_record_post_action 04:50:26 INFO - [mozharness: 2016-09-13 11:50:26.718356Z] Finished install step (success) 04:50:26 INFO - [mozharness: 2016-09-13 11:50:26.718523Z] Running run-tests step. 04:50:26 INFO - Running pre-action listener: _resource_record_pre_action 04:50:26 INFO - Running main action method: run_tests 04:50:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:50:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:50:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:50:26 INFO - 2016-09-13 04:50:26.732 screenresolution[1634:7336] starting screenresolution argv=screenresolution get 04:50:26 INFO - 2016-09-13 04:50:26.735 screenresolution[1634:7336] Display 0: 1600x1200x32@60 04:50:26 INFO - 2016-09-13 04:50:26.741 screenresolution[1635:7338] starting screenresolution argv=screenresolution list 04:50:26 INFO - Available Modes on Display 0 04:50:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:50:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:50:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:50:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:50:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:50:26 INFO - Intel Iris: 04:50:26 INFO - Chipset Model: Intel Iris 04:50:26 INFO - Type: GPU 04:50:26 INFO - Bus: Built-In 04:50:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:50:26 INFO - Vendor: Intel (0x8086) 04:50:26 INFO - Device ID: 0x0a2e 04:50:26 INFO - Revision ID: 0x0009 04:50:26 INFO - Displays: 04:50:26 INFO - Display: 04:50:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:50:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:50:26 INFO - Display Serial Number: 1600x1200 60 04:50:26 INFO - Main Display: Yes 04:50:26 INFO - Mirror: Off 04:50:26 INFO - Online: Yes 04:50:26 INFO - Rotation: Supported 04:50:26 INFO - Return code: 0 04:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:26 INFO - Python 2.7.3 04:50:26 INFO - Return code: 0 04:50:26 INFO - grabbing minidump binary from tooltool 04:50:26 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')]} 04:50:26 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 0x106a67d30>, '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 0x10688ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a5fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:26 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 04:50:26 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 04:50:26 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 04:50:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:27 INFO - Return code: 0 04:50:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:50:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:50:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 04:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0119 --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 04:50:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vIb6RvHg3O/Render', 04:50:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:27 INFO - 'HOME': '/Users/cltbld', 04:50:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:27 INFO - 'LOGNAME': 'cltbld', 04:50:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:27 INFO - 'MOZ_NO_REMOTE': '1', 04:50:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:27 INFO - 'NO_EM_RESTART': '1', 04:50:27 INFO - 'PAGER': '/bin/cat', 04:50:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:27 INFO - 'PWD': '/builds/slave/test', 04:50:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:27 INFO - 'SHELL': '/bin/bash', 04:50:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0pwNuDOUDu/Listeners', 04:50:27 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 04:50:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:27 INFO - 'USER': 'cltbld', 04:50:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:27 INFO - 'XPC_FLAGS': '0x0', 04:50:27 INFO - 'XPC_SERVICE_NAME': '0', 04:50:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 04:50:27 INFO - mozversion application_buildid: 20160913025909 04:50:27 INFO - mozversion application_changeset: f5d043ce6d36a3c461cbd829d4a4a38394b7c436 04:50:27 INFO - mozversion application_display_name: Nightly 04:50:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:27 INFO - mozversion application_name: Firefox 04:50:27 INFO - mozversion application_remotingname: firefox 04:50:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:50:27 INFO - mozversion application_vendor: Mozilla 04:50:27 INFO - mozversion application_version: 51.0a1 04:50:27 INFO - mozversion platform_buildid: 20160913025909 04:50:27 INFO - mozversion platform_changeset: f5d043ce6d36a3c461cbd829d4a4a38394b7c436 04:50:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:50:27 INFO - mozversion platform_version: 51.0a1 04:50:27 INFO - using testdate: 1473767427 04:50:27 INFO - actual date: 1473767427 04:50:27 INFO - starting webserver on 'localhost:49266' 04:50:27 INFO - SUITE-START | Running 2 tests 04:50:27 INFO - TEST-START | dromaeo_css 04:50:27 INFO - operating with platform_type : mac_ 04:50:27 INFO - Initialising browser for dromaeo_css test... 04:50:27 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpHEcnIW/profile http://localhost:49266/getInfo.html) 04:50:29 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 04:50:29 INFO - PROCESS | 1645 | colorDepth:24 04:50:29 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 04:50:29 INFO - PROCESS | 1645 | __metrics 04:50:29 INFO - PROCESS | 1645 | 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" 04:50:29 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:30 INFO - TEST-INFO | 1645: exit 0 04:50:30 INFO - Browser initialized. 04:50:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:30 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpHEcnIW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:42 INFO - PROCESS | 1647 | RSS: Main: 229158912 04:50:42 INFO - PROCESS | 1647 | 04:51:33 INFO - PROCESS | 1647 | 1473767493836 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] 04:53:46 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 04:53:47 INFO - PROCESS | 1647 | RSS: Main: 385716224 04:53:47 INFO - PROCESS | 1647 | 04:56:50 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 04:56:51 INFO - PROCESS | 1647 | RSS: Main: 365125632 04:56:51 INFO - PROCESS | 1647 | 04:59:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 04:59:54 INFO - PROCESS | 1647 | RSS: Main: 363737088 04:59:54 INFO - PROCESS | 1647 | 05:02:56 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 05:02:57 INFO - PROCESS | 1647 | RSS: Main: 334794752 05:02:57 INFO - PROCESS | 1647 | 05:06:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 05:06:01 INFO - PROCESS | 1647 | RSS: Main: 329777152 05:06:01 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 05:09:04 INFO - PROCESS | 1647 | RSS: Main: 488914944 05:09:04 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | __start_tp_report 05:09:04 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 05:09:04 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 05:09:04 INFO - PROCESS | 1647 | |i|pagename|runs| 05:09:04 INFO - PROCESS | 1647 | |0;dojo.html;3316.9004929852103;3358.0597432718846;3374.8650053997835;3380.712639425649;3399.1841957930105;5559.19391688206;5676.035074037419;5698.715064246791;5752.683602401867;5753.2520772299595;5683;5716.114002329635;5727;5730.7707691692385;5731.455511726379;5165.096108181072;5198.636095473299;5210.088234558956;5238.8690282742855;5257.36911570612;5269.736513174326;5270.288511050997;5285.920711189336;5287.576993840503;5296.629235953485;5206.869828254286;5241.475852414766;5244.737763111848;5255.816046438375;5261.684298942057;5295.655782374152;5297.708626025567;5307;5318.069337865858;5340.931813637288;5038.496150384969;5154.252633368141;5248.8425347239645;5261.3686357637325;5280.6039547034125;5562.9443705562835;5575.665460072409;5607.52336051432;5667.234923285345;5674.886502269931;5065;6146.200993870768;6220.68896555175;6228.346023667495;6232.3144454110015;6124.005123272519;6226.097215903714;6290.937090629127;6298.6535740534255;6303.55875088744;5711.571632127566;5737.799177028784;5754.539636829044;5786.450287222707;5794.478496935296;6195.9869621123125;6236.438720515175;6244.1570387997035;6245.281792593819;6265.968670156712;6112.174856394418;6149.477294429934;6149.815505534841;6150.7232174552255;6150.7847225346895;6095.207623009069;6132.8773424532155;6140.074827791203;6199.442050215503;6245.594036387711;6119.533019689859;6149.477294429934;6155.384461553809;6218.906716399258;6243.313235544087;6191.133241346215;6232.56372053961;6261.405166509175;6274.215723034621;6276.6547839868335;4839.7096174229655;4894.877628059256;4945.23348880924;4956;4975.552200301918;4361.869143925624;4441.555844415532;4452.48796388413;4469.642428605704;4474.574915383034;5734.197212390269;5780.971095144498;5789.710514474344;5863.5309175265875;5882.411758824083;6243.937560624427;6272.655003974825;6297.590656607306;6297.811065668037;6305;5801.622894511843;5826.650400975955;5831.475167234969;5834;5871.588988770831;5310.707911064928;5352.598555108305;5384.40771515133;5442.210879422461;5444.945550544444;6196.628202307876;6310.5267104967315;6321.431071203614;6322.8735425290315;6337.8732425352155;6243.843903902439;6274.749010039547;6280.780172693934;6302.684865756785;6316.115743795965;5554.555635549065;6155.599886007395;6317.084022816758;6323.336049714714;6323.620582765049;6098.807833950406;6142.477889379453;6152.477039451696;6211.161493198541;6226.62640241587;5034.597232221487;5981.461668449861;6208;6258.624482531062;6287.2769631492965;5926.585139040399;6124.846878828065;6137;6147.538934580014;6161.630302181883;6001.4298641628975;6056.485198757979;6066.393360663898;6099.481544068626;6138.877222455437;5996.8500787478915;6000;6001.639901605918;6009.969950150221;6019.067044608093;6107.908381374372;6137.478314343331;6140.785072522441;6144.662043587646;6144.969275153596;5718.714064296685;5845.09401042839;5895.970520147372;5897.3807750185615;5942.673152976455 05:09:04 INFO - PROCESS | 1647 | |1;ext.html;445.61454341994175;505.4137200847018;506.1420891588759;532.8587924200086;556.326844518133;30853;40961.18077638449;41800;41808.95477613061;41909.58090419095;43037.7848110759;43270.78364608181;43303.56696433035;43410.565894341045;43544.91137721558;9712.368696034753;9897.653582124627;9913.256505762061;9922.90077099227;9968.800623987516;9763.951180244088;9891.703248902544;9895.703128906145;9911.25665575081;9921.454320012397;9856.605735770561;9882.357646752975;9906.207503399746;9918.355306905065;9924.751881202956;9427.245820334358;9883.061109194616;9892.50537473127;9923.206143508502;9924;9724.270679699051;9801.656942007066;9804.36271642341;9804.705858824247;9834.65578704749;40702.185956281006;41046;41133;41169.79415102935;41348.1730365391;3410.471376936579;3490.9127271818406;3849.556416343871;4031.3193318277345;4182.539920608761;30983.22541936447;31326;32111.83944080288;32321.35357292841;32506.6749332506;3004.8581539015254;3032.6664066952617;3195.201199700075;3225.7580831379855;3257.2671148991526;474587;474632;475005;475076;475889;50514.494855051715;54811.62970925679;57762.71118644464;57844.13233801496;58099.12851307234;57164.71417642968;57283.427165728644;57304.42695573074;57405.712971435714;57439.71280143572;15944.123073231083;16175.757363639555;16184.83815161857;16191.595210119842;16225.756613650805;12457;12521.93739031299;12526.561570344995;12537.24776513394;12552.372381380894;12322.137450378566;13957.115009746507;14259.215743134228;15004.399824006918;15782.68434631301;5396;6256.311805701369;6291.245050593867;6315.463185629181;6361.554691171574;858.7810108422312;907.8411278026451;918.7381596245039;942.3026960049514;999.2905037423511;27921.301967450978;29273.268168295963;29490.85254573756;29748;29763.492905779127;995.64654547636;1008.8991100889999;1053.8208504554243;1055.37205362809;1108.2685427617894;14713.117212967256;15087.396504139931;15180.620484487756;15363.539093827203;15549;627282;628186;629939;630692;635562;58046.83906321934;58192.709036454544;58279.125813112834;58282.12576811351;58340;1219.4207751318054;1250.4873002069107;1335.2856221921224;1354.8983826213073;1377.6349267444136;29526;31193.68806311908;31276.218094547818;31483.212919677193;32121.51817722689;40656;49212;49665.255021175435;49741;49985;533734.6145001125;535540;537248.6476217159;537275;538007;31796.841015794773;33009.33981320408;39340.803295983336;40402.989925252106;40492;41420.378694320214;44288;46395.536044640474;47596;47824.760876196786;38952.80523597364;38995.6100438992;39221.41167882541;40282.1943561133;40283.1943361137;38531;39917;41905.79047104867;42447;43635.56364436442;34139;35620.46569301515;35968.820155899055;40294.1941161181;42300.40446562077;34501.654983449844;38842.61157388503;38905.41641875318;40373.39439908345;40780.59219407768;30010.84994575013;31265.062048138592;31270;31826.78891767915;32035.359292813548 05:09:04 INFO - PROCESS | 1647 | |2;jquery.html;357.1945263430963;370.1191165027235;377.13823912360255;386.79499865071506;406.7925358067385;14913.776293355608;15091;16878.57803554912;20189.495262618406;20914.686279705817;16548.172591370443;19382.321618743346;19848.20607175711;20286.98565071744;20339.389818305473;5330.3603567571845;5534.308211473566;5544.16837474378;5547.694876781776;5561.5828812839;5817.272840894888;6105.511559075263;6171.074338849164;6180.165677633507;6190.566660333779;3878.728489005771;4103.220388126261;6174.629522228681;6553.475721942234;6835.077264569294;6649.567778094409;6668.599884006927;6817.931820681779;6861.1423572053745;6876.381125698686;5971.313298970587;5974.731137098841;5977.701114944235;5987.341392446828;5996.430339117776;12829.807552886714;16919.661606767797;24923;25000.4999900001;25158.371040723945;2077.989610051955;2228.7882651148116;2485.478049609584;2528.6092649043135;2796.6364372631633;9778.657746978894;9786.217102631843;9825.213982881352;10163.949180254125;10182.439965801877;1687.772150759644;1763.6031892824012;1825.9360922367653;1833.1604563951046;1879.6804543227547;118531;119675;121818.39090804578;125328;125437;11020.50407731654;11098.944505277583;11231.606893758679;11351.489182986785;11359.204855660024;14284.0001199915;14295.642608934651;14301.78547321791;14305.499307524187;14320.212388318534;8326.333893288522;8472.322214222848;8474.915250847536;8481.830363392697;8610.923634545681;8351.707690230813;8374.204450577185;8376.49741015541;8519.531425771518;8561.44350617208;4469.642428605769;4484.148011877733;4494.9325760113625;4495;4543.4093567836635;1668.4827703411981;1843.806400327973;1853.6385404846196;1893.9810601893805;1899.4586542835225;911.7447114807865;942.7030485397078;943.3443756589105;956.6269155029544;963.7446076789656;11713.414329283502;12244.938775306067;12276.938615306866;19612.70580941287;21206.787932120482;361.48668890176015;422.2968757019589;433.8091239854454;437;439.05383897700506;5707.143928410772;5890.2342695449315;5940.34656187819;6000.879982400327;6155.384461553809;591187;599707;606443;610380;610412;133313;133933;136675;139864.300678498;141947;430.3759548654401;452.85508637236427;454.3094496365506;456.39299731357215;456.4818930513891;11123.03951185654;11131.387773672526;11300.604478843201;11413.828792567952;11545.769084618429;53429;55126.72436637791;56477.43522564722;56736.716316418155;57406.13890791558;77225;83107.58446207971;83636;84924.15075849163;85828.57085714531;7952.681892724227;8175.182481751777;8176.591170441573;8305.709300174465;8452.797289398377;9308.860367094363;12238.449269782703;12981.4158362872;13201.471941122247;13420.932895335462;11078.723031924266;11098;11448;11494.827577586175;11585;9936;10951.288166269167;11061.94469027682;11406.315621062762;11417.657470275904;11288.94355528217;11375.374354410256;11716.121290903387;11803.940980295043;11826.467808948446;8088.555129467935;8303.543305118277;8311.085780564254;8410.915890841014;8552.417802706519;8019.438639295194;10224.744381390525;11282.266652667551;11519.596814111466;11642.94178529102 05:09:04 INFO - PROCESS | 1647 | |3;mootools.html;1345.2802750528467;1366.0301186157828;1507.6230942264438;1685.1911082680313;1904.6190761847633;7773.183815699348;8279.089300176976;8592.699255526059;8926.973398059225;8930.017698053209;8791.912080879189;8882.333824963122;8891.644334226623;8902.065283145273;8904.554772261394;2390.7011623547055;2415.45652228249;2419.9637005444933;2421.32202983165;2424.8787560621986;2359.374765687094;2406.0616359619676;2406.831521793475;2408.8072954163713;2418.105301038618;2376.6435034744754;2398.0647547456506;2409.6987876515436;2412.6381042843627;2417.359399759065;2357.610994185957;2393;2393.772591603795;2400.3159099656514;2403.267003563912;2347.401412639783;2367.6922000140044;2380.833341666084;2382.0590866607768;2382.702162229721;8793;8902.821943561092;8912.975007874113;8998.640054397882;9039.412438191497;5233.895322093575;5397.433269506684;5430.321209848769;5446.346438427375;5447.727613619343;3639;3651.6165802590876;3694.6305369463107;3724.478572999782;3730.552333719971;1061.4215252687304;1072.855164552791;1074.2372915230196;1085.1861104171871;1094.6497120921308;11762.294262344201;11786.292822430682;11858.40707964607;11859.169858109935;11908.523659053713;4439.178751930903;4499.68502204849;4685.016146609182;4686.531346865354;4688.742119183477;9275.350725449154;9290.396124252036;9302.90697093034;9317.90682093184;9328.440293582407;5313.521783039545;5327.121025030827;5327.973360133252;5331.173668081454;5339.519443250126;4373.234683930299;4397.670174736908;4479.395281637003;4652.767361631905;5010.949890501049;3241.854116564713;3747.4191500317493;3811.294910441577;3847.980285224418;3857.0935830079907;1010.7068950004564;1166.731651720109;1181.8345431639577;1182.9704257393635;1183.9408029598485;766.3983772738374;789.4671097009495;886.2821114896955;926.9860952085725;927.9721608351625;5532.917006244909;5539.806106786243;5939.4557415072395;6007.098935159761;6033.607815491979;928.8885333759857;957.4446820843893;969.6170012845027;979.2068424576116;1067.412922892406;3385.2396753688436;3793.943090853639;3811.123441608446;3886.4753258310334;3913.3934240192816;10595.682129536126;10772.407517586451;10906.672799816019;10915.072218861327;10948.288361256493;10278.17774578032;10697.786044279072;10708.678739637824;10846.29499082557;10858.131349492021;7976.960115199387;8200.138985406566;8219.301359384519;8219.465734727342;8229.300509456763;5585.916211256753;5781.768729250783;5832.387599302182;5940.079287710412;6144.846378840386;9892.208623310262;10152.492375381054;10173.033561811617;10186.796264074528;10192.643257485952;9453.810923781624;10331.483425828828;10399.58401663925;10530.36817790935;10536.157107431234;7005.54463959841;7122.18094919091;7235.782926512213;7260.782176534713;7353.338199561851;7910.485818422015;7926.841463170589;7950.085740139958;7974.003249593801;8030.63862126194;7226.349628533457;7280.854382912418;7304.5252058616015;7349.8162545936775;7387.4090072795125;6201.2868520118955;6778.593284402951;7075.752348667772;7096.290370962863;7224.674889630084;6649.833754156185;6806.897896531457;6814.62519561409;6815.522913396015;6840.281770414035;4116.547179810159;4742.549457801503;4908.533689299511;4932.827351042696;4994.325766021686;4856.9314750754775;4882.389701287339;4901.705897646153;4973;4987.077390682735 05:09:04 INFO - PROCESS | 1647 | |4;prototype.html;302.1554754461281;303.0529595015576;310.09761593762147;313.30602714986316;318.9170815587946;4604.378408914799;5080.847574572759;5166.328377310944;5304.49607287308;5357.196420536917;4249.893752656185;4562.90874182517;5163.81926632568;5169.741512924357;5196.792128314863;3622.876908158479;3685.8942317304836;4033.3748269018347;4074.144429669758;4083.775392353419;3799.5060642116623;4101.457096600112;4106.1992911382295;4106.917861642765;4121.629053385194;3543.919104673074;3951.5060617422823;3989.5412027616903;4011.5186177658575;4082.9183416331657;3741.8877433677035;4022.1955608878343;4025.657819085396;4040.757554546707;4078.714489985702;2934.6669397828778;3054.8167109973474;3364.310316385135;3501.9299614007577;3521.4365701487895;4900.730459824708;5188.195829646411;5206.095428428678;5228.738563071831;5258.6581872178185;3629.3467175908327;4556.453225612948;4616.714726210514;4624.392973480691;4626.444826620794;4898.951010489885;5246.344206974129;5601.19940029985;5607.971960140173;5638.351589567212;3684.5025921500524;3804.90487737806;3815.7138214634015;3821.719723892499;3831.444440556104;5190.480951904817;5716.228309178249;5893.174955506232;5897.938371093202;5911.970440147772;3255.544223808621;3617.3127105849803;3871.225754848985;3883.30100581898;3884.057971014493;3665.7617254878346;3700.296943580711;3916.4921505220127;3929.351656976624;3958.4364176150834;3828.942565861514;4028.5165780106577;4569.811848919305;4600.815967361335;4605.953940460619;4502.482214545304;5602.243697100921;5628.634138781048;5631.18347839561;5675.631083979611;1093.945302734876;1189.7798907202196;1202.392791640216;1276.4638851682316;1324.5165514587106;743.6913680822398;894.4901406198404;896.1441823058963;905.3526728389234;907.9727608171765;4495.640348772155;5071.949280507221;5116.334876466036;5128.358955130609;5130.333056702605;4847.587955023862;5324.307839980777;5392.272043274186;5607.2897766180895;5665.235193248858;4351.891202719958;5067;5068.6451948363265;5081.949180508222;5084.720340381241;2267.013848975701;2368.171140100951;2474.8267621266336;2519.3953451171587;2520.218732193026;4558.703684260512;4858;4892.902141957212;4909.656324057353;4911.18965370717;4589.5639914208095;4636.8670411610365;4685.079117561783;4821.7589120543835;4949;4211.031462763521;4591.862244132682;4882.632862798422;4932.309476673268;4968.8757781055765;4107.876763697094;4178.519470260959;4630.768461576975;4661.112249538942;4994.450610432922;5405.97276021492;5477;5794.783095549982;5800.332961709458;5826.94173058264;4674.943025068958;5862.355140934408;6069.51443884497;6075.083959699281;6085.908711369421;3774.7923864186637;3849.9037524062123;3864.787436691009;3899.883003509899;3918.1967696622696;5831.912521312269;5834.27071616048;5843.370483282625;5848.970755146367;5860.443257890493;4683.648726345469;4772.375193643413;5098.674344670487;5360.463953604608;5653.180288858175;4701.858944231679;5329.350261389096;5635.88728225425;5673.5461163107675;5709.25779648643;4008.4388185653447;5061.519155680205;5091.134507133722;5257.342832145981;5473.549509380097;4973.651844370859;4973.9306049199595;5228.921566176587;5714.3714191438075;5723.7996670116345;4758.809647614056;5349;5467.289252397163;5566.443355664401;5603.80386686464 05:09:04 INFO - PROCESS | 1647 | |5;yui.html;679.2256827216974;769.2077160524658;773.5281478298234;793.5794029164545;821.5235163605108;15032.624184395381;15572.37710491579;16209;16228.756568651464;16509.422170224043;14555;14945.775813362781;14954.62613434662;14984.175870327128;15149.015314004582;692.1486571517037;708.5323686366999;829.0838623321233;840.2899549880372;843.5402705525503;684.691888650107;835.4903508859591;850.0097386544699;850.9829803403928;859.4456575508793;860;861.1087524412203;861.7156338408311;861.8362511122898;863.3869952333819;720.5028530314066;854.0434713121344;854.7521218846558;857.5283594023325;858.1375717404001;546.0907588864536;637.6461064109418;648.5006544960354;654.1365397675071;654.5908806995627;14863.777043344358;14886.553403397915;14904.850951490454;14914;14920.2539873007;12035.638930832089;13827.446902123904;13911.373988170557;14160.645983850383;14240.50158244467;12404.25574465535;12591.685207869785;12791.104622676416;13153.53962611304;13270.933645331712;4510.481294651091;4529.063897302739;4566.474855391639;4770.546798054179;4771.928421073687;124395.13407298898;124844;124854.37572812168;126146;126536.36731816374;10970;11011.779764404668;11018.283811552223;11073.224874258885;11262.267952583055;21603.243886463897;21633.783662163492;21636.242731504637;21649.56700865974;21654.35036948894;7750.186230445835;8025.2777250047775;8149.429539932148;8149.959250203711;8150.144234855255;3765.4728338032696;4331.480222373272;4421.9336709949375;4582.450105987236;4583.839565615254;3417.2311229973056;3506.7545271830727;3554.59122200945;3565.3404120237838;3572.5355703758346;652.3639451534716;665.6369886901481;666.5267659961385;678.060885673346;678.6708446403491;612.4182027074297;612.834534675635;616.747133675191;639.9360063993563;667.9365460281266;7811.648475818602;8572.699955501528;8685.6525738971;8862.291016718647;8980.823916878682;554.027681419115;565.8047973449236;567.2937193194499;595.7229888101966;643.0547095769211;4203.91592168155;4221.852235171816;4468.776561171929;4490.910181796346;4530.184566778012;125880;160643.19678401534;161807;163203;165415;137957;143536.28231858983;144228.27885860714;146213;146529;116138.64405593296;118367;119970;120595.39702301432;121026.39486802685;7708.922910770821;7831.334336581454;8049.51702897828;8438.53588052663;8470.618822152896;48413.27380089231;49839.754006150135;60001.39998599958;67836.98244526237;67880.10693380366;66484.66757666181;97333.53999690151;100328;100894;102851;10948.20035037411;11298.152638551977;11369.886301136883;11699.415029248674;11818.290902545874;11865.347405892759;12051.33717645538;12060.216085954386;12567.245965242115;12604.432800523815;11575.652730418102;11723.941380293385;11744;11989.520419183134;12051.51793928233;11361.829572556253;11511.791261917713;11567.190296679151;11678.532858685558;11935.880641193824;11152.219344645797;11251.324920504796;11394.430278486208;11494.712632184262;11985.28088314704;9247.260219182584;9513.809723805623;9735.659251926148;10087.69736907894;10159;8799.548233056303;9782.168515676247;9820.635411779731;9833.803323933338;9955.003107520199 05:09:04 INFO - PROCESS | 1647 | __end_tp_report 05:09:04 INFO - PROCESS | 1647 | __start_cc_report 05:09:04 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1269 05:09:04 INFO - PROCESS | 1647 | __end_cc_report 05:09:04 INFO - PROCESS | 1647 | __startTimestamp1473768544727__endTimestamp 05:09:04 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | ------- Summary: start ------- 05:09:04 INFO - PROCESS | 1647 | Number of tests: 6 05:09:04 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5735.54 Median:5926.59 stddev:631.15 (10.6%) stddev-sans-first:603.89 05:09:04 INFO - PROCESS | 1647 | Values: 3316.9 3358.1 3374.9 3380.7 3399.2 5559.2 5676.0 5698.7 5752.7 5753.3 5683.0 5716.1 5727.0 5730.8 5731.5 5165.1 5198.6 5210.1 5238.9 5257.4 5269.7 5270.3 5285.9 5287.6 5296.6 5206.9 5241.5 5244.7 5255.8 5261.7 5295.7 5297.7 5307.0 5318.1 5340.9 5038.5 5154.3 5248.8 5261.4 5280.6 5562.9 5575.7 5607.5 5667.2 5674.9 5065.0 6146.2 6220.7 6228.3 6232.3 6124.0 6226.1 6290.9 6298.7 6303.6 5711.6 5737.8 5754.5 5786.5 5794.5 6196.0 6236.4 6244.2 6245.3 6266.0 6112.2 6149.5 6149.8 6150.7 6150.8 6095.2 6132.9 6140.1 6199.4 6245.6 6119.5 6149.5 6155.4 6218.9 6243.3 6191.1 6232.6 6261.4 6274.2 6276.7 4839.7 4894.9 4945.2 4956.0 4975.6 4361.9 4441.6 4452.5 4469.6 4474.6 5734.2 5781.0 5789.7 5863.5 5882.4 6243.9 6272.7 6297.6 6297.8 6305.0 5801.6 5826.7 5831.5 5834.0 5871.6 5310.7 5352.6 5384.4 5442.2 5444.9 6196.6 6310.5 6321.4 6322.9 6337.9 6243.8 6274.7 6280.8 6302.7 6316.1 5554.6 6155.6 6317.1 6323.3 6323.6 6098.8 6142.5 6152.5 6211.2 6226.6 5034.6 5981.5 6208.0 6258.6 6287.3 5926.6 6124.8 6137.0 6147.5 6161.6 6001.4 6056.5 6066.4 6099.5 6138.9 5996.9 6000.0 6001.6 6010.0 6019.1 6107.9 6137.5 6140.8 6144.7 6145.0 5718.7 5845.1 5896.0 5897.4 5942.7 05:09:04 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:68672.12 Median:23044.17 stddev:146945.53 (637.7%) stddev-sans-first:147268.46 05:09:04 INFO - PROCESS | 1647 | Values: 445.6 505.4 506.1 532.9 556.3 30853.0 40961.2 41800.0 41809.0 41909.6 43037.8 43270.8 43303.6 43410.6 43544.9 9712.4 9897.7 9913.3 9922.9 9968.8 9764.0 9891.7 9895.7 9911.3 9921.5 9856.6 9882.4 9906.2 9918.4 9924.8 9427.2 9883.1 9892.5 9923.2 9924.0 9724.3 9801.7 9804.4 9804.7 9834.7 40702.2 41046.0 41133.0 41169.8 41348.2 3410.5 3490.9 3849.6 4031.3 4182.5 30983.2 31326.0 32111.8 32321.4 32506.7 3004.9 3032.7 3195.2 3225.8 3257.3 474587.0 474632.0 475005.0 475076.0 475889.0 50514.5 54811.6 57762.7 57844.1 58099.1 57164.7 57283.4 57304.4 57405.7 57439.7 15944.1 16175.8 16184.8 16191.6 16225.8 12457.0 12521.9 12526.6 12537.2 12552.4 12322.1 13957.1 14259.2 15004.4 15782.7 5396.0 6256.3 6291.2 6315.5 6361.6 858.8 907.8 918.7 942.3 999.3 27921.3 29273.3 29490.9 29748.0 29763.5 995.6 1008.9 1053.8 1055.4 1108.3 14713.1 15087.4 15180.6 15363.5 15549.0 627282.0 628186.0 629939.0 630692.0 635562.0 58046.8 58192.7 58279.1 58282.1 58340.0 1219.4 1250.5 1335.3 1354.9 1377.6 29526.0 31193.7 31276.2 31483.2 32121.5 40656.0 49212.0 49665.3 49741.0 49985.0 533734.6 535540.0 537248.6 537275.0 538007.0 31796.8 33009.3 39340.8 40403.0 40492.0 41420.4 44288.0 46395.5 47596.0 47824.8 38952.8 38995.6 39221.4 40282.2 40283.2 38531.0 39917.0 41905.8 42447.0 43635.6 34139.0 35620.5 35968.8 40294.2 42300.4 34501.7 38842.6 38905.4 40373.4 40780.6 30010.8 31265.1 31270.0 31826.8 32035.4 05:09:04 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:35010.96 Median:2255.01 stddev:101276.19 (4491.2%) stddev-sans-first:101526.87 05:09:04 INFO - PROCESS | 1647 | Values: 357.2 370.1 377.1 386.8 406.8 14913.8 15091.0 16878.6 20189.5 20914.7 16548.2 19382.3 19848.2 20287.0 20339.4 5330.4 5534.3 5544.2 5547.7 5561.6 5817.3 6105.5 6171.1 6180.2 6190.6 3878.7 4103.2 6174.6 6553.5 6835.1 6649.6 6668.6 6817.9 6861.1 6876.4 5971.3 5974.7 5977.7 5987.3 5996.4 12829.8 16919.7 24923.0 25000.5 25158.4 2078.0 2228.8 2485.5 2528.6 2796.6 9778.7 9786.2 9825.2 10163.9 10182.4 1687.8 1763.6 1825.9 1833.2 1879.7 118531.0 119675.0 121818.4 125328.0 125437.0 11020.5 11098.9 11231.6 11351.5 11359.2 14284.0 14295.6 14301.8 14305.5 14320.2 8326.3 8472.3 8474.9 8481.8 8610.9 8351.7 8374.2 8376.5 8519.5 8561.4 4469.6 4484.1 4494.9 4495.0 4543.4 1668.5 1843.8 1853.6 1894.0 1899.5 911.7 942.7 943.3 956.6 963.7 11713.4 12244.9 12276.9 19612.7 21206.8 361.5 422.3 433.8 437.0 439.1 5707.1 5890.2 5940.3 6000.9 6155.4 591187.0 599707.0 606443.0 610380.0 610412.0 133313.0 133933.0 136675.0 139864.3 141947.0 430.4 452.9 454.3 456.4 456.5 11123.0 11131.4 11300.6 11413.8 11545.8 53429.0 55126.7 56477.4 56736.7 57406.1 77225.0 83107.6 83636.0 84924.2 85828.6 7952.7 8175.2 8176.6 8305.7 8452.8 9308.9 12238.4 12981.4 13201.5 13420.9 11078.7 11098.0 11448.0 11494.8 11585.0 9936.0 10951.3 11061.9 11406.3 11417.7 11288.9 11375.4 11716.1 11803.9 11826.5 8088.6 8303.5 8311.1 8410.9 8552.4 8019.4 10224.7 11282.3 11519.6 11642.9 05:09:04 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5655.28 Median:4869.66 stddev:3194.88 (65.6%) stddev-sans-first:3187.42 05:09:04 INFO - PROCESS | 1647 | Values: 1345.3 1366.0 1507.6 1685.2 1904.6 7773.2 8279.1 8592.7 8927.0 8930.0 8791.9 8882.3 8891.6 8902.1 8904.6 2390.7 2415.5 2420.0 2421.3 2424.9 2359.4 2406.1 2406.8 2408.8 2418.1 2376.6 2398.1 2409.7 2412.6 2417.4 2357.6 2393.0 2393.8 2400.3 2403.3 2347.4 2367.7 2380.8 2382.1 2382.7 8793.0 8902.8 8913.0 8998.6 9039.4 5233.9 5397.4 5430.3 5446.3 5447.7 3639.0 3651.6 3694.6 3724.5 3730.6 1061.4 1072.9 1074.2 1085.2 1094.6 11762.3 11786.3 11858.4 11859.2 11908.5 4439.2 4499.7 4685.0 4686.5 4688.7 9275.4 9290.4 9302.9 9317.9 9328.4 5313.5 5327.1 5328.0 5331.2 5339.5 4373.2 4397.7 4479.4 4652.8 5010.9 3241.9 3747.4 3811.3 3848.0 3857.1 1010.7 1166.7 1181.8 1183.0 1183.9 766.4 789.5 886.3 927.0 928.0 5532.9 5539.8 5939.5 6007.1 6033.6 928.9 957.4 969.6 979.2 1067.4 3385.2 3793.9 3811.1 3886.5 3913.4 10595.7 10772.4 10906.7 10915.1 10948.3 10278.2 10697.8 10708.7 10846.3 10858.1 7977.0 8200.1 8219.3 8219.5 8229.3 5585.9 5781.8 5832.4 5940.1 6144.8 9892.2 10152.5 10173.0 10186.8 10192.6 9453.8 10331.5 10399.6 10530.4 10536.2 7005.5 7122.2 7235.8 7260.8 7353.3 7910.5 7926.8 7950.1 7974.0 8030.6 7226.3 7280.9 7304.5 7349.8 7387.4 6201.3 6778.6 7075.8 7096.3 7224.7 6649.8 6806.9 6814.6 6815.5 6840.3 4116.5 4742.5 4908.5 4932.8 4994.3 4856.9 4882.4 4901.7 4973.0 4987.1 05:09:04 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4362.32 Median:4765.59 stddev:1352.39 (28.4%) stddev-sans-first:1321.41 05:09:04 INFO - PROCESS | 1647 | Values: 302.2 303.1 310.1 313.3 318.9 4604.4 5080.8 5166.3 5304.5 5357.2 4249.9 4562.9 5163.8 5169.7 5196.8 3622.9 3685.9 4033.4 4074.1 4083.8 3799.5 4101.5 4106.2 4106.9 4121.6 3543.9 3951.5 3989.5 4011.5 4082.9 3741.9 4022.2 4025.7 4040.8 4078.7 2934.7 3054.8 3364.3 3501.9 3521.4 4900.7 5188.2 5206.1 5228.7 5258.7 3629.3 4556.5 4616.7 4624.4 4626.4 4899.0 5246.3 5601.2 5608.0 5638.4 3684.5 3804.9 3815.7 3821.7 3831.4 5190.5 5716.2 5893.2 5897.9 5912.0 3255.5 3617.3 3871.2 3883.3 3884.1 3665.8 3700.3 3916.5 3929.4 3958.4 3828.9 4028.5 4569.8 4600.8 4606.0 4502.5 5602.2 5628.6 5631.2 5675.6 1093.9 1189.8 1202.4 1276.5 1324.5 743.7 894.5 896.1 905.4 908.0 4495.6 5071.9 5116.3 5128.4 5130.3 4847.6 5324.3 5392.3 5607.3 5665.2 4351.9 5067.0 5068.6 5081.9 5084.7 2267.0 2368.2 2474.8 2519.4 2520.2 4558.7 4858.0 4892.9 4909.7 4911.2 4589.6 4636.9 4685.1 4821.8 4949.0 4211.0 4591.9 4882.6 4932.3 4968.9 4107.9 4178.5 4630.8 4661.1 4994.5 5406.0 5477.0 5794.8 5800.3 5826.9 4674.9 5862.4 6069.5 6075.1 6085.9 3774.8 3849.9 3864.8 3899.9 3918.2 5831.9 5834.3 5843.4 5849.0 5860.4 4683.6 4772.4 5098.7 5360.5 5653.2 4701.9 5329.4 5635.9 5673.5 5709.3 4008.4 5061.5 5091.1 5257.3 5473.5 4973.7 4973.9 5228.9 5714.4 5723.8 4758.8 5349.0 5467.3 5566.4 5603.8 05:09:04 INFO - PROCESS | 1647 | 05:09:04 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:25750.88 Median:3984.69 stddev:43050.33 (1080.4%) stddev-sans-first:43129.94 05:09:04 INFO - PROCESS | 1647 | Values: 679.2 769.2 773.5 793.6 821.5 15032.6 15572.4 16209.0 16228.8 16509.4 14555.0 14945.8 14954.6 14984.2 15149.0 692.1 708.5 829.1 840.3 843.5 684.7 835.5 850.0 851.0 859.4 860.0 861.1 861.7 861.8 863.4 720.5 854.0 854.8 857.5 858.1 546.1 637.6 648.5 654.1 654.6 14863.8 14886.6 14904.9 14914.0 14920.3 12035.6 13827.4 13911.4 14160.6 14240.5 12404.3 12591.7 12791.1 13153.5 13270.9 4510.5 4529.1 4566.5 4770.5 4771.9 124395.1 124844.0 124854.4 126146.0 126536.4 10970.0 11011.8 11018.3 11073.2 11262.3 21603.2 21633.8 21636.2 21649.6 21654.4 7750.2 8025.3 8149.4 8150.0 8150.1 3765.5 4331.5 4421.9 4582.5 4583.8 3417.2 3506.8 3554.6 3565.3 3572.5 652.4 665.6 666.5 678.1 678.7 612.4 612.8 616.7 639.9 667.9 7811.6 8572.7 8685.7 8862.3 8980.8 554.0 565.8 567.3 595.7 643.1 4203.9 4221.9 4468.8 4490.9 4530.2 125880.0 160643.2 161807.0 163203.0 165415.0 137957.0 143536.3 144228.3 146213.0 146529.0 116138.6 118367.0 119970.0 120595.4 121026.4 7708.9 7831.3 8049.5 8438.5 8470.6 48413.3 49839.8 60001.4 67837.0 67880.1 66484.7 97333.5 100328.0 100894.0 102851.0 10948.2 11298.2 11369.9 11699.4 11818.3 11865.3 12051.3 12060.2 12567.2 12604.4 11575.7 11723.9 11744.0 11989.5 12051.5 11361.8 11511.8 11567.2 11678.5 11935.9 11152.2 11251.3 11394.4 11494.7 11985.3 9247.3 9513.8 9735.7 10087.7 10159.0 8799.5 9782.2 9820.6 9833.8 9955.0 05:09:04 INFO - PROCESS | 1647 | -------- Summary: end -------- 05:09:04 INFO - PROCESS | 1647 | 05:09:05 INFO - TEST-INFO | 1647: exit 0 05:09:05 INFO - TEST-OK | dromaeo_css | took 1118015ms 05:09:05 INFO - TEST-START | kraken 05:09:05 INFO - operating with platform_type : mac_ 05:09:05 INFO - Initialising browser for kraken test... 05:09:05 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpOvgdEL/profile http://localhost:49266/getInfo.html) 05:09:07 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:09:07 INFO - PROCESS | 1657 | colorDepth:24 05:09:07 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:09:07 INFO - PROCESS | 1657 | __metrics 05:09:07 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" 05:09:07 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] 05:09:08 INFO - TEST-INFO | 1657: exit 0 05:09:08 INFO - Browser initialized. 05:09:08 INFO - Running cycle 1/1 for kraken test... 05:09:08 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpOvgdEL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:20 INFO - PROCESS | 1658 | RSS: Main: 229556224 05:09:20 INFO - PROCESS | 1658 | 05:09:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:24 INFO - PROCESS | 1658 | RSS: Main: 291549184 05:09:24 INFO - PROCESS | 1658 | 05:09:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 05:09:27 INFO - PROCESS | 1658 | RSS: Main: 292634624 05:09:27 INFO - PROCESS | 1658 | 05:09:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 05:09:31 INFO - PROCESS | 1658 | RSS: Main: 383541248 05:09:31 INFO - PROCESS | 1658 | 05:09:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 05:09:34 INFO - PROCESS | 1658 | RSS: Main: 282906624 05:09:34 INFO - PROCESS | 1658 | 05:09:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:36 INFO - PROCESS | 1658 | RSS: Main: 286969856 05:09:36 INFO - PROCESS | 1658 | 05:09:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:40 INFO - PROCESS | 1658 | RSS: Main: 324202496 05:09:40 INFO - PROCESS | 1658 | 05:09:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:43 INFO - PROCESS | 1658 | RSS: Main: 326213632 05:09:43 INFO - PROCESS | 1658 | 05:09:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 05:09:47 INFO - PROCESS | 1658 | RSS: Main: 324018176 05:09:47 INFO - PROCESS | 1658 | 05:09:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:49 INFO - PROCESS | 1658 | RSS: Main: 302370816 05:09:49 INFO - PROCESS | 1658 | 05:09:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:52 INFO - PROCESS | 1658 | RSS: Main: 305614848 05:09:52 INFO - PROCESS | 1658 | 05:09:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:55 INFO - PROCESS | 1658 | RSS: Main: 310300672 05:09:55 INFO - PROCESS | 1658 | 05:09:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:58 INFO - PROCESS | 1658 | RSS: Main: 321232896 05:09:58 INFO - PROCESS | 1658 | 05:10:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:02 INFO - PROCESS | 1658 | RSS: Main: 317575168 05:10:02 INFO - PROCESS | 1658 | 05:10:03 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 05:10:04 INFO - PROCESS | 1658 | RSS: Main: 361078784 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | __start_tp_report 05:10:04 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 05:10:04 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 05:10:04 INFO - PROCESS | 1658 | |i|pagename|runs| 05:10:04 INFO - PROCESS | 1658 | |0;ai-astar;104;112;113;112;113;113;113;113;113;113 05:10:04 INFO - PROCESS | 1658 | |1;audio-beat-detection;145;108;106;145;110;108;113;132;175;112 05:10:04 INFO - PROCESS | 1658 | |2;audio-dft;183;180;184;184;190;219;186;186;179;185 05:10:04 INFO - PROCESS | 1658 | |3;audio-fft;78;58;60;88;62;60;59;58;82;58 05:10:04 INFO - PROCESS | 1658 | |4;audio-oscillator;85;72;121;102;100;68;91;67;68;89 05:10:04 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;89;84;88;92;134;115;89;86;88;84 05:10:04 INFO - PROCESS | 1658 | |6;imaging-darkroom;93;93;94;93;96;92;93;93;93;92 05:10:04 INFO - PROCESS | 1658 | |7;imaging-desaturate;84;85;85;84;84;85;83;84;84;84 05:10:04 INFO - PROCESS | 1658 | |8;json-parse-financial;42;42;77;79;78;79;81;44;44;75 05:10:04 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;65;73;79;74;73;71;70;71;70;71 05:10:04 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;82;86;86;87;88;88;85;95;91;90 05:10:04 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;140;135;143;154;147;135;134;138;179;137 05:10:04 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;175;175;172;169;169;170;170;167;170;172 05:10:04 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;67;66;67;69;67;67;68;69;79 05:10:04 INFO - PROCESS | 1658 | __end_tp_report 05:10:04 INFO - PROCESS | 1658 | __start_cc_report 05:10:04 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2001 05:10:04 INFO - PROCESS | 1658 | __end_cc_report 05:10:04 INFO - PROCESS | 1658 | __startTimestamp1473768604109__endTimestamp 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | ------- Summary: start ------- 05:10:04 INFO - PROCESS | 1658 | Number of tests: 14 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.81 (2.5%) stddev-sans-first:0.44 05:10:04 INFO - PROCESS | 1658 | Values: 104.0 112.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 113.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:122.50 stddev:23.15 (18.9%) stddev-sans-first:23.45 05:10:04 INFO - PROCESS | 1658 | Values: 145.0 108.0 106.0 145.0 110.0 108.0 113.0 132.0 175.0 112.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:187.60 Median:185.50 stddev:11.46 (6.2%) stddev-sans-first:12.04 05:10:04 INFO - PROCESS | 1658 | Values: 183.0 180.0 184.0 184.0 190.0 219.0 186.0 186.0 179.0 185.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.00 stddev:11.61 (19.0%) stddev-sans-first:11.51 05:10:04 INFO - PROCESS | 1658 | Values: 78.0 58.0 60.0 88.0 62.0 60.0 59.0 58.0 82.0 58.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:70.00 stddev:18.00 (25.7%) stddev-sans-first:19.09 05:10:04 INFO - PROCESS | 1658 | Values: 85.0 72.0 121.0 102.0 100.0 68.0 91.0 67.0 68.0 89.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:88.00 stddev:16.41 (18.6%) stddev-sans-first:17.26 05:10:04 INFO - PROCESS | 1658 | Values: 89.0 84.0 88.0 92.0 134.0 115.0 89.0 86.0 88.0 84.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 05:10:04 INFO - PROCESS | 1658 | Values: 93.0 93.0 94.0 93.0 96.0 92.0 93.0 93.0 93.0 92.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 05:10:04 INFO - PROCESS | 1658 | Values: 84.0 85.0 85.0 84.0 84.0 85.0 83.0 84.0 84.0 84.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:77.50 stddev:18.24 (23.5%) stddev-sans-first:17.50 05:10:04 INFO - PROCESS | 1658 | Values: 42.0 42.0 77.0 79.0 78.0 79.0 81.0 44.0 44.0 75.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:3.56 (4.9%) stddev-sans-first:2.83 05:10:04 INFO - PROCESS | 1658 | Values: 65.0 73.0 79.0 74.0 73.0 71.0 70.0 71.0 70.0 71.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:88.00 stddev:3.58 (4.1%) stddev-sans-first:3.13 05:10:04 INFO - PROCESS | 1658 | Values: 82.0 86.0 86.0 87.0 88.0 88.0 85.0 95.0 91.0 90.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:141.50 stddev:13.73 (9.7%) stddev-sans-first:14.48 05:10:04 INFO - PROCESS | 1658 | Values: 140.0 135.0 143.0 154.0 147.0 135.0 134.0 138.0 179.0 137.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:171.00 stddev:2.60 (1.5%) stddev-sans-first:2.30 05:10:04 INFO - PROCESS | 1658 | Values: 175.0 175.0 172.0 169.0 169.0 170.0 170.0 167.0 170.0 172.0 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:3.74 (5.5%) stddev-sans-first:3.96 05:10:04 INFO - PROCESS | 1658 | Values: 68.0 67.0 66.0 67.0 69.0 67.0 67.0 68.0 69.0 79.0 05:10:04 INFO - PROCESS | 1658 | -------- Summary: end -------- 05:10:04 INFO - PROCESS | 1658 | 05:10:04 INFO - TEST-INFO | 1658: exit 0 05:10:05 INFO - TEST-OK | kraken | took 59659ms 05:10:05 INFO - SUITE-END | took 1177s 05:10:05 INFO - Completed test suite (00:19:37) 05:10:05 INFO - javascript benchmark 05:10:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.9004929852103, 3358.0597432718846, 3374.8650053997835, 3380.712639425649, 3399.1841957930105, 5559.19391688206, 5676.035074037419, 5698.715064246791, 5752.683602401867, 5753.2520772299595, 5683.0, 5716.114002329635, 5727.0, 5730.7707691692385, 5731.455511726379, 5165.096108181072, 5198.636095473299, 5210.088234558956, 5238.8690282742855, 5257.36911570612, 5269.736513174326, 5270.288511050997, 5285.920711189336, 5287.576993840503, 5296.629235953485, 5206.869828254286, 5241.475852414766, 5244.737763111848, 5255.816046438375, 5261.684298942057, 5295.655782374152, 5297.708626025567, 5307.0, 5318.069337865858, 5340.931813637288, 5038.496150384969, 5154.252633368141, 5248.8425347239645, 5261.3686357637325, 5280.6039547034125, 5562.9443705562835, 5575.665460072409, 5607.52336051432, 5667.234923285345, 5674.886502269931, 5065.0, 6146.200993870768, 6220.68896555175, 6228.346023667495, 6232.3144454110015, 6124.005123272519, 6226.097215903714, 6290.937090629127, 6298.6535740534255, 6303.55875088744, 5711.571632127566, 5737.799177028784, 5754.539636829044, 5786.450287222707, 5794.478496935296, 6195.9869621123125, 6236.438720515175, 6244.1570387997035, 6245.281792593819, 6265.968670156712, 6112.174856394418, 6149.477294429934, 6149.815505534841, 6150.7232174552255, 6150.7847225346895, 6095.207623009069, 6132.8773424532155, 6140.074827791203, 6199.442050215503, 6245.594036387711, 6119.533019689859, 6149.477294429934, 6155.384461553809, 6218.906716399258, 6243.313235544087, 6191.133241346215, 6232.56372053961, 6261.405166509175, 6274.215723034621, 6276.6547839868335, 4839.7096174229655, 4894.877628059256, 4945.23348880924, 4956.0, 4975.552200301918, 4361.869143925624, 4441.555844415532, 4452.48796388413, 4469.642428605704, 4474.574915383034, 5734.197212390269, 5780.971095144498, 5789.710514474344, 5863.5309175265875, 5882.411758824083, 6243.937560624427, 6272.655003974825, 6297.590656607306, 6297.811065668037, 6305.0, 5801.622894511843, 5826.650400975955, 5831.475167234969, 5834.0, 5871.588988770831, 5310.707911064928, 5352.598555108305, 5384.40771515133, 5442.210879422461, 5444.945550544444, 6196.628202307876, 6310.5267104967315, 6321.431071203614, 6322.8735425290315, 6337.8732425352155, 6243.843903902439, 6274.749010039547, 6280.780172693934, 6302.684865756785, 6316.115743795965, 5554.555635549065, 6155.599886007395, 6317.084022816758, 6323.336049714714, 6323.620582765049, 6098.807833950406, 6142.477889379453, 6152.477039451696, 6211.161493198541, 6226.62640241587, 5034.597232221487, 5981.461668449861, 6208.0, 6258.624482531062, 6287.2769631492965, 5926.585139040399, 6124.846878828065, 6137.0, 6147.538934580014, 6161.630302181883, 6001.4298641628975, 6056.485198757979, 6066.393360663898, 6099.481544068626, 6138.877222455437, 5996.8500787478915, 6000.0, 6001.639901605918, 6009.969950150221, 6019.067044608093, 6107.908381374372, 6137.478314343331, 6140.785072522441, 6144.662043587646, 6144.969275153596, 5718.714064296685, 5845.09401042839, 5895.970520147372, 5897.3807750185615, 5942.673152976455], "value": 5695.941351624339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.61454341994175, 505.4137200847018, 506.1420891588759, 532.8587924200086, 556.326844518133, 30853.0, 40961.18077638449, 41800.0, 41808.95477613061, 41909.58090419095, 43037.7848110759, 43270.78364608181, 43303.56696433035, 43410.565894341045, 43544.91137721558, 9712.368696034753, 9897.653582124627, 9913.256505762061, 9922.90077099227, 9968.800623987516, 9763.951180244088, 9891.703248902544, 9895.703128906145, 9911.25665575081, 9921.454320012397, 9856.605735770561, 9882.357646752975, 9906.207503399746, 9918.355306905065, 9924.751881202956, 9427.245820334358, 9883.061109194616, 9892.50537473127, 9923.206143508502, 9924.0, 9724.270679699051, 9801.656942007066, 9804.36271642341, 9804.705858824247, 9834.65578704749, 40702.185956281006, 41046.0, 41133.0, 41169.79415102935, 41348.1730365391, 3410.471376936579, 3490.9127271818406, 3849.556416343871, 4031.3193318277345, 4182.539920608761, 30983.22541936447, 31326.0, 32111.83944080288, 32321.35357292841, 32506.6749332506, 3004.8581539015254, 3032.6664066952617, 3195.201199700075, 3225.7580831379855, 3257.2671148991526, 474587.0, 474632.0, 475005.0, 475076.0, 475889.0, 50514.494855051715, 54811.62970925679, 57762.71118644464, 57844.13233801496, 58099.12851307234, 57164.71417642968, 57283.427165728644, 57304.42695573074, 57405.712971435714, 57439.71280143572, 15944.123073231083, 16175.757363639555, 16184.83815161857, 16191.595210119842, 16225.756613650805, 12457.0, 12521.93739031299, 12526.561570344995, 12537.24776513394, 12552.372381380894, 12322.137450378566, 13957.115009746507, 14259.215743134228, 15004.399824006918, 15782.68434631301, 5396.0, 6256.311805701369, 6291.245050593867, 6315.463185629181, 6361.554691171574, 858.7810108422312, 907.8411278026451, 918.7381596245039, 942.3026960049514, 999.2905037423511, 27921.301967450978, 29273.268168295963, 29490.85254573756, 29748.0, 29763.492905779127, 995.64654547636, 1008.8991100889999, 1053.8208504554243, 1055.37205362809, 1108.2685427617894, 14713.117212967256, 15087.396504139931, 15180.620484487756, 15363.539093827203, 15549.0, 627282.0, 628186.0, 629939.0, 630692.0, 635562.0, 58046.83906321934, 58192.709036454544, 58279.125813112834, 58282.12576811351, 58340.0, 1219.4207751318054, 1250.4873002069107, 1335.2856221921224, 1354.8983826213073, 1377.6349267444136, 29526.0, 31193.68806311908, 31276.218094547818, 31483.212919677193, 32121.51817722689, 40656.0, 49212.0, 49665.255021175435, 49741.0, 49985.0, 533734.6145001125, 535540.0, 537248.6476217159, 537275.0, 538007.0, 31796.841015794773, 33009.33981320408, 39340.803295983336, 40402.989925252106, 40492.0, 41420.378694320214, 44288.0, 46395.536044640474, 47596.0, 47824.760876196786, 38952.80523597364, 38995.6100438992, 39221.41167882541, 40282.1943561133, 40283.1943361137, 38531.0, 39917.0, 41905.79047104867, 42447.0, 43635.56364436442, 34139.0, 35620.46569301515, 35968.820155899055, 40294.1941161181, 42300.40446562077, 34501.654983449844, 38842.61157388503, 38905.41641875318, 40373.39439908345, 40780.59219407768, 30010.84994575013, 31265.062048138592, 31270.0, 31826.78891767915, 32035.359292813548], "value": 20010.479729274077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.1945263430963, 370.1191165027235, 377.13823912360255, 386.79499865071506, 406.7925358067385, 14913.776293355608, 15091.0, 16878.57803554912, 20189.495262618406, 20914.686279705817, 16548.172591370443, 19382.321618743346, 19848.20607175711, 20286.98565071744, 20339.389818305473, 5330.3603567571845, 5534.308211473566, 5544.16837474378, 5547.694876781776, 5561.5828812839, 5817.272840894888, 6105.511559075263, 6171.074338849164, 6180.165677633507, 6190.566660333779, 3878.728489005771, 4103.220388126261, 6174.629522228681, 6553.475721942234, 6835.077264569294, 6649.567778094409, 6668.599884006927, 6817.931820681779, 6861.1423572053745, 6876.381125698686, 5971.313298970587, 5974.731137098841, 5977.701114944235, 5987.341392446828, 5996.430339117776, 12829.807552886714, 16919.661606767797, 24923.0, 25000.4999900001, 25158.371040723945, 2077.989610051955, 2228.7882651148116, 2485.478049609584, 2528.6092649043135, 2796.6364372631633, 9778.657746978894, 9786.217102631843, 9825.213982881352, 10163.949180254125, 10182.439965801877, 1687.772150759644, 1763.6031892824012, 1825.9360922367653, 1833.1604563951046, 1879.6804543227547, 118531.0, 119675.0, 121818.39090804578, 125328.0, 125437.0, 11020.50407731654, 11098.944505277583, 11231.606893758679, 11351.489182986785, 11359.204855660024, 14284.0001199915, 14295.642608934651, 14301.78547321791, 14305.499307524187, 14320.212388318534, 8326.333893288522, 8472.322214222848, 8474.915250847536, 8481.830363392697, 8610.923634545681, 8351.707690230813, 8374.204450577185, 8376.49741015541, 8519.531425771518, 8561.44350617208, 4469.642428605769, 4484.148011877733, 4494.9325760113625, 4495.0, 4543.4093567836635, 1668.4827703411981, 1843.806400327973, 1853.6385404846196, 1893.9810601893805, 1899.4586542835225, 911.7447114807865, 942.7030485397078, 943.3443756589105, 956.6269155029544, 963.7446076789656, 11713.414329283502, 12244.938775306067, 12276.938615306866, 19612.70580941287, 21206.787932120482, 361.48668890176015, 422.2968757019589, 433.8091239854454, 437.0, 439.05383897700506, 5707.143928410772, 5890.2342695449315, 5940.34656187819, 6000.879982400327, 6155.384461553809, 591187.0, 599707.0, 606443.0, 610380.0, 610412.0, 133313.0, 133933.0, 136675.0, 139864.300678498, 141947.0, 430.3759548654401, 452.85508637236427, 454.3094496365506, 456.39299731357215, 456.4818930513891, 11123.03951185654, 11131.387773672526, 11300.604478843201, 11413.828792567952, 11545.769084618429, 53429.0, 55126.72436637791, 56477.43522564722, 56736.716316418155, 57406.13890791558, 77225.0, 83107.58446207971, 83636.0, 84924.15075849163, 85828.57085714531, 7952.681892724227, 8175.182481751777, 8176.591170441573, 8305.709300174465, 8452.797289398377, 9308.860367094363, 12238.449269782703, 12981.4158362872, 13201.471941122247, 13420.932895335462, 11078.723031924266, 11098.0, 11448.0, 11494.827577586175, 11585.0, 9936.0, 10951.288166269167, 11061.94469027682, 11406.315621062762, 11417.657470275904, 11288.94355528217, 11375.374354410256, 11716.121290903387, 11803.940980295043, 11826.467808948446, 8088.555129467935, 8303.543305118277, 8311.085780564254, 8410.915890841014, 8552.417802706519, 8019.438639295194, 10224.744381390525, 11282.266652667551, 11519.596814111466, 11642.94178529102], "value": 8777.33510460467, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.2802750528467, 1366.0301186157828, 1507.6230942264438, 1685.1911082680313, 1904.6190761847633, 7773.183815699348, 8279.089300176976, 8592.699255526059, 8926.973398059225, 8930.017698053209, 8791.912080879189, 8882.333824963122, 8891.644334226623, 8902.065283145273, 8904.554772261394, 2390.7011623547055, 2415.45652228249, 2419.9637005444933, 2421.32202983165, 2424.8787560621986, 2359.374765687094, 2406.0616359619676, 2406.831521793475, 2408.8072954163713, 2418.105301038618, 2376.6435034744754, 2398.0647547456506, 2409.6987876515436, 2412.6381042843627, 2417.359399759065, 2357.610994185957, 2393.0, 2393.772591603795, 2400.3159099656514, 2403.267003563912, 2347.401412639783, 2367.6922000140044, 2380.833341666084, 2382.0590866607768, 2382.702162229721, 8793.0, 8902.821943561092, 8912.975007874113, 8998.640054397882, 9039.412438191497, 5233.895322093575, 5397.433269506684, 5430.321209848769, 5446.346438427375, 5447.727613619343, 3639.0, 3651.6165802590876, 3694.6305369463107, 3724.478572999782, 3730.552333719971, 1061.4215252687304, 1072.855164552791, 1074.2372915230196, 1085.1861104171871, 1094.6497120921308, 11762.294262344201, 11786.292822430682, 11858.40707964607, 11859.169858109935, 11908.523659053713, 4439.178751930903, 4499.68502204849, 4685.016146609182, 4686.531346865354, 4688.742119183477, 9275.350725449154, 9290.396124252036, 9302.90697093034, 9317.90682093184, 9328.440293582407, 5313.521783039545, 5327.121025030827, 5327.973360133252, 5331.173668081454, 5339.519443250126, 4373.234683930299, 4397.670174736908, 4479.395281637003, 4652.767361631905, 5010.949890501049, 3241.854116564713, 3747.4191500317493, 3811.294910441577, 3847.980285224418, 3857.0935830079907, 1010.7068950004564, 1166.731651720109, 1181.8345431639577, 1182.9704257393635, 1183.9408029598485, 766.3983772738374, 789.4671097009495, 886.2821114896955, 926.9860952085725, 927.9721608351625, 5532.917006244909, 5539.806106786243, 5939.4557415072395, 6007.098935159761, 6033.607815491979, 928.8885333759857, 957.4446820843893, 969.6170012845027, 979.2068424576116, 1067.412922892406, 3385.2396753688436, 3793.943090853639, 3811.123441608446, 3886.4753258310334, 3913.3934240192816, 10595.682129536126, 10772.407517586451, 10906.672799816019, 10915.072218861327, 10948.288361256493, 10278.17774578032, 10697.786044279072, 10708.678739637824, 10846.29499082557, 10858.131349492021, 7976.960115199387, 8200.138985406566, 8219.301359384519, 8219.465734727342, 8229.300509456763, 5585.916211256753, 5781.768729250783, 5832.387599302182, 5940.079287710412, 6144.846378840386, 9892.208623310262, 10152.492375381054, 10173.033561811617, 10186.796264074528, 10192.643257485952, 9453.810923781624, 10331.483425828828, 10399.58401663925, 10530.36817790935, 10536.157107431234, 7005.54463959841, 7122.18094919091, 7235.782926512213, 7260.782176534713, 7353.338199561851, 7910.485818422015, 7926.841463170589, 7950.085740139958, 7974.003249593801, 8030.63862126194, 7226.349628533457, 7280.854382912418, 7304.5252058616015, 7349.8162545936775, 7387.4090072795125, 6201.2868520118955, 6778.593284402951, 7075.752348667772, 7096.290370962863, 7224.674889630084, 6649.833754156185, 6806.897896531457, 6814.62519561409, 6815.522913396015, 6840.281770414035, 4116.547179810159, 4742.549457801503, 4908.533689299511, 4932.827351042696, 4994.325766021686, 4856.9314750754775, 4882.389701287339, 4901.705897646153, 4973.0, 4987.077390682735], "value": 4539.648648032625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.1554754461281, 303.0529595015576, 310.09761593762147, 313.30602714986316, 318.9170815587946, 4604.378408914799, 5080.847574572759, 5166.328377310944, 5304.49607287308, 5357.196420536917, 4249.893752656185, 4562.90874182517, 5163.81926632568, 5169.741512924357, 5196.792128314863, 3622.876908158479, 3685.8942317304836, 4033.3748269018347, 4074.144429669758, 4083.775392353419, 3799.5060642116623, 4101.457096600112, 4106.1992911382295, 4106.917861642765, 4121.629053385194, 3543.919104673074, 3951.5060617422823, 3989.5412027616903, 4011.5186177658575, 4082.9183416331657, 3741.8877433677035, 4022.1955608878343, 4025.657819085396, 4040.757554546707, 4078.714489985702, 2934.6669397828778, 3054.8167109973474, 3364.310316385135, 3501.9299614007577, 3521.4365701487895, 4900.730459824708, 5188.195829646411, 5206.095428428678, 5228.738563071831, 5258.6581872178185, 3629.3467175908327, 4556.453225612948, 4616.714726210514, 4624.392973480691, 4626.444826620794, 4898.951010489885, 5246.344206974129, 5601.19940029985, 5607.971960140173, 5638.351589567212, 3684.5025921500524, 3804.90487737806, 3815.7138214634015, 3821.719723892499, 3831.444440556104, 5190.480951904817, 5716.228309178249, 5893.174955506232, 5897.938371093202, 5911.970440147772, 3255.544223808621, 3617.3127105849803, 3871.225754848985, 3883.30100581898, 3884.057971014493, 3665.7617254878346, 3700.296943580711, 3916.4921505220127, 3929.351656976624, 3958.4364176150834, 3828.942565861514, 4028.5165780106577, 4569.811848919305, 4600.815967361335, 4605.953940460619, 4502.482214545304, 5602.243697100921, 5628.634138781048, 5631.18347839561, 5675.631083979611, 1093.945302734876, 1189.7798907202196, 1202.392791640216, 1276.4638851682316, 1324.5165514587106, 743.6913680822398, 894.4901406198404, 896.1441823058963, 905.3526728389234, 907.9727608171765, 4495.640348772155, 5071.949280507221, 5116.334876466036, 5128.358955130609, 5130.333056702605, 4847.587955023862, 5324.307839980777, 5392.272043274186, 5607.2897766180895, 5665.235193248858, 4351.891202719958, 5067.0, 5068.6451948363265, 5081.949180508222, 5084.720340381241, 2267.013848975701, 2368.171140100951, 2474.8267621266336, 2519.3953451171587, 2520.218732193026, 4558.703684260512, 4858.0, 4892.902141957212, 4909.656324057353, 4911.18965370717, 4589.5639914208095, 4636.8670411610365, 4685.079117561783, 4821.7589120543835, 4949.0, 4211.031462763521, 4591.862244132682, 4882.632862798422, 4932.309476673268, 4968.8757781055765, 4107.876763697094, 4178.519470260959, 4630.768461576975, 4661.112249538942, 4994.450610432922, 5405.97276021492, 5477.0, 5794.783095549982, 5800.332961709458, 5826.94173058264, 4674.943025068958, 5862.355140934408, 6069.51443884497, 6075.083959699281, 6085.908711369421, 3774.7923864186637, 3849.9037524062123, 3864.787436691009, 3899.883003509899, 3918.1967696622696, 5831.912521312269, 5834.27071616048, 5843.370483282625, 5848.970755146367, 5860.443257890493, 4683.648726345469, 4772.375193643413, 5098.674344670487, 5360.463953604608, 5653.180288858175, 4701.858944231679, 5329.350261389096, 5635.88728225425, 5673.5461163107675, 5709.25779648643, 4008.4388185653447, 5061.519155680205, 5091.134507133722, 5257.342832145981, 5473.549509380097, 4973.651844370859, 4973.9306049199595, 5228.921566176587, 5714.3714191438075, 5723.7996670116345, 4758.809647614056, 5349.0, 5467.289252397163, 5566.443355664401, 5603.80386686464], "value": 3935.1555307127696, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.2256827216974, 769.2077160524658, 773.5281478298234, 793.5794029164545, 821.5235163605108, 15032.624184395381, 15572.37710491579, 16209.0, 16228.756568651464, 16509.422170224043, 14555.0, 14945.775813362781, 14954.62613434662, 14984.175870327128, 15149.015314004582, 692.1486571517037, 708.5323686366999, 829.0838623321233, 840.2899549880372, 843.5402705525503, 684.691888650107, 835.4903508859591, 850.0097386544699, 850.9829803403928, 859.4456575508793, 860.0, 861.1087524412203, 861.7156338408311, 861.8362511122898, 863.3869952333819, 720.5028530314066, 854.0434713121344, 854.7521218846558, 857.5283594023325, 858.1375717404001, 546.0907588864536, 637.6461064109418, 648.5006544960354, 654.1365397675071, 654.5908806995627, 14863.777043344358, 14886.553403397915, 14904.850951490454, 14914.0, 14920.2539873007, 12035.638930832089, 13827.446902123904, 13911.373988170557, 14160.645983850383, 14240.50158244467, 12404.25574465535, 12591.685207869785, 12791.104622676416, 13153.53962611304, 13270.933645331712, 4510.481294651091, 4529.063897302739, 4566.474855391639, 4770.546798054179, 4771.928421073687, 124395.13407298898, 124844.0, 124854.37572812168, 126146.0, 126536.36731816374, 10970.0, 11011.779764404668, 11018.283811552223, 11073.224874258885, 11262.267952583055, 21603.243886463897, 21633.783662163492, 21636.242731504637, 21649.56700865974, 21654.35036948894, 7750.186230445835, 8025.2777250047775, 8149.429539932148, 8149.959250203711, 8150.144234855255, 3765.4728338032696, 4331.480222373272, 4421.9336709949375, 4582.450105987236, 4583.839565615254, 3417.2311229973056, 3506.7545271830727, 3554.59122200945, 3565.3404120237838, 3572.5355703758346, 652.3639451534716, 665.6369886901481, 666.5267659961385, 678.060885673346, 678.6708446403491, 612.4182027074297, 612.834534675635, 616.747133675191, 639.9360063993563, 667.9365460281266, 7811.648475818602, 8572.699955501528, 8685.6525738971, 8862.291016718647, 8980.823916878682, 554.027681419115, 565.8047973449236, 567.2937193194499, 595.7229888101966, 643.0547095769211, 4203.91592168155, 4221.852235171816, 4468.776561171929, 4490.910181796346, 4530.184566778012, 125880.0, 160643.19678401534, 161807.0, 163203.0, 165415.0, 137957.0, 143536.28231858983, 144228.27885860714, 146213.0, 146529.0, 116138.64405593296, 118367.0, 119970.0, 120595.39702301432, 121026.39486802685, 7708.922910770821, 7831.334336581454, 8049.51702897828, 8438.53588052663, 8470.618822152896, 48413.27380089231, 49839.754006150135, 60001.39998599958, 67836.98244526237, 67880.10693380366, 66484.66757666181, 97333.53999690151, 100328.0, 100894.0, 102851.0, 10948.20035037411, 11298.152638551977, 11369.886301136883, 11699.415029248674, 11818.290902545874, 11865.347405892759, 12051.33717645538, 12060.216085954386, 12567.245965242115, 12604.432800523815, 11575.652730418102, 11723.941380293385, 11744.0, 11989.520419183134, 12051.51793928233, 11361.829572556253, 11511.791261917713, 11567.190296679151, 11678.532858685558, 11935.880641193824, 11152.219344645797, 11251.324920504796, 11394.430278486208, 11494.712632184262, 11985.28088314704, 9247.260219182584, 9513.809723805623, 9735.659251926148, 10087.69736907894, 10159.0, 8799.548233056303, 9782.168515676247, 9820.635411779731, 9833.803323933338, 9955.003107520199], "value": 7608.62466401783, "unit": "score"}], "name": "dromaeo_css", "value": 7171.123325042679, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 106.0, 145.0, 110.0, 108.0, 113.0, 132.0, 175.0, 112.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 184.0, 184.0, 190.0, 219.0, 186.0, 186.0, 179.0, 185.0], "value": 187.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 60.0, 88.0, 62.0, 60.0, 59.0, 58.0, 82.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 121.0, 102.0, 100.0, 68.0, 91.0, 67.0, 68.0, 89.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 88.0, 92.0, 134.0, 115.0, 89.0, 86.0, 88.0, 84.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 96.0, 92.0, 93.0, 93.0, 93.0, 92.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 83.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 42.0, 77.0, 79.0, 78.0, 79.0, 81.0, 44.0, 44.0, 75.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 79.0, 74.0, 73.0, 71.0, 70.0, 71.0, 70.0, 71.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 86.0, 87.0, 88.0, 88.0, 85.0, 95.0, 91.0, 90.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 143.0, 154.0, 147.0, 135.0, 134.0, 138.0, 179.0, 137.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 172.0, 169.0, 169.0, 170.0, 170.0, 167.0, 170.0, 172.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 67.0, 69.0, 67.0, 67.0, 68.0, 69.0, 79.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1457.2000000000003, "alertThreshold": 2.0}]} 05:10:05 INFO - Return code: 0 05:10:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:10:05 INFO - # TBPL SUCCESS # 05:10:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:05 INFO - 2016-09-13 05:10:05.399 screenresolution[1662:9664] starting screenresolution argv=screenresolution get 05:10:05 INFO - 2016-09-13 05:10:05.402 screenresolution[1662:9664] Display 0: 1600x1200x32@60 05:10:05 INFO - 2016-09-13 05:10:05.408 screenresolution[1663:9667] starting screenresolution argv=screenresolution list 05:10:05 INFO - Available Modes on Display 0 05:10:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:05 INFO - Intel Iris: 05:10:05 INFO - Chipset Model: Intel Iris 05:10:05 INFO - Type: GPU 05:10:05 INFO - Bus: Built-In 05:10:05 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:05 INFO - Vendor: Intel (0x8086) 05:10:05 INFO - Device ID: 0x0a2e 05:10:05 INFO - Revision ID: 0x0009 05:10:05 INFO - Displays: 05:10:05 INFO - Display: 05:10:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:05 INFO - Display Serial Number: 1600x1200 60 05:10:05 INFO - Main Display: Yes 05:10:05 INFO - Mirror: Off 05:10:05 INFO - Online: Yes 05:10:05 INFO - Rotation: Supported 05:10:05 INFO - Return code: 0 05:10:05 INFO - Running post-action listener: _resource_record_post_action 05:10:05 INFO - [mozharness: 2016-09-13 12:10:05.651469Z] Finished run-tests step (success) 05:10:05 INFO - Running post-run listener: _resource_record_post_run 05:10:05 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38437888; Write bytes: 705036288; Read time: 374; Write time: 2217 05:10:05 INFO - TinderboxPrint: CPU usage
53.6% 05:10:05 INFO - TinderboxPrint: I/O read bytes / time
38,437,888 / 374 05:10:05 INFO - TinderboxPrint: I/O write bytes / time
705,036,288 / 2,217 05:10:05 INFO - TinderboxPrint: CPU idle
2,250.7 (46.4%) 05:10:05 INFO - TinderboxPrint: CPU system
970.3 (20.0%) 05:10:05 INFO - TinderboxPrint: CPU user
1,628.7 (33.6%) 05:10:05 INFO - TinderboxPrint: Swap in / out
443,543,552 / 0 05:10:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403927552; Write bytes: 399140864; Read time: 29804; Write time: 804 05:10:05 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34456576; Write bytes: 295114752; Read time: 340; Write time: 1384 05:10:06 INFO - Running post-run listener: _upload_blobber_files 05:10:06 INFO - Blob upload gear active. 05:10:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:10:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:10:06 INFO - (blobuploader) - INFO - Open directory for files ... 05:10:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:10:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:10:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:07 INFO - (blobuploader) - INFO - Done attempting. 05:10:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:10:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:08 INFO - (blobuploader) - INFO - Done attempting. 05:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:11 INFO - (blobuploader) - INFO - Done attempting. 05:10:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:10:11 INFO - Return code: 0 05:10:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:10:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:10:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/145aa2c2165ba4f9968fa46b0f06c1e1818e8e31b3fc1af53f2ad9de4cce2c7af6170d498c0d893af9db54d53cf003dc51b21354e780372afd4d1282aab0967b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fff86915a6e29b5de2a686ac6afebbda370b12ec739cb396c30d66f3650fb545e9f74e1ec948e915b9f5669479b78d3a10dc9c68c8b9007b2a0a308621b788b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8582882310c9f3612b43ba55974ddfd843177bac1c9902c5db8f6a93ddf8debbb7fd75f2fedae5b4c24321b0f887c3ff30fd91f86a6bb4d85b397d7adfe17f0b"} 05:10:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:10:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:10:11 INFO - Contents: 05:10:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/145aa2c2165ba4f9968fa46b0f06c1e1818e8e31b3fc1af53f2ad9de4cce2c7af6170d498c0d893af9db54d53cf003dc51b21354e780372afd4d1282aab0967b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fff86915a6e29b5de2a686ac6afebbda370b12ec739cb396c30d66f3650fb545e9f74e1ec948e915b9f5669479b78d3a10dc9c68c8b9007b2a0a308621b788b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8582882310c9f3612b43ba55974ddfd843177bac1c9902c5db8f6a93ddf8debbb7fd75f2fedae5b4c24321b0f887c3ff30fd91f86a6bb4d85b397d7adfe17f0b"} 05:10:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:10:11 INFO - Copying logs to upload dir... 05:10:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:10:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.087422 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-13 05:10:11.438149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 05:10:11.441535) ========= 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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/145aa2c2165ba4f9968fa46b0f06c1e1818e8e31b3fc1af53f2ad9de4cce2c7af6170d498c0d893af9db54d53cf003dc51b21354e780372afd4d1282aab0967b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fff86915a6e29b5de2a686ac6afebbda370b12ec739cb396c30d66f3650fb545e9f74e1ec948e915b9f5669479b78d3a10dc9c68c8b9007b2a0a308621b788b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8582882310c9f3612b43ba55974ddfd843177bac1c9902c5db8f6a93ddf8debbb7fd75f2fedae5b4c24321b0f887c3ff30fd91f86a6bb4d85b397d7adfe17f0b"} build_url:https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010917 build_url: 'https://queue.taskcluster.net/v1/task/BcsBoAgxQiCOCCpLwTiSMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/145aa2c2165ba4f9968fa46b0f06c1e1818e8e31b3fc1af53f2ad9de4cce2c7af6170d498c0d893af9db54d53cf003dc51b21354e780372afd4d1282aab0967b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fff86915a6e29b5de2a686ac6afebbda370b12ec739cb396c30d66f3650fb545e9f74e1ec948e915b9f5669479b78d3a10dc9c68c8b9007b2a0a308621b788b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8582882310c9f3612b43ba55974ddfd843177bac1c9902c5db8f6a93ddf8debbb7fd75f2fedae5b4c24321b0f887c3ff30fd91f86a6bb4d85b397d7adfe17f0b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 05:10:11.478119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 05:10:11.478447) ========= 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.vIb6RvHg3O/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.0pwNuDOUDu/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.005247 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 05:10:11.532542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 05:10:11.533243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 05:10:11.534017) ========= ========= Total master_lag: 0.20 =========