builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0370 starttime: 1485620334.15 results: success (0) buildid: 20170128071620 builduid: 935d178bb0094261b8c0af6c2a2ceacc revision: 83336666dfce1ad037f1f1bd881f43bfdc266831 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:54.151200) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:54.151631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:54.151905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:54.181321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:54.181592) ========= 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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 --2017-01-28 08:18:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2017-01-28 08:18:54 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.634500 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:54.892443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:54.892719) ========= 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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.026450 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:54.943817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-28 08:18:54.944193) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 83336666dfce1ad037f1f1bd881f43bfdc266831 --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 83336666dfce1ad037f1f1bd881f43bfdc266831 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eZ7XXplVye/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.FaM3bjg7sJ/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 2017-01-28 08:18:55,053 truncating revision to first 12 chars 2017-01-28 08:18:55,053 Setting DEBUG logging. 2017-01-28 08:18:55,053 attempt 1/10 2017-01-28 08:18:55,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/83336666dfce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-28 08:18:56,235 unpacking tar archive at: mozilla-central-83336666dfce/testing/mozharness/ program finished with exit code 0 elapsedTime=1.536683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-28 08:18:56.504232) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:56.504602) ========= script_repo_revision: 83336666dfce1ad037f1f1bd881f43bfdc266831 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:56.505029) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:56.505301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-28 08:18:56.524672) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-28 08:18:56.525007) ========= /tools/buildbot/bin/python -u 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', '-u', '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:18:56 INFO - MultiFileLogger online at 20170128 08:18:56 in /builds/slave/test 08:18:56 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 08:18:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:56 INFO - {'append_to_log': False, 08:18:56 INFO - 'base_work_dir': '/builds/slave/test', 08:18:56 INFO - 'blob_upload_branch': 'Firefox', 08:18:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:56 INFO - 'branch': 'Firefox', 08:18:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:56 INFO - 'config_files': ('talos/mac_config.py',), 08:18:56 INFO - 'default_actions': ('clobber', 08:18:56 INFO - 'read-buildbot-config', 08:18:56 INFO - 'download-and-extract', 08:18:56 INFO - 'populate-webroot', 08:18:56 INFO - 'create-virtualenv', 08:18:56 INFO - 'install', 08:18:56 INFO - 'run-tests'), 08:18:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:56 INFO - 'download_minidump_stackwalk': True, 08:18:56 INFO - 'download_symbols': 'ondemand', 08:18:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:56 INFO - 'installer_path': 'installer.exe', 08:18:56 INFO - 'log_level': 'info', 08:18:56 INFO - 'log_name': 'talos', 08:18:56 INFO - 'log_to_console': True, 08:18:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:18:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:18:56 INFO - 'opt_config_files': (), 08:18:56 INFO - 'pip_index': False, 08:18:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:18:56 INFO - 'cmd': ('bash', 08:18:56 INFO - '-c', 08:18:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:18:56 INFO - 'enabled': True, 08:18:56 INFO - 'halt_on_failure': False, 08:18:56 INFO - 'name': 'check_screen_resolution'},), 08:18:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:18:56 INFO - 'cmd': ('bash', 08:18:56 INFO - '-c', 08:18:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:18:56 INFO - 'enabled': True, 08:18:56 INFO - 'halt_on_failure': False, 08:18:56 INFO - 'name': 'check_screen_resolution'},), 08:18:56 INFO - 'run_cmd_checks_enabled': True, 08:18:56 INFO - 'sps_profile': False, 08:18:56 INFO - 'sps_profile_interval': 0, 08:18:56 INFO - 'suite': 'dromaeojs', 08:18:56 INFO - 'system_bits': '32', 08:18:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:56 INFO - 'title': 't-yosemite-r7-0370', 08:18:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:56 INFO - 'use_talos_json': True, 08:18:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:56 INFO - 'work_dir': 'build'} 08:18:56 INFO - [mozharness: 2017-01-28 16:18:56.741331Z] Running clobber step. 08:18:56 INFO - Running pre-action listener: _resource_record_pre_action 08:18:56 INFO - Running main action method: clobber 08:18:56 INFO - rmtree: /builds/slave/test/build 08:18:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:59 INFO - Running post-action listener: _resource_record_post_action 08:18:59 INFO - [mozharness: 2017-01-28 16:18:59.207501Z] Finished clobber step (success) 08:18:59 INFO - [mozharness: 2017-01-28 16:18:59.207706Z] Running read-buildbot-config step. 08:18:59 INFO - Running pre-action listener: _resource_record_pre_action 08:18:59 INFO - Running main action method: read_buildbot_config 08:18:59 INFO - Using buildbot properties: 08:18:59 INFO - { 08:18:59 INFO - "project": "", 08:18:59 INFO - "product": "firefox", 08:18:59 INFO - "script_repo_revision": "production", 08:18:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:18:59 INFO - "repository": "", 08:18:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:18:59 INFO - "buildid": "20170128071620", 08:18:59 INFO - "pgo_build": "False", 08:18:59 INFO - "basedir": "/builds/slave/test", 08:18:59 INFO - "buildnumber": 77, 08:18:59 INFO - "slavename": "t-yosemite-r7-0370", 08:18:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:18:59 INFO - "platform": "yosemite_r7", 08:18:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:18:59 INFO - "branch": "mozilla-central", 08:18:59 INFO - "repo_path": "mozilla-central", 08:18:59 INFO - "revision": "83336666dfce1ad037f1f1bd881f43bfdc266831", 08:18:59 INFO - "stage_platform": "macosx64", 08:18:59 INFO - "builduid": "935d178bb0094261b8c0af6c2a2ceacc", 08:18:59 INFO - "slavebuilddir": "test" 08:18:59 INFO - } 08:18:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 08:18:59 INFO - Running post-action listener: _resource_record_post_action 08:18:59 INFO - [mozharness: 2017-01-28 16:18:59.212080Z] Finished read-buildbot-config step (success) 08:18:59 INFO - [mozharness: 2017-01-28 16:18:59.212254Z] Running download-and-extract step. 08:18:59 INFO - Running pre-action listener: _resource_record_pre_action 08:18:59 INFO - Running main action method: download_and_extract 08:18:59 INFO - mkdir: /builds/slave/test/build/tests 08:18: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')]} 08:18:59 INFO - trying https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 08:18:59 INFO - Downloading https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 08:19:00 INFO - Downloaded 1199 bytes. 08:19:00 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:19:00 INFO - Using the following test package requirements: 08:19:00 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:19:00 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:19:00 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 08:19:00 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:19:00 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 08:19:00 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:19:00 INFO - u'jsshell-mac.zip'], 08:19:00 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:19:00 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 08:19:00 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:19:00 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:19:00 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 08:19:00 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:19:00 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 08:19:00 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:19:00 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 08:19:00 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:19:00 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 08:19:00 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:19:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:19:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:19:00 INFO - Fetch https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:19:01 INFO - Expected file size: 16361020 08:19:01 INFO - Obtained file size: 16361020 08:19:08 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:19:09 INFO - Expected file size: 16361020 08:19:09 INFO - Obtained file size: 16361020 08:19:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 08:19:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:19:15 INFO - Fetch https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 08:19:16 INFO - Expected file size: 14403454 08:19:16 INFO - Obtained file size: 14403454 08:19:16 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')]} 08:19:16 INFO - trying https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:19:16 INFO - Downloading https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 08:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 08:19:18 INFO - Downloaded 70132932 bytes. 08:19:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:19:18 INFO - mkdir: /builds/slave/test/properties 08:19:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:19:18 INFO - Writing to file /builds/slave/test/properties/build_url 08:19:18 INFO - Contents: 08:19:18 INFO - build_url:https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:19:19 INFO - Running post-action listener: _resource_record_post_action 08:19:19 INFO - Running post-action listener: set_extra_try_arguments 08:19:19 INFO - [mozharness: 2017-01-28 16:19:19.136881Z] Finished download-and-extract step (success) 08:19:19 INFO - [mozharness: 2017-01-28 16:19:19.137021Z] Running populate-webroot step. 08:19:19 INFO - Running pre-action listener: _resource_record_pre_action 08:19:19 INFO - Running main action method: populate_webroot 08:19:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:19 INFO - '--tppagecycles', 08:19:19 INFO - '7'], 08:19:19 INFO - 'tests': ['tsvgm']}}, 08:19:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:19:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:19:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:19:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:19:19 INFO - 'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:19:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:19:19 INFO - 'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['damp', 'tps']}, 08:19:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:19:19 INFO - 'tests': ['damp', 'tps']}, 08:19:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['dromaeo_dom']}, 08:19:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['basic_compositor_video']}, 08:19:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:19:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other-e10s': {'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['a11yr', 08:19:19 INFO - 'ts_paint', 08:19:19 INFO - 'tpaint', 08:19:19 INFO - 'sessionrestore', 08:19:19 INFO - 'sessionrestore_no_auto_restore', 08:19:19 INFO - 'tabpaint']}, 08:19:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['tsvgx', 08:19:19 INFO - 'tsvgr_opacity', 08:19:19 INFO - 'tart', 08:19:19 INFO - 'tscrollx', 08:19:19 INFO - 'cart', 08:19:19 INFO - 'tsvg_static']}, 08:19:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:19:19 INFO - 'tsvgr_opacity', 08:19:19 INFO - 'tart', 08:19:19 INFO - 'tscrollx', 08:19:19 INFO - 'cart', 08:19:19 INFO - 'tsvg_static']}, 08:19:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:19:19 INFO - 'talos_options': ['--disable-e10s'], 08:19:19 INFO - 'tests': ['tp5o']}, 08:19:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:19:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:19:19 INFO - 'talos_options': ['--disable-e10s', 08:19:19 INFO - '--xperf_path', 08:19:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:19 INFO - 'tests': ['tp5n']}, 08:19:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:19:19 INFO - 'talos_options': ['--xperf_path', 08:19:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:19 INFO - 'tests': ['tp5n']}}, 08:19:19 INFO - 'talos.zip': {'path': '', 08:19:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:19 INFO - Running post-action listener: _resource_record_post_action 08:19:19 INFO - [mozharness: 2017-01-28 16:19:19.155251Z] Finished populate-webroot step (success) 08:19:19 INFO - [mozharness: 2017-01-28 16:19:19.155359Z] Running create-virtualenv step. 08:19:19 INFO - Running pre-action listener: _resource_record_pre_action 08:19:19 INFO - Running main action method: create_virtualenv 08:19:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:19:19 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 08:19:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:19:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:19 INFO - Using real prefix '/tools/python27' 08:19:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:19:20 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:22 INFO - Installing pip.................done. 08:19:22 INFO - Return code: 0 08:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:19:23 INFO - Reading from file tmpfile_stdout 08:19:23 INFO - Output received: 08:19:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:19:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:23 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')]} 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 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')]} 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:23 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 08:19:23 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 08:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:23 INFO - 'HOME': '/Users/cltbld', 08:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:23 INFO - 'LOGNAME': 'cltbld', 08:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:23 INFO - 'MOZ_NO_REMOTE': '1', 08:19:23 INFO - 'NO_EM_RESTART': '1', 08:19:23 INFO - 'PAGER': '/bin/cat', 08:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:23 INFO - 'PWD': '/builds/slave/test', 08:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:23 INFO - 'SHELL': '/bin/bash', 08:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:23 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:23 INFO - 'USER': 'cltbld', 08:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:23 INFO - 'XPC_FLAGS': '0x0', 08:19:23 INFO - 'XPC_SERVICE_NAME': '0', 08:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:23 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 08:19:23 INFO - Cleaning up... 08:19:23 INFO - Return code: 0 08:19:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:19:23 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')]} 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 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')]} 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:23 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 08:19:23 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 08:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:23 INFO - 'HOME': '/Users/cltbld', 08:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:23 INFO - 'LOGNAME': 'cltbld', 08:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:23 INFO - 'MOZ_NO_REMOTE': '1', 08:19:23 INFO - 'NO_EM_RESTART': '1', 08:19:23 INFO - 'PAGER': '/bin/cat', 08:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:23 INFO - 'PWD': '/builds/slave/test', 08:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:23 INFO - 'SHELL': '/bin/bash', 08:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:23 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:23 INFO - 'USER': 'cltbld', 08:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:23 INFO - 'XPC_FLAGS': '0x0', 08:19:23 INFO - 'XPC_SERVICE_NAME': '0', 08:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:23 INFO - Downloading/unpacking psutil>=3.1.1 08:19:23 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 08:19:23 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 08:19:23 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 08:19:23 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 08:19:23 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 08:19:23 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 08:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:27 INFO - Installing collected packages: psutil 08:19:27 INFO - Running setup.py install for psutil 08:19:27 INFO - building 'psutil._psutil_osx' extension 08:19:27 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 08:19: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:19: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:19:28 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 08:19:28 INFO - building 'psutil._psutil_posix' extension 08:19:28 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 08:19:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:19:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:19:28 INFO - ^ 08:19:28 INFO - 1 warning generated. 08:19:28 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 08:19:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:28 INFO - Successfully installed psutil 08:19:28 INFO - Cleaning up... 08:19:28 INFO - Return code: 0 08:19:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:28 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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:28 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 08:19:28 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 08:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:28 INFO - 'HOME': '/Users/cltbld', 08:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:28 INFO - 'LOGNAME': 'cltbld', 08:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:28 INFO - 'MOZ_NO_REMOTE': '1', 08:19:28 INFO - 'NO_EM_RESTART': '1', 08:19:28 INFO - 'PAGER': '/bin/cat', 08:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:28 INFO - 'PWD': '/builds/slave/test', 08:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:28 INFO - 'SHELL': '/bin/bash', 08:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:28 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:28 INFO - 'USER': 'cltbld', 08:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:28 INFO - 'XPC_FLAGS': '0x0', 08:19:28 INFO - 'XPC_SERVICE_NAME': '0', 08:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:19:31 INFO - Installing collected packages: mozsystemmonitor 08:19:31 INFO - Running setup.py install for mozsystemmonitor 08:19:31 INFO - Successfully installed mozsystemmonitor 08:19:31 INFO - Cleaning up... 08:19:32 INFO - Return code: 0 08:19:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:19:32 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')]} 08:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:32 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')]} 08:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:32 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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:32 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 08:19:32 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 08:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:32 INFO - 'HOME': '/Users/cltbld', 08:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:32 INFO - 'LOGNAME': 'cltbld', 08:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:32 INFO - 'MOZ_NO_REMOTE': '1', 08:19:32 INFO - 'NO_EM_RESTART': '1', 08:19:32 INFO - 'PAGER': '/bin/cat', 08:19:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:32 INFO - 'PWD': '/builds/slave/test', 08:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:32 INFO - 'SHELL': '/bin/bash', 08:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:32 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:32 INFO - 'USER': 'cltbld', 08:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:32 INFO - 'XPC_FLAGS': '0x0', 08:19:32 INFO - 'XPC_SERVICE_NAME': '0', 08:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:32 INFO - Downloading/unpacking jsonschema==2.5.1 08:19:32 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 08:19:32 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 08:19:32 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 08:19:32 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 08:19:32 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 08:19:32 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 08:19:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:19:34 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 08:19:34 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 08:19:34 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 08:19:34 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 08:19:34 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 08:19:34 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 08:19:35 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:35 INFO - warning: no files found matching '*.txt' 08:19:35 INFO - no previously-included directories found matching 'build' 08:19:35 INFO - no previously-included directories found matching 'dist' 08:19:35 INFO - no previously-included directories found matching '.git*' 08:19:35 INFO - Installing collected packages: jsonschema, functools32 08:19:35 INFO - Running setup.py install for functools32 08:19:35 INFO - warning: no files found matching '*.txt' 08:19:35 INFO - no previously-included directories found matching 'build' 08:19:35 INFO - no previously-included directories found matching 'dist' 08:19:35 INFO - no previously-included directories found matching '.git*' 08:19:35 INFO - Successfully installed jsonschema functools32 08:19:35 INFO - Cleaning up... 08:19:35 INFO - Return code: 0 08:19:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:19:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:35 INFO - 'HOME': '/Users/cltbld', 08:19:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:35 INFO - 'LOGNAME': 'cltbld', 08:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:35 INFO - 'MOZ_NO_REMOTE': '1', 08:19:35 INFO - 'NO_EM_RESTART': '1', 08:19:35 INFO - 'PAGER': '/bin/cat', 08:19:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:35 INFO - 'PWD': '/builds/slave/test', 08:19:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:35 INFO - 'SHELL': '/bin/bash', 08:19:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:35 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:35 INFO - 'USER': 'cltbld', 08:19:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:35 INFO - 'XPC_FLAGS': '0x0', 08:19:35 INFO - 'XPC_SERVICE_NAME': '0', 08:19:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:19:35 INFO - Cleaning up... 08:19:35 INFO - Return code: 0 08:19:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:19:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:35 INFO - 'HOME': '/Users/cltbld', 08:19:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:35 INFO - 'LOGNAME': 'cltbld', 08:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:35 INFO - 'MOZ_NO_REMOTE': '1', 08:19:35 INFO - 'NO_EM_RESTART': '1', 08:19:35 INFO - 'PAGER': '/bin/cat', 08:19:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:35 INFO - 'PWD': '/builds/slave/test', 08:19:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:35 INFO - 'SHELL': '/bin/bash', 08:19:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:35 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:35 INFO - 'USER': 'cltbld', 08:19:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:35 INFO - 'XPC_FLAGS': '0x0', 08:19:35 INFO - 'XPC_SERVICE_NAME': '0', 08:19:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19:39 INFO - Downloading docopt-0.6.1.tar.gz 08:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:40 INFO - Running setup.py install for blobuploader 08:19:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:40 INFO - Running setup.py install for requests 08:19:40 INFO - Running setup.py install for docopt 08:19:40 INFO - Successfully installed blobuploader requests docopt 08:19:40 INFO - Cleaning up... 08:19:40 INFO - Return code: 0 08:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:40 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 08:19:40 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 08:19:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:40 INFO - 'HOME': '/Users/cltbld', 08:19:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:40 INFO - 'LOGNAME': 'cltbld', 08:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:40 INFO - 'MOZ_NO_REMOTE': '1', 08:19:40 INFO - 'NO_EM_RESTART': '1', 08:19:40 INFO - 'PAGER': '/bin/cat', 08:19:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:40 INFO - 'PWD': '/builds/slave/test', 08:19:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:40 INFO - 'SHELL': '/bin/bash', 08:19:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:40 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:40 INFO - 'USER': 'cltbld', 08:19:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:40 INFO - 'XPC_FLAGS': '0x0', 08:19:40 INFO - 'XPC_SERVICE_NAME': '0', 08:19:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-pk2g73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-KHHbkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-iurljM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-9550U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ei7YM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-8ooUie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-r84Dwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-COQBwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-viv_vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-2IzrPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-x51iCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-q2Dn3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-mK8Ehc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Uu1Q4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ViqX1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-NGaGEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-bGTrBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:42 INFO - Running setup.py install for manifestparser 08:19:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:43 INFO - Running setup.py install for mozcrash 08:19:43 INFO - Running setup.py install for mozdebug 08:19:43 INFO - Running setup.py install for mozdevice 08:19:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:43 INFO - Running setup.py install for mozfile 08:19:43 INFO - Running setup.py install for mozhttpd 08:19:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:43 INFO - Running setup.py install for mozinfo 08:19:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Running setup.py install for mozInstall 08:19:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Running setup.py install for mozleak 08:19:44 INFO - Running setup.py install for mozlog 08:19:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Running setup.py install for moznetwork 08:19:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Running setup.py install for mozprocess 08:19:44 INFO - Running setup.py install for mozprofile 08:19:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:44 INFO - Running setup.py install for mozrunner 08:19:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:45 INFO - Running setup.py install for mozscreenshot 08:19:45 INFO - Running setup.py install for moztest 08:19:45 INFO - Running setup.py install for mozversion 08:19:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:45 INFO - Cleaning up... 08:19:45 INFO - Return code: 0 08:19:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:45 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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:45 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 08:19:45 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 08:19:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:45 INFO - 'HOME': '/Users/cltbld', 08:19:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:45 INFO - 'LOGNAME': 'cltbld', 08:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:45 INFO - 'MOZ_NO_REMOTE': '1', 08:19:45 INFO - 'NO_EM_RESTART': '1', 08:19:45 INFO - 'PAGER': '/bin/cat', 08:19:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:45 INFO - 'PWD': '/builds/slave/test', 08:19:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:45 INFO - 'SHELL': '/bin/bash', 08:19:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:45 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:45 INFO - 'USER': 'cltbld', 08:19:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:45 INFO - 'XPC_FLAGS': '0x0', 08:19:45 INFO - 'XPC_SERVICE_NAME': '0', 08:19:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:45 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Fee7Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:45 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)) 08:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:45 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-f87nya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Hipmca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:46 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-s_5c9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-i7cXID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:46 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-TDiOOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:46 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Slf3Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:46 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-VLGdkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:46 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-GLvXce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:46 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-NRElCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:46 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-zKbxq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:46 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)) 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:47 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-M5fViP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:47 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-YUjB3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:47 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)) 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:47 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-kyGiE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:47 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-52mNwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:47 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)) 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:47 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-m2VZpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:47 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-szMybl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:47 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)) 08:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:47 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)) 08:19:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:50 INFO - Downloading blessings-1.6.tar.gz 08:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:50 INFO - Installing collected packages: blessings 08:19:50 INFO - Running setup.py install for blessings 08:19:50 INFO - Successfully installed blessings 08:19:50 INFO - Cleaning up... 08:19:50 INFO - Return code: 0 08:19:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:50 INFO - Reading from file tmpfile_stdout 08:19:50 INFO - Current package versions: 08:19:50 INFO - blessings == 1.6 08:19:50 INFO - blobuploader == 1.2.4 08:19:50 INFO - docopt == 0.6.1 08:19:50 INFO - functools32 == 3.2.3-2 08:19:50 INFO - jsonschema == 2.5.1 08:19:50 INFO - manifestparser == 1.1 08:19:50 INFO - mozInstall == 1.12 08:19:50 INFO - mozcrash == 1.0 08:19:50 INFO - mozdebug == 0.1 08:19:50 INFO - mozdevice == 0.49 08:19:50 INFO - mozfile == 1.2 08:19:50 INFO - mozhttpd == 0.7 08:19:50 INFO - mozinfo == 0.9 08:19:50 INFO - mozleak == 0.1 08:19:50 INFO - mozlog == 3.4 08:19:50 INFO - moznetwork == 0.27 08:19:50 INFO - mozprocess == 0.24 08:19:50 INFO - mozprofile == 0.28 08:19:50 INFO - mozrunner == 6.13 08:19:50 INFO - mozscreenshot == 0.1 08:19:50 INFO - mozsystemmonitor == 0.3 08:19:50 INFO - moztest == 0.8 08:19:50 INFO - mozversion == 1.4 08:19:50 INFO - psutil == 3.1.1 08:19:50 INFO - requests == 1.2.3 08:19:50 INFO - wsgiref == 0.1.2 08:19:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:50 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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:50 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 08:19:50 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 08:19:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:50 INFO - 'HOME': '/Users/cltbld', 08:19:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:50 INFO - 'LOGNAME': 'cltbld', 08:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:50 INFO - 'MOZ_NO_REMOTE': '1', 08:19:50 INFO - 'NO_EM_RESTART': '1', 08:19:50 INFO - 'PAGER': '/bin/cat', 08:19:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:50 INFO - 'PWD': '/builds/slave/test', 08:19:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:50 INFO - 'SHELL': '/bin/bash', 08:19:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:50 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:50 INFO - 'USER': 'cltbld', 08:19:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:50 INFO - 'XPC_FLAGS': '0x0', 08:19:50 INFO - 'XPC_SERVICE_NAME': '0', 08:19:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 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)) 08:19:51 INFO - Cleaning up... 08:19:51 INFO - Return code: 0 08:19:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:51 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 0x10d413b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d416768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb781c59e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, '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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 08:19:51 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 08:19:51 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 08:19:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:19:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:51 INFO - 'HOME': '/Users/cltbld', 08:19:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:51 INFO - 'LOGNAME': 'cltbld', 08:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:51 INFO - 'MOZ_NO_REMOTE': '1', 08:19:51 INFO - 'NO_EM_RESTART': '1', 08:19:51 INFO - 'PAGER': '/bin/cat', 08:19:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:51 INFO - 'PWD': '/builds/slave/test', 08:19:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:51 INFO - 'SHELL': '/bin/bash', 08:19:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:19:51 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:19:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:51 INFO - 'USER': 'cltbld', 08:19:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:51 INFO - 'XPC_FLAGS': '0x0', 08:19:51 INFO - 'XPC_SERVICE_NAME': '0', 08:19:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:51 INFO - Cleaning up... 08:19:51 INFO - Return code: 0 08:19:51 INFO - Running post-action listener: _resource_record_post_action 08:19:51 INFO - Running post-action listener: _start_resource_monitoring 08:19:51 INFO - Starting resource monitoring. 08:19:51 INFO - [mozharness: 2017-01-28 16:19:51.514954Z] Finished create-virtualenv step (success) 08:19:51 INFO - [mozharness: 2017-01-28 16:19:51.515902Z] Running install step. 08:19:51 INFO - Running pre-action listener: _resource_record_pre_action 08:19:51 INFO - Running main action method: install 08:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:51 INFO - Reading from file tmpfile_stdout 08:19:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:51 INFO - Reading from file tmpfile_stdout 08:19:51 INFO - Output received: 08:19:51 INFO - Usage: mozinstall [options] installer 08:19:51 INFO - Options: 08:19:51 INFO - -h, --help show this help message and exit 08:19:51 INFO - -d DEST, --destination=DEST 08:19:51 INFO - Directory to install application into. [default: 08:19:51 INFO - "/builds/slave/test"] 08:19:51 INFO - --app=APP Application being installed. [default: firefox] 08:19:51 INFO - mkdir: /builds/slave/test/build/application 08:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:20:14 INFO - Reading from file tmpfile_stdout 08:20:14 INFO - Output received: 08:20:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:20:14 INFO - Running post-action listener: _resource_record_post_action 08:20:14 INFO - [mozharness: 2017-01-28 16:20:14.277244Z] Finished install step (success) 08:20:14 INFO - [mozharness: 2017-01-28 16:20:14.277374Z] Running run-tests step. 08:20:14 INFO - Running pre-action listener: _resource_record_pre_action 08:20:14 INFO - Running main action method: run_tests 08:20:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:20:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:20:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:20:14 INFO - 2017-01-28 08:20:14.290 screenresolution[1643:8053] starting screenresolution argv=screenresolution get 08:20:14 INFO - 2017-01-28 08:20:14.292 screenresolution[1643:8053] Display 0: 1600x1200x32@60 08:20:14 INFO - 2017-01-28 08:20:14.298 screenresolution[1644:8055] starting screenresolution argv=screenresolution list 08:20:14 INFO - Available Modes on Display 0 08:20:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:20:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:20:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:20:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:20:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:20:14 INFO - Intel Iris: 08:20:14 INFO - Chipset Model: Intel Iris 08:20:14 INFO - Type: GPU 08:20:14 INFO - Bus: Built-In 08:20:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:20:14 INFO - Vendor: Intel (0x8086) 08:20:14 INFO - Device ID: 0x0a2e 08:20:14 INFO - Revision ID: 0x0009 08:20:14 INFO - Displays: 08:20:14 INFO - Display: 08:20:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:20:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:20:14 INFO - Display Serial Number: 1600x1200 60 08:20:14 INFO - Main Display: Yes 08:20:14 INFO - Mirror: Off 08:20:14 INFO - Online: Yes 08:20:14 INFO - Rotation: Supported 08:20:14 INFO - Return code: 0 08:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:20:14 INFO - Python 2.7.3 08:20:14 INFO - Return code: 0 08:20:14 INFO - grabbing minidump binary from tooltool 08:20:14 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')]} 08:20:14 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 0x10d1f1d30>, '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 0x10d118db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:20:14 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 08:20:14 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 08:20:14 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 08:20:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:20:14 INFO - Return code: 0 08:20:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:20:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:20:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:20:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:20:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:20:14 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/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 08:20:14 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/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --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 08:20:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eZ7XXplVye/Render', 08:20:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:14 INFO - 'HOME': '/Users/cltbld', 08:20:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:14 INFO - 'LOGNAME': 'cltbld', 08:20:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:20:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:14 INFO - 'MOZ_NO_REMOTE': '1', 08:20:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:20:14 INFO - 'NO_EM_RESTART': '1', 08:20:14 INFO - 'PAGER': '/bin/cat', 08:20:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:14 INFO - 'PWD': '/builds/slave/test', 08:20:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:20:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:14 INFO - 'SHELL': '/bin/bash', 08:20:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FaM3bjg7sJ/Listeners', 08:20:14 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 08:20:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:14 INFO - 'USER': 'cltbld', 08:20:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:14 INFO - 'XPC_FLAGS': '0x0', 08:20:14 INFO - 'XPC_SERVICE_NAME': '0', 08:20:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:14 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/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 08:20:14 INFO - mozversion application_buildid: 20170128071620 08:20:14 INFO - mozversion application_changeset: 83336666dfce1ad037f1f1bd881f43bfdc266831 08:20:14 INFO - mozversion application_display_name: Nightly 08:20:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:20:14 INFO - mozversion application_name: Firefox 08:20:14 INFO - mozversion application_remotingname: firefox 08:20:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:20:14 INFO - mozversion application_vendor: Mozilla 08:20:14 INFO - mozversion application_version: 54.0a1 08:20:14 INFO - mozversion platform_buildid: 20170128071620 08:20:14 INFO - mozversion platform_changeset: 83336666dfce1ad037f1f1bd881f43bfdc266831 08:20:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:20:14 INFO - mozversion platform_version: 54.0a1 08:20:14 INFO - using testdate: 1485620414 08:20:14 INFO - actual date: 1485620414 08:20:14 INFO - starting webserver on 'localhost:49237' 08:20:14 INFO - SUITE-START | Running 2 tests 08:20:14 INFO - TEST-START | dromaeo_css 08:20:14 INFO - operating with platform_type : mac_ 08:20:14 INFO - Initialising browser for dromaeo_css test... 08:20:14 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpkcsnu3/profile http://localhost:49237/getInfo.html) 08:20:17 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 08:20:17 INFO - PROCESS | 1654 | colorDepth:24 08:20:17 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 08:20:17 INFO - PROCESS | 1654 | __metrics 08:20:17 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:20:17 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:20:18 INFO - TEST-INFO | 1654: exit 0 08:20:18 INFO - Browser initialized. 08:20:18 INFO - Running cycle 1/1 for dromaeo_css test... 08:20:18 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpkcsnu3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:30 INFO - PROCESS | 1657 | RSS: Main: 236462080 08:20:30 INFO - PROCESS | 1657 | 08:23:34 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 08:23:36 INFO - PROCESS | 1657 | RSS: Main: 345890816 08:23:36 INFO - PROCESS | 1657 | 08:25:20 INFO - PROCESS | 1657 | ************************* 08:25:20 INFO - PROCESS | 1657 | A coding exception was thrown and uncaught in a Task. 08:25:20 INFO - PROCESS | 1657 | 08:25:20 ERROR - PROCESS | 1657 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:25:20 INFO - PROCESS | 1657 | Full stack: 08:25:20 INFO - PROCESS | 1657 | ************************* 08:26:39 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 08:26:39 INFO - PROCESS | 1657 | RSS: Main: 365785088 08:26:39 INFO - PROCESS | 1657 | 08:29:42 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 08:29:42 INFO - PROCESS | 1657 | RSS: Main: 361459712 08:29:42 INFO - PROCESS | 1657 | 08:32:45 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 08:32:45 INFO - PROCESS | 1657 | RSS: Main: 339832832 08:32:45 INFO - PROCESS | 1657 | 08:35:49 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 08:35:49 INFO - PROCESS | 1657 | RSS: Main: 325046272 08:35:49 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 08:38:53 INFO - PROCESS | 1657 | RSS: Main: 401346560 08:38:53 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | __start_tp_report 08:38:53 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 08:38:53 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 08:38:53 INFO - PROCESS | 1657 | |i|pagename|runs| 08:38:53 INFO - PROCESS | 1657 | |0;dojo.html;3108.3627856289463;3330.950750513588;3335.665733706518;3357.83210839458;3389.169653434909;4705.1530724469585;5564.666120032796;5588.6646801191955;5664.858378540539;5668.149777533372;5660.235868157797;5672.886542269152;5705.629134106281;5709.257796486461;5710.229119068925;5160.767765450545;5184.7148406837605;5254.684718916858;5260.947390526103;5273.182656688219;5154.819581314655;5291.1798671206025;5294.629375943667;5294.841154765344;5305.098133317345;5281.102212623863;5295.232191332255;5297.814576489824;5299.205119232127;5320.600954928396;5130.97380523893;5148.871278218075;5266.078436273675;5273.050850846846;5346.171343441753;5141.742912854343;5166.974165129188;5180.844574662766;5199.064168449678;5257.342832145981;5615.691136987464;5650.63270887391;5671;5674.2623458950075;5679.886402271932;6241.625502469867;6246.031865060922;6253.4997200224325;6254.781082662085;6260.40526150015;6173.876522469525;6180.258368995705;6203.968980155116;6291.842703932392;6302.401271879165;5858.619189752652;5874.148248503943;5900.704964751745;5910;5911.793087241926;6164.044573091089;6282.371762823681;6287.2140982377205;6291.465225455888;6296.905546416808;6012.158297838306;6051.0923361496125;6188.319284878659;6191.628502289877;6218.409251121137;6204.193454850841;6215.751369945242;6236.719347629368;6262.937370626236;6297.055441683784;6097.542684298695;6149.723262453201;6270.561060725797;6272.059191121369;6273.749050037947;6127.750382672762;6191.25704915404;6205.81382558524;6275.748970041239;6324.33594472583;4994.425641051253;5006.999999999927;5014.398272207285;5020.2720605511995;5045.545900868866;4411.911761764747;4425.955740442554;4433.778311084433;4441.067375851043;4533.795979180944;5698.772049117989;5750.769969201268;5756.992526307879;5773.8556536086935;5806.390329015477;6315.273743519554;6339.11252424661;6340.302566717657;6342.841428964312;6349.714262858182;5041.79832806691;5407.70257635826;5616.2698849150165;5743.655380677089;5761.942380576224;5404.972975135178;5406.621536492407;5417.214503896992;5429.4299098594865;5446.972765136149;6234.37656234382;6254.249490061313;6254.874902501833;6280.591761535486;6294.527910406646;6228.252609686867;6301.8109456716375;6311.747530098928;6318;6335.049742538656;6262.4990000800735;6262.5929314594405;6263.561550691408;6266.811995640138;6279.089532017923;6112.777056696867;6159.568830182024;6167.84580385494;6227.377262273736;6275.152854364603;6296.464800492009;6318.778842740666;6321.936780632135;6324.747010119728;6329.841753956188;6125.111858780541;6189.659568723763;6193.659348735863;6200.286966998853;6202.844928876814;5903.911441328298;5979.521638269015;6096.908546371897;6099.969500152471;6104.0347610180015;5757.65454072757;5878.088896221093;5920.963831329586;6016.8796624068145;6064.332923378337;6115.938840611715;6119.357467465852;6134.436587033385;6136.120845438929;6142.529470848956;5979.4917432018765;6018.548608854266;6025.005874030736;6050.42520960508;6055.666938318434 08:38:53 INFO - PROCESS | 1657 | |1;ext.html;441.6886095302812;441.9845305414311;471.91269615121183;472.13599113622075;495.1335163463938;23649.76350236497;40263;42761.289548418026;42964.785176074074;44269.77865110678;43662.345064823974;43963.78018109905;43985;43988.78005609968;44133.7793311033;8328.541930193836;9192.12674795895;9409.482478463682;9413.81172376552;9417.670381536647;8281.710140145096;11091.445427728622;11355.659330220107;11384.658460246206;11572.71068223297;9616.855747163798;11253.156013298994;11342.035926946179;11346;11394.430278486043;8315.8336833263;8539.444936079135;9656.999999999965;11336.48985795637;11416.600418985296;10909.727256818644;11233.60682376121;11237.719057023558;11443.54225830974;11474.885251147465;41533.37699934503;41994;41995.79002105001;42026;42032.579674203174;3546.804925729084;3989.082511022452;3999.1201935574127;4010.3984402339593;4125.731827431237;28586.571201431994;29323.266918327;30016.69983300161;30365.696343036507;30468.390632187453;3059.5257735051105;3097.225693576606;3098.148009297439;3111.502159654467;3167.303193297471;489536;490035.99999999645;492026.53986730194;492999;493576;56211.156832647546;56655.866882662114;56708.71645641745;56727.43272567304;56729;59190.816183676085;60000.69999649974;60079.9880017992;60108;60126.09810852841;13278.800817987738;13577.253251071286;14178.787318190236;14693.706125877423;14700.926495367668;8990.190882820578;10012.649557265606;10443;11172.329660220414;11275.66173014811;18010.729839052423;18232.36186733458;18454.538636533925;18703.81296187048;18836.152373143243;6396.872062558816;7507.361874240751;7604.9353090567365;7634.809129771689;7736.690532378641;752.3905636434506;850.1116333431579;858.3733874271692;872.8347655879345;873.895132584094;28069;29651.20054345369;29957;30297;30657.38685226283;1042.921780866423;1047.6542740895638;1077.466654006272;1079.7354648111263;1167.0605162843992;15543.766843497357;15568.45510407153;15609;15684.76472852908;16000.199990000454;520343;616270;616424;616553;617301;63004;63409.68295158587;63416.68291658512;63450.36549634444;63461;1401.831780186384;1415.143837978029;1443.9350229239499;1447.1534152520894;1450.050217107796;23949.76050239545;29278.560821587267;29385.85307073451;30043.549346760254;30050.69949300479;52871.47128528819;53801;53806.65483362791;53869.730651346494;53927.730361347945;560296;561607;562015;563133;563196;23412.946417410916;24145.034198631856;26060.609090863272;26431.603525946743;27075;46104.7694761524;46374;47270.52729472799;47308;48175.27737083876;39013.60986390214;39163.216735665694;39563;40288;40477.595224047385;38091.2381752369;38481.615183848924;39377.60622393739;39434.2113157741;39497.210055799296;37216.25567488581;37360.43959340666;37652.623473766005;38182;38183.42724859185;28972.565411518422;31544.74295751921;32354;33419.66580334263;33917.15207119842;23694;23879.97020253298;23888;24209.878950605133;24284.51430971406 08:38:53 INFO - PROCESS | 1657 | |2;jquery.html;335.14203638684967;389.2273836434678;399.0034645178872;401.5462527344102;428.1223491841724;13807.585772426819;19823.306184283552;20832.47918802027;21123.788762112374;21151.894240528774;20498.385048448534;20758.377248682562;20912;21041.47396315093;21061.368158955218;5817.534597232211;6187.412195841388;6199.504039676815;6212.937870621304;6221.595596286227;5600.635958662674;5853.824385268427;6042.788502402417;6120.602160859552;6164.722587483551;6103;6108.541859360544;6108.69456527174;6111.174991376151;6120.602160859552;5783.797567085153;5952.226210592617;6012.939870601282;6020.127081573191;6101.60339577926;5280.234366016906;5282.683039017633;5283.339582552181;5285.969235998982;5294.470552944713;25977.74022259791;26033.479330413476;26184.34539136518;26438.339041523923;26653.733462665317;2723.1694333228356;2738.52075886719;2774.098418014133;2796.9440611187865;2797.734215249548;15332.616684582863;15343.846561534465;15449.227538623136;15576;15902.443414480438;1827.7806663200502;1865.7201419787004;1866.8599855010928;1876.7715948083003;1877.3241633012105;133096;137830;138717;138899;139008.49690031508;11241.325520468634;11431.14266430021;11456.599019034295;11555.942220289013;11705.297682139098;12537.874621253854;13138.146020508637;14242.359093840802;14266.429342826379;14311.427542898376;6215.502759779297;6407.935920640827;7964.283214510722;8214.26071653554;8376;7841.255080767318;7844.294013538809;7856.528608283407;7992.761122026095;8030.718924837603;5867.647941123546;6926.480513961473;7051.788446346618;7074.964625176841;7088.787336379917;1894.6968485042328;1960.4216756056996;1961.931332403359;1963.234338607944;1969.6946973219174;924.8150369926042;998.6754304850953;1003.9508713394374;1004.5830980143159;1045.6549338718357;16391.754123688155;21679.458013549473;22530.662040069412;22719.09123635036;22761.97571109304;1051.1800795379615;1063.914886809069;1086.760912599227;1088.1294964028746;1088.5917780832187;9514.733617395043;11410.258333208314;11624.476898539586;11627.360495172677;11855.58505452305;528735;581088;589881;704033;704794;124520.89090554648;140082;147797.2610136964;149217;157203.21398393164;957.9616815327448;978.1978777402604;1037.6886933919945;1040.6669865643073;1040.9895901040893;18949.242030318634;19111.426657200307;19222.135003924577;19225.51936201606;19285.228590856208;44063;54253.18620220779;56268.43731562632;56696.71651641715;57979.71010144922;81566;81653.59173204096;83157.16842831494;84113.12133497905;84658.57670711607;7219.530730502501;7405.8148546286775;7538.849223015619;7916.920830791619;8343;11737.35444550558;13104.475820967436;13276.552354961195;13526.729465410834;13653.590392288248;10754.73113172177;11398.259113157617;11500.50493435848;11816.881831181578;11842.052635788943;11206.159538034517;11270.887291127312;11476.655700329004;11650.417479125841;11836.289822610672;11461.369624670722;11603;11948.641540753792;11976.28142311464;12069.27584344942;7458.21688722698;7681.1934746850775;7736.994190755166;7847.411444141826;7898.842023159619;10538.78922421532;10657.680269591925;11117.821757468626;11272.380019099028;11697.06423486136 08:38:53 INFO - PROCESS | 1657 | |3;mootools.html;1195.5755706724112;1412.689208374158;1422.5803388000538;1432.5344263114484;1438.3239877257686;7917.643706033228;8304.750857474279;8324.958375208116;8325.458845175059;8344.499330040195;7320.414366850652;7517.398608111352;7533.623318834064;7848.8037799055055;8062.91937080629;2194.703714998471;2273.9420824154167;2274.306336567346;2283.9885800570974;2286.4283929017747;2249.336445748508;2278.5898538263104;2284.828637852168;2286.039863257436;2297.6208925527267;1999.3302243748362;2063.9174433022663;2210.635245184543;2232.6427771556555;2249.3814201094665;2253.4028482452163;2262.694536237603;2266.6486694562286;2271.0121097322717;2271.9204827830945;2211.2813335665974;2259.8418110732255;2270.0465804362043;2283.0251832165222;2284.5202507473286;8134.430589858713;8205.466644668077;8225.670973161066;8230;8232.711855085043;4803.951960480385;4952.7523623819025;4959.107360675077;4966.056449274663;4966.329545511346;3092.5361195820583;3193.457112290916;3402.3195360927666;3471.8264086795557;3485.0590340607896;1153.244624770768;1187.6674531131298;1242.1305086439438;1246.8316777235048;1250.9124361294712;10545.103666188383;10547.789044219073;10547.84178237327;10572.577096916115;10578.735531611772;4211;4378.1024889898135;4544.091181763661;4604.309353596987;4613.769311534477;8558.871616925751;9184.403013804082;9188.219001384823;9201.447913125234;9209.861852072225;5134.512221338967;5167.534921856975;5173.793048278102;5179.741012949337;5191.273221748958;4372.912541749147;4478.037221997286;4672.159011377985;4762.78567464465;4788.449328327218;3654.524911761454;3704.6480584344445;3759.285735710206;3793.4067691569608;3804.0680033391995;1247.2267194339568;1249.1830921272472;1254.4292346982102;1267.207995003123;1268.8096785482066;767.1522967121363;818.275825894088;891.3003292415423;900.5002223765742;931.7158266728712;5309.787608495694;5449.291592093082;5682.466170483873;5710.2862142232225;5757.366689664133;951.5251360391366;954.6467806911348;980.3823591137681;992.9734924879682;1008.7478130467383;3514.297140571845;3727.8322475488667;3769.5853456119803;3791.810409479515;3854.0557563397147;9485.620575177054;9813.558389872473;9833.754156146011;9841;9845.458499782437;9177.403468774508;9760.414375137514;9760.511974401252;9766.925638179795;9809.11717945374;7384.335409813035;7673.309402153833;7677.769666910001;7680;7704.961475192588;5477.370102438271;5572.108462645957;5686.886262274814;5705.172749951151;5760.913586296293;7013.228544860163;8754.21212090915;8964.731058068268;8977.506237156758;9052.954735226545;8175.386845986456;8551.1448855114;9237.907620923705;9258.444493330422;9326.580303886205;6998.090248267897;7017.789466316019;7137.429005679637;7149.0706208192605;7155.928440715735;7659.923400766144;7664.31021208094;7771.261730135628;7774.2614451627005;7781.572013539083;6663.300353462817;6686.765963191265;6741.86516269662;6787.423069039187;6872.896906546506;6862.519623626298;6903.413209877016;6926.9307306926285;6931.7227310907;6953.478489113438;6243.8126856194385;6282.246130464374;6285.120083188449;6354.777582784765;6385.393387628168;4830.903381932412;4854.441739200037;4861.756912154449;4951.133551628379;5073.644844860972;4899.289603007473;4914.582260507754;5021.548060674557;5031.22016087507;5071.137906555969 08:38:53 INFO - PROCESS | 1657 | |4;prototype.html;298.3130397601564;328.75565982755273;355.69410307135865;365.6928180328524;370.1468115992636;4476.239039363308;5044;5093.414257360405;5262.079136151177;5364.352240476484;4930.6055515558755;5207;5234.842954711356;5237.214417837316;5276.709780962055;3640.872569460056;4211.136427229483;4215.283401821697;4220.957790422102;4229.6042306038935;4025.8993525161814;4230.809613567397;4235.6187943085115;4240.23675738367;4250.2137104635585;3971;4109.938350924738;4139.847279414703;4141.792910354486;4157.750534967897;4078.5105787305565;4089.488813898263;4117.032497363117;4145.253854306224;4147.81334839933;3036.6963303669677;3662.926741465182;3678.1907980244305;3682.6317368263226;3684.299983003221;4792.856214313576;4915.935307170997;5109.310243117169;5123.410807757118;5220.686758794446;4256;4334.089841133366;4774.713517188945;4812.7352995585225;4842.757862106881;4418.447694038246;5151.690898546061;5209.270702101709;5556.9444305556835;5614.522765564931;3365.8653653853817;3859.1702783901596;4051;4082.2856000199845;4109.6506796922295;5717.628354156966;5765.567582431292;5793.362730099686;5837.219648007356;5889.5582831286965;4142.958570414257;4150.758590361171;4167.916641667211;4174.7077704561;4177.561356057631;3546.4819977815523;3662.7069834413182;3786.8639408177437;4280;4290.699651024398;4289.485261768546;4616.838410655611;4709.011107667359;4759.952400476021;4799.544043315879;5541.944580554143;5549.500544950893;5574.777008919679;5575.8884822304135;5595.496405323541;1103.674416047268;1357.450232655776;1372.1355546006153;1374.6357215337944;1379.5861241627472;854.5513605357113;869.9603973251903;969.4619486185235;986.2051067058029;990.9752256193652;4571.9314210286875;4860.295257187688;4866.926996095061;4891.730954797449;4912.666483420347;4282.5075116361395;5167.328247327823;5200.219967004904;5373;5485.61600687948;3976.940345894814;4080.021189722982;4682.073703935041;4854.781534830941;4855.936227103467;2350.670906073151;2683.624991882198;2770.8500972096354;2854.615511476932;2900.7389334959953;4959;5543.009033495877;5703.54371650267;5726.139004823366;5727.933167451157;4872.9512704872495;5059.62052846038;5236.24074509194;5609.06487261894;5616.803411880564;4413.44831896013;4618.30725391194;4843.007183527439;5607.635503692411;5668.234788303609;4673.509281525391;4866.562009419169;5457.135004122867;5470.8085217017215;5479.780808767764;5095.878906640533;5421.322334708161;5596.384397716167;5695.572832037531;5780.479756821906;5780.930527852361;5903.380145084704;5960.940390596039;5964.508872781805;5973.535349497194;3478.6869181773764;3962.9392715788204;4172.979135104427;4209.642180414699;4240.469941257343;4649.535396350139;4775.880602984953;5305.814296499604;5332.20016997438;5473.890522189614;4652.976735116303;4672.425594420339;4883.5837607093545;5544.916826247691;5600.27196464457;4326.675499337499;4930.556249937523;5556.611037227355;5556.972215138899;5602.350049459021;5078.7206703631655;5179.896402071862;5537.501624853782;5546.334439867242;5562.637153897321;4907.920257543335;5439.646422982493;5501.559875209893;5603.439656034364;5650.29371328584;4840.782164802522;5214.374275087014;5230.320058392537;5235.685858848481;5317.946820531745 08:38:53 INFO - PROCESS | 1657 | |5;yui.html;703.4899697719151;734.313416955147;764.5221736414741;823.287856004556;836.736428025172;14933.626659333522;15863.920680396597;15874.206289685513;15901.681966360695;15914.363425462967;14715.852841471582;14863.108213507197;14867.107973521597;14889.329980150893;14909.701805963874;684.336193891924;703.9788806335819;706.7314420520221;855.1875718067829;870.6038752367657;852.9616167272457;872.733816186063;874.5802015032756;875.1248751248751;876.5441970175505;934.654177954158;935.1443429262217;935.8876934767837;936.241644268145;936.3164889630574;905.7916679163764;928.3037721708719;929.6560272699077;930.939488933224;933.1834644685899;534.521603165165;549.7443688684741;671.3253180553512;684.226823689228;690.4476418864888;15267.160306183156;15294.541163764994;15305.540833775005;15313.387464501406;15358.232088395647;13892.861071389258;13939.651508712263;13946;13958.441662333495;13980.951428642791;11218.439078046065;12104.39478026104;12685.619431417072;12703.682407939876;13076.08467407282;4470.2177119004045;4542.977285113553;4571.428571428572;4673.719576825401;4676.321933319684;102855.60021596983;105661.99999999923;106629.46685266524;107134;109634;10670.733231669115;10675.039246467855;10739.463026848627;10857.185711071701;11289.717757055974;21214.893925530272;21261.78738212629;21463.570728585342;21524.354269371943;21552.784472155392;6502.252240992252;7373.483856130127;7427.108746950401;7456;7475.738349157862;4065.0447144920918;4149.605787450188;4152.750834949913;4159.91680166395;4162.500499940026;3266.3304022675293;3317.867285308609;3353.245519758035;3353.8155401453155;3354.2955979244143;619.6127420362274;620.6307247187916;621.3196549777986;636.8853606350901;639.354252205276;531.4579129288104;541.5829811045552;548.202365558112;554.5314209492972;559.4908633143901;9359.204467620328;9534.646705520412;9577.808443831085;9715.36850104741;9880.99746845525;522.615877330162;528.7382745540982;541.2260467531468;542.1758926431802;561.6586264623379;4362.672799539983;4695.765211739467;4707.964247865532;4740.407449068866;4793.952060479421;78975.420491591;84389.15610843936;87265;87519.56240218885;90371;73447.63276183585;76769.61615191889;77024.61487692638;78761.48669593074;81025;68841;69583.60832783316;70163;71244.28755712583;71485;10060.69817905464;10241.436720980417;10356.223283253938;10472;10538.470767015708;43592.12815743604;43925.12149757051;47272.52727472681;47963.28055079107;49098;56970.715146424;57903;61426;62748;64129.67935160294;12315.876841231473;12360.38198090074;12408.689782755504;12499;12522.37388130608;14208.07647502909;14334.21161836109;14417.062890912057;14456.710865782416;14461.927690361481;12984.003475985251;13029.218246905217;13102;13282.136661116996;13286.933565332112;13152.473901044234;13310.933445332712;13325;13331.933340333237;13363.3986470611;9567.37812042215;12771.80842287385;13142.60572182836;13217.801732974205;13245.20528768277;10788.244822862323;11203.607873724706;11485.81600953382;11547.191696581158;11690.415479225834;10606.204534660086;10617.469126543796;10648.733781655521;10650.307729997525;10657 08:38:53 INFO - PROCESS | 1657 | __end_tp_report 08:38:53 INFO - PROCESS | 1657 | __start_cc_report 08:38:53 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1096 08:38:53 INFO - PROCESS | 1657 | __end_cc_report 08:38:53 INFO - PROCESS | 1657 | __startTimestamp1485621533462__endTimestamp 08:38:53 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | ------- Summary: start ------- 08:38:53 INFO - PROCESS | 1657 | Number of tests: 6 08:38:53 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5754.35 Median:6016.88 stddev:650.28 (10.8%) stddev-sans-first:618.26 08:38:53 INFO - PROCESS | 1657 | Values: 3108.4 3331.0 3335.7 3357.8 3389.2 4705.2 5564.7 5588.7 5664.9 5668.1 5660.2 5672.9 5705.6 5709.3 5710.2 5160.8 5184.7 5254.7 5260.9 5273.2 5154.8 5291.2 5294.6 5294.8 5305.1 5281.1 5295.2 5297.8 5299.2 5320.6 5131.0 5148.9 5266.1 5273.1 5346.2 5141.7 5167.0 5180.8 5199.1 5257.3 5615.7 5650.6 5671.0 5674.3 5679.9 6241.6 6246.0 6253.5 6254.8 6260.4 6173.9 6180.3 6204.0 6291.8 6302.4 5858.6 5874.1 5900.7 5910.0 5911.8 6164.0 6282.4 6287.2 6291.5 6296.9 6012.2 6051.1 6188.3 6191.6 6218.4 6204.2 6215.8 6236.7 6262.9 6297.1 6097.5 6149.7 6270.6 6272.1 6273.7 6127.8 6191.3 6205.8 6275.7 6324.3 4994.4 5007.0 5014.4 5020.3 5045.5 4411.9 4426.0 4433.8 4441.1 4533.8 5698.8 5750.8 5757.0 5773.9 5806.4 6315.3 6339.1 6340.3 6342.8 6349.7 5041.8 5407.7 5616.3 5743.7 5761.9 5405.0 5406.6 5417.2 5429.4 5447.0 6234.4 6254.2 6254.9 6280.6 6294.5 6228.3 6301.8 6311.7 6318.0 6335.0 6262.5 6262.6 6263.6 6266.8 6279.1 6112.8 6159.6 6167.8 6227.4 6275.2 6296.5 6318.8 6321.9 6324.7 6329.8 6125.1 6189.7 6193.7 6200.3 6202.8 5903.9 5979.5 6096.9 6100.0 6104.0 5757.7 5878.1 5921.0 6016.9 6064.3 6115.9 6119.4 6134.4 6136.1 6142.5 5979.5 6018.5 6025.0 6050.4 6055.7 08:38:53 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:68637.88 Median:39405.91 stddev:147454.05 (374.2%) stddev-sans-first:147778.80 08:38:53 INFO - PROCESS | 1657 | Values: 441.7 442.0 471.9 472.1 495.1 23649.8 40263.0 42761.3 42964.8 44269.8 43662.3 43963.8 43985.0 43988.8 44133.8 8328.5 9192.1 9409.5 9413.8 9417.7 8281.7 11091.4 11355.7 11384.7 11572.7 9616.9 11253.2 11342.0 11346.0 11394.4 8315.8 8539.4 9657.0 11336.5 11416.6 10909.7 11233.6 11237.7 11443.5 11474.9 41533.4 41994.0 41995.8 42026.0 42032.6 3546.8 3989.1 3999.1 4010.4 4125.7 28586.6 29323.3 30016.7 30365.7 30468.4 3059.5 3097.2 3098.1 3111.5 3167.3 489536.0 490036.0 492026.5 492999.0 493576.0 56211.2 56655.9 56708.7 56727.4 56729.0 59190.8 60000.7 60080.0 60108.0 60126.1 13278.8 13577.3 14178.8 14693.7 14700.9 8990.2 10012.6 10443.0 11172.3 11275.7 18010.7 18232.4 18454.5 18703.8 18836.2 6396.9 7507.4 7604.9 7634.8 7736.7 752.4 850.1 858.4 872.8 873.9 28069.0 29651.2 29957.0 30297.0 30657.4 1042.9 1047.7 1077.5 1079.7 1167.1 15543.8 15568.5 15609.0 15684.8 16000.2 520343.0 616270.0 616424.0 616553.0 617301.0 63004.0 63409.7 63416.7 63450.4 63461.0 1401.8 1415.1 1443.9 1447.2 1450.1 23949.8 29278.6 29385.9 30043.5 30050.7 52871.5 53801.0 53806.7 53869.7 53927.7 560296.0 561607.0 562015.0 563133.0 563196.0 23412.9 24145.0 26060.6 26431.6 27075.0 46104.8 46374.0 47270.5 47308.0 48175.3 39013.6 39163.2 39563.0 40288.0 40477.6 38091.2 38481.6 39377.6 39434.2 39497.2 37216.3 37360.4 37652.6 38182.0 38183.4 28972.6 31544.7 32354.0 33419.7 33917.2 23694.0 23880.0 23888.0 24209.9 24284.5 08:38:53 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:37070.74 Median:21415.68 stddev:105141.42 (491.0%) stddev-sans-first:105400.19 08:38:53 INFO - PROCESS | 1657 | Values: 335.1 389.2 399.0 401.5 428.1 13807.6 19823.3 20832.5 21123.8 21151.9 20498.4 20758.4 20912.0 21041.5 21061.4 5817.5 6187.4 6199.5 6212.9 6221.6 5600.6 5853.8 6042.8 6120.6 6164.7 6103.0 6108.5 6108.7 6111.2 6120.6 5783.8 5952.2 6012.9 6020.1 6101.6 5280.2 5282.7 5283.3 5286.0 5294.5 25977.7 26033.5 26184.3 26438.3 26653.7 2723.2 2738.5 2774.1 2796.9 2797.7 15332.6 15343.8 15449.2 15576.0 15902.4 1827.8 1865.7 1866.9 1876.8 1877.3 133096.0 137830.0 138717.0 138899.0 139008.5 11241.3 11431.1 11456.6 11555.9 11705.3 12537.9 13138.1 14242.4 14266.4 14311.4 6215.5 6407.9 7964.3 8214.3 8376.0 7841.3 7844.3 7856.5 7992.8 8030.7 5867.6 6926.5 7051.8 7075.0 7088.8 1894.7 1960.4 1961.9 1963.2 1969.7 924.8 998.7 1004.0 1004.6 1045.7 16391.8 21679.5 22530.7 22719.1 22762.0 1051.2 1063.9 1086.8 1088.1 1088.6 9514.7 11410.3 11624.5 11627.4 11855.6 528735.0 581088.0 589881.0 704033.0 704794.0 124520.9 140082.0 147797.3 149217.0 157203.2 958.0 978.2 1037.7 1040.7 1041.0 18949.2 19111.4 19222.1 19225.5 19285.2 44063.0 54253.2 56268.4 56696.7 57979.7 81566.0 81653.6 83157.2 84113.1 84658.6 7219.5 7405.8 7538.8 7916.9 8343.0 11737.4 13104.5 13276.6 13526.7 13653.6 10754.7 11398.3 11500.5 11816.9 11842.1 11206.2 11270.9 11476.7 11650.4 11836.3 11461.4 11603.0 11948.6 11976.3 12069.3 7458.2 7681.2 7737.0 7847.4 7898.8 10538.8 10657.7 11117.8 11272.4 11697.1 08:38:53 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5307.27 Median:5250.53 stddev:2858.50 (54.4%) stddev-sans-first:2849.81 08:38:53 INFO - PROCESS | 1657 | Values: 1195.6 1412.7 1422.6 1432.5 1438.3 7917.6 8304.8 8325.0 8325.5 8344.5 7320.4 7517.4 7533.6 7848.8 8062.9 2194.7 2273.9 2274.3 2284.0 2286.4 2249.3 2278.6 2284.8 2286.0 2297.6 1999.3 2063.9 2210.6 2232.6 2249.4 2253.4 2262.7 2266.6 2271.0 2271.9 2211.3 2259.8 2270.0 2283.0 2284.5 8134.4 8205.5 8225.7 8230.0 8232.7 4804.0 4952.8 4959.1 4966.1 4966.3 3092.5 3193.5 3402.3 3471.8 3485.1 1153.2 1187.7 1242.1 1246.8 1250.9 10545.1 10547.8 10547.8 10572.6 10578.7 4211.0 4378.1 4544.1 4604.3 4613.8 8558.9 9184.4 9188.2 9201.4 9209.9 5134.5 5167.5 5173.8 5179.7 5191.3 4372.9 4478.0 4672.2 4762.8 4788.4 3654.5 3704.6 3759.3 3793.4 3804.1 1247.2 1249.2 1254.4 1267.2 1268.8 767.2 818.3 891.3 900.5 931.7 5309.8 5449.3 5682.5 5710.3 5757.4 951.5 954.6 980.4 993.0 1008.7 3514.3 3727.8 3769.6 3791.8 3854.1 9485.6 9813.6 9833.8 9841.0 9845.5 9177.4 9760.4 9760.5 9766.9 9809.1 7384.3 7673.3 7677.8 7680.0 7705.0 5477.4 5572.1 5686.9 5705.2 5760.9 7013.2 8754.2 8964.7 8977.5 9053.0 8175.4 8551.1 9237.9 9258.4 9326.6 6998.1 7017.8 7137.4 7149.1 7155.9 7659.9 7664.3 7771.3 7774.3 7781.6 6663.3 6686.8 6741.9 6787.4 6872.9 6862.5 6903.4 6926.9 6931.7 6953.5 6243.8 6282.2 6285.1 6354.8 6385.4 4830.9 4854.4 4861.8 4951.1 5073.6 4899.3 4914.6 5021.5 5031.2 5071.1 08:38:53 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4462.05 Median:4863.43 stddev:1314.43 (27.0%) stddev-sans-first:1280.43 08:38:53 INFO - PROCESS | 1657 | Values: 298.3 328.8 355.7 365.7 370.1 4476.2 5044.0 5093.4 5262.1 5364.4 4930.6 5207.0 5234.8 5237.2 5276.7 3640.9 4211.1 4215.3 4221.0 4229.6 4025.9 4230.8 4235.6 4240.2 4250.2 3971.0 4109.9 4139.8 4141.8 4157.8 4078.5 4089.5 4117.0 4145.3 4147.8 3036.7 3662.9 3678.2 3682.6 3684.3 4792.9 4915.9 5109.3 5123.4 5220.7 4256.0 4334.1 4774.7 4812.7 4842.8 4418.4 5151.7 5209.3 5556.9 5614.5 3365.9 3859.2 4051.0 4082.3 4109.7 5717.6 5765.6 5793.4 5837.2 5889.6 4143.0 4150.8 4167.9 4174.7 4177.6 3546.5 3662.7 3786.9 4280.0 4290.7 4289.5 4616.8 4709.0 4760.0 4799.5 5541.9 5549.5 5574.8 5575.9 5595.5 1103.7 1357.5 1372.1 1374.6 1379.6 854.6 870.0 969.5 986.2 991.0 4571.9 4860.3 4866.9 4891.7 4912.7 4282.5 5167.3 5200.2 5373.0 5485.6 3976.9 4080.0 4682.1 4854.8 4855.9 2350.7 2683.6 2770.9 2854.6 2900.7 4959.0 5543.0 5703.5 5726.1 5727.9 4873.0 5059.6 5236.2 5609.1 5616.8 4413.4 4618.3 4843.0 5607.6 5668.2 4673.5 4866.6 5457.1 5470.8 5479.8 5095.9 5421.3 5596.4 5695.6 5780.5 5780.9 5903.4 5960.9 5964.5 5973.5 3478.7 3962.9 4173.0 4209.6 4240.5 4649.5 4775.9 5305.8 5332.2 5473.9 4653.0 4672.4 4883.6 5544.9 5600.3 4326.7 4930.6 5556.6 5557.0 5602.4 5078.7 5179.9 5537.5 5546.3 5562.6 4907.9 5439.6 5501.6 5603.4 5650.3 4840.8 5214.4 5230.3 5235.7 5317.9 08:38:53 INFO - PROCESS | 1657 | 08:38:53 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:19146.73 Median:24143.90 stddev:26594.65 (110.2%) stddev-sans-first:26633.20 08:38:53 INFO - PROCESS | 1657 | Values: 703.5 734.3 764.5 823.3 836.7 14933.6 15863.9 15874.2 15901.7 15914.4 14715.9 14863.1 14867.1 14889.3 14909.7 684.3 704.0 706.7 855.2 870.6 853.0 872.7 874.6 875.1 876.5 934.7 935.1 935.9 936.2 936.3 905.8 928.3 929.7 930.9 933.2 534.5 549.7 671.3 684.2 690.4 15267.2 15294.5 15305.5 15313.4 15358.2 13892.9 13939.7 13946.0 13958.4 13981.0 11218.4 12104.4 12685.6 12703.7 13076.1 4470.2 4543.0 4571.4 4673.7 4676.3 102855.6 105662.0 106629.5 107134.0 109634.0 10670.7 10675.0 10739.5 10857.2 11289.7 21214.9 21261.8 21463.6 21524.4 21552.8 6502.3 7373.5 7427.1 7456.0 7475.7 4065.0 4149.6 4152.8 4159.9 4162.5 3266.3 3317.9 3353.2 3353.8 3354.3 619.6 620.6 621.3 636.9 639.4 531.5 541.6 548.2 554.5 559.5 9359.2 9534.6 9577.8 9715.4 9881.0 522.6 528.7 541.2 542.2 561.7 4362.7 4695.8 4708.0 4740.4 4794.0 78975.4 84389.2 87265.0 87519.6 90371.0 73447.6 76769.6 77024.6 78761.5 81025.0 68841.0 69583.6 70163.0 71244.3 71485.0 10060.7 10241.4 10356.2 10472.0 10538.5 43592.1 43925.1 47272.5 47963.3 49098.0 56970.7 57903.0 61426.0 62748.0 64129.7 12315.9 12360.4 12408.7 12499.0 12522.4 14208.1 14334.2 14417.1 14456.7 14461.9 12984.0 13029.2 13102.0 13282.1 13286.9 13152.5 13310.9 13325.0 13331.9 13363.4 9567.4 12771.8 13142.6 13217.8 13245.2 10788.2 11203.6 11485.8 11547.2 11690.4 10606.2 10617.5 10648.7 10650.3 10657.0 08:38:53 INFO - PROCESS | 1657 | -------- Summary: end -------- 08:38:53 INFO - PROCESS | 1657 | 08:38:54 INFO - TEST-INFO | 1657: exit 0 08:38:54 INFO - TEST-OK | dromaeo_css | took 1119393ms 08:38:54 INFO - TEST-START | kraken 08:38:54 INFO - operating with platform_type : mac_ 08:38:54 INFO - Initialising browser for kraken test... 08:38:54 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpVMBN7y/profile http://localhost:49237/getInfo.html) 08:38:56 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:38:56 INFO - PROCESS | 1663 | colorDepth:24 08:38:56 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:38:56 INFO - PROCESS | 1663 | __metrics 08:38:56 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:38:56 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:57 INFO - TEST-INFO | 1663: exit 0 08:38:57 INFO - Browser initialized. 08:38:57 INFO - Running cycle 1/1 for kraken test... 08:38:57 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpVMBN7y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:09 INFO - PROCESS | 1664 | RSS: Main: 236011520 08:39:09 INFO - PROCESS | 1664 | 08:39:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 08:39:13 INFO - PROCESS | 1664 | RSS: Main: 288411648 08:39:13 INFO - PROCESS | 1664 | 08:39:15 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 08:39:16 INFO - PROCESS | 1664 | RSS: Main: 289021952 08:39:16 INFO - PROCESS | 1664 | 08:39:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 08:39:20 INFO - PROCESS | 1664 | RSS: Main: 378802176 08:39:20 INFO - PROCESS | 1664 | 08:39:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 08:39:23 INFO - PROCESS | 1664 | RSS: Main: 281477120 08:39:23 INFO - PROCESS | 1664 | 08:39:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:39:26 INFO - PROCESS | 1664 | RSS: Main: 284872704 08:39:26 INFO - PROCESS | 1664 | 08:39:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 08:39:29 INFO - PROCESS | 1664 | RSS: Main: 327712768 08:39:29 INFO - PROCESS | 1664 | 08:39:32 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 08:39:32 INFO - PROCESS | 1664 | RSS: Main: 329117696 08:39:32 INFO - PROCESS | 1664 | 08:39:35 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 08:39:36 INFO - PROCESS | 1664 | RSS: Main: 328040448 08:39:36 INFO - PROCESS | 1664 | 08:39:37 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:38 INFO - PROCESS | 1664 | RSS: Main: 304640000 08:39:38 INFO - PROCESS | 1664 | 08:39:40 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:41 INFO - PROCESS | 1664 | RSS: Main: 308121600 08:39:41 INFO - PROCESS | 1664 | 08:39:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:43 INFO - PROCESS | 1664 | RSS: Main: 309645312 08:39:43 INFO - PROCESS | 1664 | 08:39:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:47 INFO - PROCESS | 1664 | RSS: Main: 328384512 08:39:47 INFO - PROCESS | 1664 | 08:39:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:51 INFO - PROCESS | 1664 | RSS: Main: 322916352 08:39:51 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 08:39:53 INFO - PROCESS | 1664 | RSS: Main: 367820800 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | __start_tp_report 08:39:53 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 08:39:53 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 08:39:53 INFO - PROCESS | 1664 | |i|pagename|runs| 08:39:53 INFO - PROCESS | 1664 | |0;ai-astar;114;113;113;115;114;115;114;114;114;114 08:39:53 INFO - PROCESS | 1664 | |1;audio-beat-detection;153;120;136;178;112;110;109;111;146;138 08:39:53 INFO - PROCESS | 1664 | |2;audio-dft;191;259;221;186;186;182;193;190;185;185 08:39:53 INFO - PROCESS | 1664 | |3;audio-fft;82;75;83;105;60;58;59;60;75;60 08:39:53 INFO - PROCESS | 1664 | |4;audio-oscillator;92;71;89;73;69;70;85;68;70;107 08:39:53 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;88;86;89;86;89;86;88;86;89;85 08:39:53 INFO - PROCESS | 1664 | |6;imaging-darkroom;94;94;94;95;95;97;94;94;93;93 08:39:53 INFO - PROCESS | 1664 | |7;imaging-desaturate;91;132;81;85;87;82;85;84;85;84 08:39:53 INFO - PROCESS | 1664 | |8;json-parse-financial;58;55;55;55;57;57;55;54;54;55 08:39:53 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;66;78;78;76;71;69;69;70;71;71 08:39:53 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;86;87;87;85;87;87;89;87;91;88 08:39:53 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;141;142;143;147;147;139;140;139;175;164 08:39:53 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;174;177;153;232;227;175;186;234;234;174 08:39:53 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;68;67;67;67;66;68;67;66;67;65 08:39:53 INFO - PROCESS | 1664 | __end_tp_report 08:39:53 INFO - PROCESS | 1664 | __start_cc_report 08:39:53 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2020 08:39:53 INFO - PROCESS | 1664 | __end_cc_report 08:39:53 INFO - PROCESS | 1664 | __startTimestamp1485621593433__endTimestamp 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | ------- Summary: start ------- 08:39:53 INFO - PROCESS | 1664 | Number of tests: 14 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:39:53 INFO - PROCESS | 1664 | Values: 114.0 113.0 113.0 115.0 114.0 115.0 114.0 114.0 114.0 114.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:137.00 stddev:23.09 (16.9%) stddev-sans-first:23.12 08:39:53 INFO - PROCESS | 1664 | Values: 153.0 120.0 136.0 178.0 112.0 110.0 109.0 111.0 146.0 138.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:197.80 Median:190.50 stddev:24.20 (12.7%) stddev-sans-first:25.54 08:39:53 INFO - PROCESS | 1664 | Values: 191.0 259.0 221.0 186.0 186.0 182.0 193.0 190.0 185.0 185.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:71.70 Median:67.50 stddev:15.36 (22.8%) stddev-sans-first:15.84 08:39:53 INFO - PROCESS | 1664 | Values: 82.0 75.0 83.0 105.0 60.0 58.0 59.0 60.0 75.0 60.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:72.00 stddev:13.21 (18.3%) stddev-sans-first:13.20 08:39:53 INFO - PROCESS | 1664 | Values: 92.0 71.0 89.0 73.0 69.0 70.0 85.0 68.0 70.0 107.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:1.55 (1.8%) stddev-sans-first:1.62 08:39:53 INFO - PROCESS | 1664 | Values: 88.0 86.0 89.0 86.0 89.0 86.0 88.0 86.0 89.0 85.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:1.16 (1.2%) stddev-sans-first:1.22 08:39:53 INFO - PROCESS | 1664 | Values: 94.0 94.0 94.0 95.0 95.0 97.0 94.0 94.0 93.0 93.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:89.60 Median:85.00 stddev:15.15 (17.8%) stddev-sans-first:16.06 08:39:53 INFO - PROCESS | 1664 | Values: 91.0 132.0 81.0 85.0 87.0 82.0 85.0 84.0 85.0 84.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.09 08:39:53 INFO - PROCESS | 1664 | Values: 58.0 55.0 55.0 55.0 57.0 57.0 55.0 54.0 54.0 55.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:71.00 stddev:4.07 (5.7%) stddev-sans-first:3.71 08:39:53 INFO - PROCESS | 1664 | Values: 66.0 78.0 78.0 76.0 71.0 69.0 69.0 70.0 71.0 71.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:1.65 (1.9%) stddev-sans-first:1.67 08:39:53 INFO - PROCESS | 1664 | Values: 86.0 87.0 87.0 85.0 87.0 87.0 89.0 87.0 91.0 88.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:145.00 stddev:12.12 (8.4%) stddev-sans-first:12.61 08:39:53 INFO - PROCESS | 1664 | Values: 141.0 142.0 143.0 147.0 147.0 139.0 140.0 139.0 175.0 164.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.60 Median:206.50 stddev:31.38 (15.2%) stddev-sans-first:32.20 08:39:53 INFO - PROCESS | 1664 | Values: 174.0 177.0 153.0 232.0 227.0 175.0 186.0 234.0 234.0 174.0 08:39:53 INFO - PROCESS | 1664 | 08:39:53 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 08:39:53 INFO - PROCESS | 1664 | Values: 68.0 67.0 67.0 67.0 66.0 68.0 67.0 66.0 67.0 65.0 08:39:53 INFO - PROCESS | 1664 | -------- Summary: end -------- 08:39:53 INFO - PROCESS | 1664 | 08:39:54 INFO - TEST-INFO | 1664: exit 0 08:39:54 INFO - TEST-OK | kraken | took 60087ms 08:39:54 INFO - SUITE-END | took 1179s 08:39:54 INFO - Completed test suite (00:19:39) 08:39:54 INFO - javascript benchmark 08:39:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7247.790820198379, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.3627856289463, 3330.950750513588, 3335.665733706518, 3357.83210839458, 3389.169653434909, 4705.1530724469585, 5564.666120032796, 5588.6646801191955, 5664.858378540539, 5668.149777533372, 5660.235868157797, 5672.886542269152, 5705.629134106281, 5709.257796486461, 5710.229119068925, 5160.767765450545, 5184.7148406837605, 5254.684718916858, 5260.947390526103, 5273.182656688219, 5154.819581314655, 5291.1798671206025, 5294.629375943667, 5294.841154765344, 5305.098133317345, 5281.102212623863, 5295.232191332255, 5297.814576489824, 5299.205119232127, 5320.600954928396, 5130.97380523893, 5148.871278218075, 5266.078436273675, 5273.050850846846, 5346.171343441753, 5141.742912854343, 5166.974165129188, 5180.844574662766, 5199.064168449678, 5257.342832145981, 5615.691136987464, 5650.63270887391, 5671.0, 5674.2623458950075, 5679.886402271932, 6241.625502469867, 6246.031865060922, 6253.4997200224325, 6254.781082662085, 6260.40526150015, 6173.876522469525, 6180.258368995705, 6203.968980155116, 6291.842703932392, 6302.401271879165, 5858.619189752652, 5874.148248503943, 5900.704964751745, 5910.0, 5911.793087241926, 6164.044573091089, 6282.371762823681, 6287.2140982377205, 6291.465225455888, 6296.905546416808, 6012.158297838306, 6051.0923361496125, 6188.319284878659, 6191.628502289877, 6218.409251121137, 6204.193454850841, 6215.751369945242, 6236.719347629368, 6262.937370626236, 6297.055441683784, 6097.542684298695, 6149.723262453201, 6270.561060725797, 6272.059191121369, 6273.749050037947, 6127.750382672762, 6191.25704915404, 6205.81382558524, 6275.748970041239, 6324.33594472583, 4994.425641051253, 5006.999999999927, 5014.398272207285, 5020.2720605511995, 5045.545900868866, 4411.911761764747, 4425.955740442554, 4433.778311084433, 4441.067375851043, 4533.795979180944, 5698.772049117989, 5750.769969201268, 5756.992526307879, 5773.8556536086935, 5806.390329015477, 6315.273743519554, 6339.11252424661, 6340.302566717657, 6342.841428964312, 6349.714262858182, 5041.79832806691, 5407.70257635826, 5616.2698849150165, 5743.655380677089, 5761.942380576224, 5404.972975135178, 5406.621536492407, 5417.214503896992, 5429.4299098594865, 5446.972765136149, 6234.37656234382, 6254.249490061313, 6254.874902501833, 6280.591761535486, 6294.527910406646, 6228.252609686867, 6301.8109456716375, 6311.747530098928, 6318.0, 6335.049742538656, 6262.4990000800735, 6262.5929314594405, 6263.561550691408, 6266.811995640138, 6279.089532017923, 6112.777056696867, 6159.568830182024, 6167.84580385494, 6227.377262273736, 6275.152854364603, 6296.464800492009, 6318.778842740666, 6321.936780632135, 6324.747010119728, 6329.841753956188, 6125.111858780541, 6189.659568723763, 6193.659348735863, 6200.286966998853, 6202.844928876814, 5903.911441328298, 5979.521638269015, 6096.908546371897, 6099.969500152471, 6104.0347610180015, 5757.65454072757, 5878.088896221093, 5920.963831329586, 6016.8796624068145, 6064.332923378337, 6115.938840611715, 6119.357467465852, 6134.436587033385, 6136.120845438929, 6142.529470848956, 5979.4917432018765, 6018.548608854266, 6025.005874030736, 6050.42520960508, 6055.666938318434], "value": 5711.390161978177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.6886095302812, 441.9845305414311, 471.91269615121183, 472.13599113622075, 495.1335163463938, 23649.76350236497, 40263.0, 42761.289548418026, 42964.785176074074, 44269.77865110678, 43662.345064823974, 43963.78018109905, 43985.0, 43988.78005609968, 44133.7793311033, 8328.541930193836, 9192.12674795895, 9409.482478463682, 9413.81172376552, 9417.670381536647, 8281.710140145096, 11091.445427728622, 11355.659330220107, 11384.658460246206, 11572.71068223297, 9616.855747163798, 11253.156013298994, 11342.035926946179, 11346.0, 11394.430278486043, 8315.8336833263, 8539.444936079135, 9656.999999999965, 11336.48985795637, 11416.600418985296, 10909.727256818644, 11233.60682376121, 11237.719057023558, 11443.54225830974, 11474.885251147465, 41533.37699934503, 41994.0, 41995.79002105001, 42026.0, 42032.579674203174, 3546.804925729084, 3989.082511022452, 3999.1201935574127, 4010.3984402339593, 4125.731827431237, 28586.571201431994, 29323.266918327, 30016.69983300161, 30365.696343036507, 30468.390632187453, 3059.5257735051105, 3097.225693576606, 3098.148009297439, 3111.502159654467, 3167.303193297471, 489536.0, 490035.99999999645, 492026.53986730194, 492999.0, 493576.0, 56211.156832647546, 56655.866882662114, 56708.71645641745, 56727.43272567304, 56729.0, 59190.816183676085, 60000.69999649974, 60079.9880017992, 60108.0, 60126.09810852841, 13278.800817987738, 13577.253251071286, 14178.787318190236, 14693.706125877423, 14700.926495367668, 8990.190882820578, 10012.649557265606, 10443.0, 11172.329660220414, 11275.66173014811, 18010.729839052423, 18232.36186733458, 18454.538636533925, 18703.81296187048, 18836.152373143243, 6396.872062558816, 7507.361874240751, 7604.9353090567365, 7634.809129771689, 7736.690532378641, 752.3905636434506, 850.1116333431579, 858.3733874271692, 872.8347655879345, 873.895132584094, 28069.0, 29651.20054345369, 29957.0, 30297.0, 30657.38685226283, 1042.921780866423, 1047.6542740895638, 1077.466654006272, 1079.7354648111263, 1167.0605162843992, 15543.766843497357, 15568.45510407153, 15609.0, 15684.76472852908, 16000.199990000454, 520343.0, 616270.0, 616424.0, 616553.0, 617301.0, 63004.0, 63409.68295158587, 63416.68291658512, 63450.36549634444, 63461.0, 1401.831780186384, 1415.143837978029, 1443.9350229239499, 1447.1534152520894, 1450.050217107796, 23949.76050239545, 29278.560821587267, 29385.85307073451, 30043.549346760254, 30050.69949300479, 52871.47128528819, 53801.0, 53806.65483362791, 53869.730651346494, 53927.730361347945, 560296.0, 561607.0, 562015.0, 563133.0, 563196.0, 23412.946417410916, 24145.034198631856, 26060.609090863272, 26431.603525946743, 27075.0, 46104.7694761524, 46374.0, 47270.52729472799, 47308.0, 48175.27737083876, 39013.60986390214, 39163.216735665694, 39563.0, 40288.0, 40477.595224047385, 38091.2381752369, 38481.615183848924, 39377.60622393739, 39434.2113157741, 39497.210055799296, 37216.25567488581, 37360.43959340666, 37652.623473766005, 38182.0, 38183.42724859185, 28972.565411518422, 31544.74295751921, 32354.0, 33419.66580334263, 33917.15207119842, 23694.0, 23879.97020253298, 23888.0, 24209.878950605133, 24284.51430971406], "value": 19837.67807133519, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.14203638684967, 389.2273836434678, 399.0034645178872, 401.5462527344102, 428.1223491841724, 13807.585772426819, 19823.306184283552, 20832.47918802027, 21123.788762112374, 21151.894240528774, 20498.385048448534, 20758.377248682562, 20912.0, 21041.47396315093, 21061.368158955218, 5817.534597232211, 6187.412195841388, 6199.504039676815, 6212.937870621304, 6221.595596286227, 5600.635958662674, 5853.824385268427, 6042.788502402417, 6120.602160859552, 6164.722587483551, 6103.0, 6108.541859360544, 6108.69456527174, 6111.174991376151, 6120.602160859552, 5783.797567085153, 5952.226210592617, 6012.939870601282, 6020.127081573191, 6101.60339577926, 5280.234366016906, 5282.683039017633, 5283.339582552181, 5285.969235998982, 5294.470552944713, 25977.74022259791, 26033.479330413476, 26184.34539136518, 26438.339041523923, 26653.733462665317, 2723.1694333228356, 2738.52075886719, 2774.098418014133, 2796.9440611187865, 2797.734215249548, 15332.616684582863, 15343.846561534465, 15449.227538623136, 15576.0, 15902.443414480438, 1827.7806663200502, 1865.7201419787004, 1866.8599855010928, 1876.7715948083003, 1877.3241633012105, 133096.0, 137830.0, 138717.0, 138899.0, 139008.49690031508, 11241.325520468634, 11431.14266430021, 11456.599019034295, 11555.942220289013, 11705.297682139098, 12537.874621253854, 13138.146020508637, 14242.359093840802, 14266.429342826379, 14311.427542898376, 6215.502759779297, 6407.935920640827, 7964.283214510722, 8214.26071653554, 8376.0, 7841.255080767318, 7844.294013538809, 7856.528608283407, 7992.761122026095, 8030.718924837603, 5867.647941123546, 6926.480513961473, 7051.788446346618, 7074.964625176841, 7088.787336379917, 1894.6968485042328, 1960.4216756056996, 1961.931332403359, 1963.234338607944, 1969.6946973219174, 924.8150369926042, 998.6754304850953, 1003.9508713394374, 1004.5830980143159, 1045.6549338718357, 16391.754123688155, 21679.458013549473, 22530.662040069412, 22719.09123635036, 22761.97571109304, 1051.1800795379615, 1063.914886809069, 1086.760912599227, 1088.1294964028746, 1088.5917780832187, 9514.733617395043, 11410.258333208314, 11624.476898539586, 11627.360495172677, 11855.58505452305, 528735.0, 581088.0, 589881.0, 704033.0, 704794.0, 124520.89090554648, 140082.0, 147797.2610136964, 149217.0, 157203.21398393164, 957.9616815327448, 978.1978777402604, 1037.6886933919945, 1040.6669865643073, 1040.9895901040893, 18949.242030318634, 19111.426657200307, 19222.135003924577, 19225.51936201606, 19285.228590856208, 44063.0, 54253.18620220779, 56268.43731562632, 56696.71651641715, 57979.71010144922, 81566.0, 81653.59173204096, 83157.16842831494, 84113.12133497905, 84658.57670711607, 7219.530730502501, 7405.8148546286775, 7538.849223015619, 7916.920830791619, 8343.0, 11737.35444550558, 13104.475820967436, 13276.552354961195, 13526.729465410834, 13653.590392288248, 10754.73113172177, 11398.259113157617, 11500.50493435848, 11816.881831181578, 11842.052635788943, 11206.159538034517, 11270.887291127312, 11476.655700329004, 11650.417479125841, 11836.289822610672, 11461.369624670722, 11603.0, 11948.641540753792, 11976.28142311464, 12069.27584344942, 7458.21688722698, 7681.1934746850775, 7736.994190755166, 7847.411444141826, 7898.842023159619, 10538.78922421532, 10657.680269591925, 11117.821757468626, 11272.380019099028, 11697.06423486136], "value": 10010.821575707367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1195.5755706724112, 1412.689208374158, 1422.5803388000538, 1432.5344263114484, 1438.3239877257686, 7917.643706033228, 8304.750857474279, 8324.958375208116, 8325.458845175059, 8344.499330040195, 7320.414366850652, 7517.398608111352, 7533.623318834064, 7848.8037799055055, 8062.91937080629, 2194.703714998471, 2273.9420824154167, 2274.306336567346, 2283.9885800570974, 2286.4283929017747, 2249.336445748508, 2278.5898538263104, 2284.828637852168, 2286.039863257436, 2297.6208925527267, 1999.3302243748362, 2063.9174433022663, 2210.635245184543, 2232.6427771556555, 2249.3814201094665, 2253.4028482452163, 2262.694536237603, 2266.6486694562286, 2271.0121097322717, 2271.9204827830945, 2211.2813335665974, 2259.8418110732255, 2270.0465804362043, 2283.0251832165222, 2284.5202507473286, 8134.430589858713, 8205.466644668077, 8225.670973161066, 8230.0, 8232.711855085043, 4803.951960480385, 4952.7523623819025, 4959.107360675077, 4966.056449274663, 4966.329545511346, 3092.5361195820583, 3193.457112290916, 3402.3195360927666, 3471.8264086795557, 3485.0590340607896, 1153.244624770768, 1187.6674531131298, 1242.1305086439438, 1246.8316777235048, 1250.9124361294712, 10545.103666188383, 10547.789044219073, 10547.84178237327, 10572.577096916115, 10578.735531611772, 4211.0, 4378.1024889898135, 4544.091181763661, 4604.309353596987, 4613.769311534477, 8558.871616925751, 9184.403013804082, 9188.219001384823, 9201.447913125234, 9209.861852072225, 5134.512221338967, 5167.534921856975, 5173.793048278102, 5179.741012949337, 5191.273221748958, 4372.912541749147, 4478.037221997286, 4672.159011377985, 4762.78567464465, 4788.449328327218, 3654.524911761454, 3704.6480584344445, 3759.285735710206, 3793.4067691569608, 3804.0680033391995, 1247.2267194339568, 1249.1830921272472, 1254.4292346982102, 1267.207995003123, 1268.8096785482066, 767.1522967121363, 818.275825894088, 891.3003292415423, 900.5002223765742, 931.7158266728712, 5309.787608495694, 5449.291592093082, 5682.466170483873, 5710.2862142232225, 5757.366689664133, 951.5251360391366, 954.6467806911348, 980.3823591137681, 992.9734924879682, 1008.7478130467383, 3514.297140571845, 3727.8322475488667, 3769.5853456119803, 3791.810409479515, 3854.0557563397147, 9485.620575177054, 9813.558389872473, 9833.754156146011, 9841.0, 9845.458499782437, 9177.403468774508, 9760.414375137514, 9760.511974401252, 9766.925638179795, 9809.11717945374, 7384.335409813035, 7673.309402153833, 7677.769666910001, 7680.0, 7704.961475192588, 5477.370102438271, 5572.108462645957, 5686.886262274814, 5705.172749951151, 5760.913586296293, 7013.228544860163, 8754.21212090915, 8964.731058068268, 8977.506237156758, 9052.954735226545, 8175.386845986456, 8551.1448855114, 9237.907620923705, 9258.444493330422, 9326.580303886205, 6998.090248267897, 7017.789466316019, 7137.429005679637, 7149.0706208192605, 7155.928440715735, 7659.923400766144, 7664.31021208094, 7771.261730135628, 7774.2614451627005, 7781.572013539083, 6663.300353462817, 6686.765963191265, 6741.86516269662, 6787.423069039187, 6872.896906546506, 6862.519623626298, 6903.413209877016, 6926.9307306926285, 6931.7227310907, 6953.478489113438, 6243.8126856194385, 6282.246130464374, 6285.120083188449, 6354.777582784765, 6385.393387628168, 4830.903381932412, 4854.441739200037, 4861.756912154449, 4951.133551628379, 5073.644844860972, 4899.289603007473, 4914.582260507754, 5021.548060674557, 5031.22016087507, 5071.137906555969], "value": 4332.771203927964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.3130397601564, 328.75565982755273, 355.69410307135865, 365.6928180328524, 370.1468115992636, 4476.239039363308, 5044.0, 5093.414257360405, 5262.079136151177, 5364.352240476484, 4930.6055515558755, 5207.0, 5234.842954711356, 5237.214417837316, 5276.709780962055, 3640.872569460056, 4211.136427229483, 4215.283401821697, 4220.957790422102, 4229.6042306038935, 4025.8993525161814, 4230.809613567397, 4235.6187943085115, 4240.23675738367, 4250.2137104635585, 3971.0, 4109.938350924738, 4139.847279414703, 4141.792910354486, 4157.750534967897, 4078.5105787305565, 4089.488813898263, 4117.032497363117, 4145.253854306224, 4147.81334839933, 3036.6963303669677, 3662.926741465182, 3678.1907980244305, 3682.6317368263226, 3684.299983003221, 4792.856214313576, 4915.935307170997, 5109.310243117169, 5123.410807757118, 5220.686758794446, 4256.0, 4334.089841133366, 4774.713517188945, 4812.7352995585225, 4842.757862106881, 4418.447694038246, 5151.690898546061, 5209.270702101709, 5556.9444305556835, 5614.522765564931, 3365.8653653853817, 3859.1702783901596, 4051.0, 4082.2856000199845, 4109.6506796922295, 5717.628354156966, 5765.567582431292, 5793.362730099686, 5837.219648007356, 5889.5582831286965, 4142.958570414257, 4150.758590361171, 4167.916641667211, 4174.7077704561, 4177.561356057631, 3546.4819977815523, 3662.7069834413182, 3786.8639408177437, 4280.0, 4290.699651024398, 4289.485261768546, 4616.838410655611, 4709.011107667359, 4759.952400476021, 4799.544043315879, 5541.944580554143, 5549.500544950893, 5574.777008919679, 5575.8884822304135, 5595.496405323541, 1103.674416047268, 1357.450232655776, 1372.1355546006153, 1374.6357215337944, 1379.5861241627472, 854.5513605357113, 869.9603973251903, 969.4619486185235, 986.2051067058029, 990.9752256193652, 4571.9314210286875, 4860.295257187688, 4866.926996095061, 4891.730954797449, 4912.666483420347, 4282.5075116361395, 5167.328247327823, 5200.219967004904, 5373.0, 5485.61600687948, 3976.940345894814, 4080.021189722982, 4682.073703935041, 4854.781534830941, 4855.936227103467, 2350.670906073151, 2683.624991882198, 2770.8500972096354, 2854.615511476932, 2900.7389334959953, 4959.0, 5543.009033495877, 5703.54371650267, 5726.139004823366, 5727.933167451157, 4872.9512704872495, 5059.62052846038, 5236.24074509194, 5609.06487261894, 5616.803411880564, 4413.44831896013, 4618.30725391194, 4843.007183527439, 5607.635503692411, 5668.234788303609, 4673.509281525391, 4866.562009419169, 5457.135004122867, 5470.8085217017215, 5479.780808767764, 5095.878906640533, 5421.322334708161, 5596.384397716167, 5695.572832037531, 5780.479756821906, 5780.930527852361, 5903.380145084704, 5960.940390596039, 5964.508872781805, 5973.535349497194, 3478.6869181773764, 3962.9392715788204, 4172.979135104427, 4209.642180414699, 4240.469941257343, 4649.535396350139, 4775.880602984953, 5305.814296499604, 5332.20016997438, 5473.890522189614, 4652.976735116303, 4672.425594420339, 4883.5837607093545, 5544.916826247691, 5600.27196464457, 4326.675499337499, 4930.556249937523, 5556.611037227355, 5556.972215138899, 5602.350049459021, 5078.7206703631655, 5179.896402071862, 5537.501624853782, 5546.334439867242, 5562.637153897321, 4907.920257543335, 5439.646422982493, 5501.559875209893, 5603.439656034364, 5650.29371328584, 4840.782164802522, 5214.374275087014, 5230.320058392537, 5235.685858848481, 5317.946820531745], "value": 4057.9816918360593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.4899697719151, 734.313416955147, 764.5221736414741, 823.287856004556, 836.736428025172, 14933.626659333522, 15863.920680396597, 15874.206289685513, 15901.681966360695, 15914.363425462967, 14715.852841471582, 14863.108213507197, 14867.107973521597, 14889.329980150893, 14909.701805963874, 684.336193891924, 703.9788806335819, 706.7314420520221, 855.1875718067829, 870.6038752367657, 852.9616167272457, 872.733816186063, 874.5802015032756, 875.1248751248751, 876.5441970175505, 934.654177954158, 935.1443429262217, 935.8876934767837, 936.241644268145, 936.3164889630574, 905.7916679163764, 928.3037721708719, 929.6560272699077, 930.939488933224, 933.1834644685899, 534.521603165165, 549.7443688684741, 671.3253180553512, 684.226823689228, 690.4476418864888, 15267.160306183156, 15294.541163764994, 15305.540833775005, 15313.387464501406, 15358.232088395647, 13892.861071389258, 13939.651508712263, 13946.0, 13958.441662333495, 13980.951428642791, 11218.439078046065, 12104.39478026104, 12685.619431417072, 12703.682407939876, 13076.08467407282, 4470.2177119004045, 4542.977285113553, 4571.428571428572, 4673.719576825401, 4676.321933319684, 102855.60021596983, 105661.99999999923, 106629.46685266524, 107134.0, 109634.0, 10670.733231669115, 10675.039246467855, 10739.463026848627, 10857.185711071701, 11289.717757055974, 21214.893925530272, 21261.78738212629, 21463.570728585342, 21524.354269371943, 21552.784472155392, 6502.252240992252, 7373.483856130127, 7427.108746950401, 7456.0, 7475.738349157862, 4065.0447144920918, 4149.605787450188, 4152.750834949913, 4159.91680166395, 4162.500499940026, 3266.3304022675293, 3317.867285308609, 3353.245519758035, 3353.8155401453155, 3354.2955979244143, 619.6127420362274, 620.6307247187916, 621.3196549777986, 636.8853606350901, 639.354252205276, 531.4579129288104, 541.5829811045552, 548.202365558112, 554.5314209492972, 559.4908633143901, 9359.204467620328, 9534.646705520412, 9577.808443831085, 9715.36850104741, 9880.99746845525, 522.615877330162, 528.7382745540982, 541.2260467531468, 542.1758926431802, 561.6586264623379, 4362.672799539983, 4695.765211739467, 4707.964247865532, 4740.407449068866, 4793.952060479421, 78975.420491591, 84389.15610843936, 87265.0, 87519.56240218885, 90371.0, 73447.63276183585, 76769.61615191889, 77024.61487692638, 78761.48669593074, 81025.0, 68841.0, 69583.60832783316, 70163.0, 71244.28755712583, 71485.0, 10060.69817905464, 10241.436720980417, 10356.223283253938, 10472.0, 10538.470767015708, 43592.12815743604, 43925.12149757051, 47272.52727472681, 47963.28055079107, 49098.0, 56970.715146424, 57903.0, 61426.0, 62748.0, 64129.67935160294, 12315.876841231473, 12360.38198090074, 12408.689782755504, 12499.0, 12522.37388130608, 14208.07647502909, 14334.21161836109, 14417.062890912057, 14456.710865782416, 14461.927690361481, 12984.003475985251, 13029.218246905217, 13102.0, 13282.136661116996, 13286.933565332112, 13152.473901044234, 13310.933445332712, 13325.0, 13331.933340333237, 13363.3986470611, 9567.37812042215, 12771.80842287385, 13142.60572182836, 13217.801732974205, 13245.20528768277, 10788.244822862323, 11203.607873724706, 11485.81600953382, 11547.191696581158, 11690.415479225834, 10606.204534660086, 10617.469126543796, 10648.733781655521, 10650.307729997525, 10657.0], "value": 7267.865595397571, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1491.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 136.0, 178.0, 112.0, 110.0, 109.0, 111.0, 146.0, 138.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 259.0, 221.0, 186.0, 186.0, 182.0, 193.0, 190.0, 185.0, 185.0], "value": 197.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 83.0, 105.0, 60.0, 58.0, 59.0, 60.0, 75.0, 60.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 71.0, 89.0, 73.0, 69.0, 70.0, 85.0, 68.0, 70.0, 107.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 89.0, 86.0, 88.0, 86.0, 89.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 97.0, 94.0, 94.0, 93.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 132.0, 81.0, 85.0, 87.0, 82.0, 85.0, 84.0, 85.0, 84.0], "value": 89.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 55.0, 57.0, 57.0, 55.0, 54.0, 54.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 78.0, 76.0, 71.0, 69.0, 69.0, 70.0, 71.0, 71.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 85.0, 87.0, 87.0, 89.0, 87.0, 91.0, 88.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 143.0, 147.0, 147.0, 139.0, 140.0, 139.0, 175.0, 164.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 153.0, 232.0, 227.0, 175.0, 186.0, 234.0, 234.0, 174.0], "value": 196.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 67.0, 65.0], "value": 66.8, "unit": "score"}]}]} 08:39:54 INFO - Return code: 0 08:39:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:54 ERROR - # TBPL SUCCESS # 08:39:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:39:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:39:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:39:54 INFO - 2017-01-28 08:39:54.758 screenresolution[1668:10331] starting screenresolution argv=screenresolution get 08:39:54 INFO - 2017-01-28 08:39:54.762 screenresolution[1668:10331] Display 0: 1600x1200x32@60 08:39:54 INFO - 2017-01-28 08:39:54.768 screenresolution[1669:10334] starting screenresolution argv=screenresolution list 08:39:54 INFO - Available Modes on Display 0 08:39:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:39:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:39:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:39:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:39:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:39:54 INFO - Intel Iris: 08:39:54 INFO - Chipset Model: Intel Iris 08:39:54 INFO - Type: GPU 08:39:54 INFO - Bus: Built-In 08:39:54 INFO - VRAM (Dynamic, Max): 1536 MB 08:39:54 INFO - Vendor: Intel (0x8086) 08:39:54 INFO - Device ID: 0x0a2e 08:39:54 INFO - Revision ID: 0x0009 08:39:54 INFO - Displays: 08:39:54 INFO - Display: 08:39:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:39:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:39:54 INFO - Display Serial Number: 1600x1200 60 08:39:54 INFO - Main Display: Yes 08:39:54 INFO - Mirror: Off 08:39:54 INFO - Online: Yes 08:39:55 INFO - Rotation: Supported 08:39:55 INFO - Return code: 0 08:39:55 INFO - Running post-action listener: _resource_record_post_action 08:39:55 INFO - [mozharness: 2017-01-28 16:39:55.003813Z] Finished run-tests step (success) 08:39:55 INFO - Running post-run listener: _resource_record_post_run 08:39:55 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 32377856; Write bytes: 555719680; Read time: 198; Write time: 1683 08:39:55 INFO - TinderboxPrint: CPU usage
53.6% 08:39:55 INFO - TinderboxPrint: I/O read bytes / time
32,377,856 / 198 08:39:55 INFO - TinderboxPrint: I/O write bytes / time
555,719,680 / 1,683 08:39:55 INFO - TinderboxPrint: CPU idle
2,232.6 (46.4%) 08:39:55 INFO - TinderboxPrint: CPU system
960.4 (20.0%) 08:39:55 INFO - TinderboxPrint: CPU user
1,620.7 (33.7%) 08:39:55 INFO - TinderboxPrint: Swap in / out
280,096,768 / 0 08:39:55 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 235858432; Write bytes: 229271552; Read time: 17638; Write time: 490 08:39:55 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31452160; Write bytes: 301753344; Read time: 187; Write time: 1132 08:39:55 INFO - Running post-run listener: _upload_blobber_files 08:39:55 INFO - Blob upload gear active. 08:39:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:55 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 08:39:55 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'] 08:39:55 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 08:39:55 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:56 INFO - (blobuploader) - INFO - Done attempting. 08:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:58 INFO - (blobuploader) - INFO - Done attempting. 08:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:59 INFO - (blobuploader) - INFO - Done attempting. 08:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:40:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:01 INFO - (blobuploader) - INFO - Done attempting. 08:40:01 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:01 INFO - Return code: 0 08:40:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:40:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f63fef6a459f2b365d3d876328d90627fab473a089ffddb2df2df070c2c18c105789fc4e91de7cc79ef1ac3b14ccb830470089cd2c0cc66147d8920cb8004517", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed7c8ac8411ea0e43e186ff58d5740c1da6066d43f25557bcdd0a649e12406bb4c6eb6c25e1505c7c02fb9eacc1d3599afe1a945c70f738eef227ac091ae521a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69c49687ce923db596f16e65cb96a67ab8ce4b680c055963bf4f01d7862e648cc093cca8e725d4285fd75e51f1fec6d34c55061bf1b05d0e8060b707a52a2856", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee4ebc8189b4ae6bfedf7c1148b96cddb5ffec6a096deb7ae126264bd9b2974423e9c4da0d7a65bd1d4276dceaa11212d53d1ad91dc04bcd1df8245920c73d5b"} 08:40:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:40:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:40:01 INFO - Contents: 08:40:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f63fef6a459f2b365d3d876328d90627fab473a089ffddb2df2df070c2c18c105789fc4e91de7cc79ef1ac3b14ccb830470089cd2c0cc66147d8920cb8004517", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed7c8ac8411ea0e43e186ff58d5740c1da6066d43f25557bcdd0a649e12406bb4c6eb6c25e1505c7c02fb9eacc1d3599afe1a945c70f738eef227ac091ae521a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69c49687ce923db596f16e65cb96a67ab8ce4b680c055963bf4f01d7862e648cc093cca8e725d4285fd75e51f1fec6d34c55061bf1b05d0e8060b707a52a2856", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee4ebc8189b4ae6bfedf7c1148b96cddb5ffec6a096deb7ae126264bd9b2974423e9c4da0d7a65bd1d4276dceaa11212d53d1ad91dc04bcd1df8245920c73d5b"} 08:40:01 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:01 INFO - Copying logs to upload dir... 08:40:01 INFO - mkdir: /builds/slave/test/build/upload/logs 08:40:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.917499 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-28 08:40:01.484057) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-28 08:40:01.487502) ========= 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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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/f63fef6a459f2b365d3d876328d90627fab473a089ffddb2df2df070c2c18c105789fc4e91de7cc79ef1ac3b14ccb830470089cd2c0cc66147d8920cb8004517", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed7c8ac8411ea0e43e186ff58d5740c1da6066d43f25557bcdd0a649e12406bb4c6eb6c25e1505c7c02fb9eacc1d3599afe1a945c70f738eef227ac091ae521a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69c49687ce923db596f16e65cb96a67ab8ce4b680c055963bf4f01d7862e648cc093cca8e725d4285fd75e51f1fec6d34c55061bf1b05d0e8060b707a52a2856", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee4ebc8189b4ae6bfedf7c1148b96cddb5ffec6a096deb7ae126264bd9b2974423e9c4da0d7a65bd1d4276dceaa11212d53d1ad91dc04bcd1df8245920c73d5b"} build_url:https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011115 build_url: 'https://queue.taskcluster.net/v1/task/eyPWo5TuTKOqXsHVqeOhOw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f63fef6a459f2b365d3d876328d90627fab473a089ffddb2df2df070c2c18c105789fc4e91de7cc79ef1ac3b14ccb830470089cd2c0cc66147d8920cb8004517", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed7c8ac8411ea0e43e186ff58d5740c1da6066d43f25557bcdd0a649e12406bb4c6eb6c25e1505c7c02fb9eacc1d3599afe1a945c70f738eef227ac091ae521a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69c49687ce923db596f16e65cb96a67ab8ce4b680c055963bf4f01d7862e648cc093cca8e725d4285fd75e51f1fec6d34c55061bf1b05d0e8060b707a52a2856", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee4ebc8189b4ae6bfedf7c1148b96cddb5ffec6a096deb7ae126264bd9b2974423e9c4da0d7a65bd1d4276dceaa11212d53d1ad91dc04bcd1df8245920c73d5b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-28 08:40:01.521348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:40:01.521674) ========= 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.eZ7XXplVye/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.FaM3bjg7sJ/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.005125 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:40:01.569949) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-28 08:40:01.570274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-28 08:40:01.570604) ========= ========= Total master_lag: 0.23 =========