builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0118 starttime: 1474460180.72 results: success (0) buildid: 20160921030508 builduid: 3f56d416c7c148db82a7a42f2e9f73f6 revision: 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:20.715777) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:20.716202) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:20.716469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:20.742129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:20.742380) ========= 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.CTe2fVYUBv/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.XoF0G6gt55/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-21 05:16:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 54.1M=0s 2016-09-21 05:16:20 (54.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:20.869905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:20.870191) ========= 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.CTe2fVYUBv/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.XoF0G6gt55/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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.020438 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:20.918912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 05:16:20.919221) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 --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 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CTe2fVYUBv/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.XoF0G6gt55/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-21 05:16:20,997 truncating revision to first 12 chars 2016-09-21 05:16:20,997 Setting DEBUG logging. 2016-09-21 05:16:20,997 attempt 1/10 2016-09-21 05:16:20,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/560b2c805bf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 05:16:21,800 unpacking tar archive at: mozilla-central-560b2c805bf7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.051679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 05:16:21.994314) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:21.994624) ========= script_repo_revision: 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:21.994997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:21.995262) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 05:16:22.013749) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-21 05:16:22.014062) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CTe2fVYUBv/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.XoF0G6gt55/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:16:22 INFO - MultiFileLogger online at 20160921 05:16:22 in /builds/slave/test 05:16:22 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 05:16:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:22 INFO - {'append_to_log': False, 05:16:22 INFO - 'base_work_dir': '/builds/slave/test', 05:16:22 INFO - 'blob_upload_branch': 'Firefox', 05:16:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:22 INFO - 'branch': 'Firefox', 05:16:22 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:22 INFO - 'config_files': ('talos/mac_config.py',), 05:16:22 INFO - 'default_actions': ('clobber', 05:16:22 INFO - 'read-buildbot-config', 05:16:22 INFO - 'download-and-extract', 05:16:22 INFO - 'populate-webroot', 05:16:22 INFO - 'create-virtualenv', 05:16:22 INFO - 'install', 05:16:22 INFO - 'run-tests'), 05:16:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:22 INFO - 'download_minidump_stackwalk': True, 05:16:22 INFO - 'download_symbols': 'ondemand', 05:16:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:22 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:22 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:22 INFO - 'installer_path': 'installer.exe', 05:16:22 INFO - 'log_level': 'info', 05:16:22 INFO - 'log_name': 'talos', 05:16:22 INFO - 'log_to_console': True, 05:16:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:16:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:16:22 INFO - 'opt_config_files': (), 05:16:22 INFO - 'pip_index': False, 05:16:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:22 INFO - 'cmd': ('bash', 05:16:22 INFO - '-c', 05:16:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:22 INFO - 'enabled': True, 05:16:22 INFO - 'halt_on_failure': False, 05:16:22 INFO - 'name': 'check_screen_resolution'},), 05:16:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:22 INFO - 'cmd': ('bash', 05:16:22 INFO - '-c', 05:16:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:22 INFO - 'enabled': True, 05:16:22 INFO - 'halt_on_failure': False, 05:16:22 INFO - 'name': 'check_screen_resolution'},), 05:16:22 INFO - 'run_cmd_checks_enabled': True, 05:16:22 INFO - 'sps_profile': False, 05:16:22 INFO - 'sps_profile_interval': 0, 05:16:22 INFO - 'suite': 'dromaeojs', 05:16:22 INFO - 'system_bits': '32', 05:16:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:22 INFO - 'title': 't-yosemite-r7-0118', 05:16:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:22 INFO - 'use_talos_json': True, 05:16:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:22 INFO - 'work_dir': 'build'} 05:16:22 INFO - [mozharness: 2016-09-21 12:16:22.209742Z] Running clobber step. 05:16:22 INFO - Running pre-action listener: _resource_record_pre_action 05:16:22 INFO - Running main action method: clobber 05:16:22 INFO - rmtree: /builds/slave/test/build 05:16:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:23 INFO - Running post-action listener: _resource_record_post_action 05:16:23 INFO - [mozharness: 2016-09-21 12:16:23.094786Z] Finished clobber step (success) 05:16:23 INFO - [mozharness: 2016-09-21 12:16:23.094905Z] Running read-buildbot-config step. 05:16:23 INFO - Running pre-action listener: _resource_record_pre_action 05:16:23 INFO - Running main action method: read_buildbot_config 05:16:23 INFO - Using buildbot properties: 05:16:23 INFO - { 05:16:23 INFO - "project": "", 05:16:23 INFO - "product": "firefox", 05:16:23 INFO - "script_repo_revision": "production", 05:16:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:16:23 INFO - "repository": "", 05:16:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:16:23 INFO - "buildid": "20160921030508", 05:16:23 INFO - "pgo_build": "False", 05:16:23 INFO - "basedir": "/builds/slave/test", 05:16:23 INFO - "buildnumber": 117, 05:16:23 INFO - "slavename": "t-yosemite-r7-0118", 05:16:23 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:16:23 INFO - "platform": "yosemite_r7", 05:16:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:16:23 INFO - "branch": "mozilla-central", 05:16:23 INFO - "repo_path": "mozilla-central", 05:16:23 INFO - "revision": "560b2c805bf7bebeb3ceebc495a81b2aa4c0c755", 05:16:23 INFO - "stage_platform": "macosx64", 05:16:23 INFO - "builduid": "3f56d416c7c148db82a7a42f2e9f73f6", 05:16:23 INFO - "slavebuilddir": "test" 05:16:23 INFO - } 05:16:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:16:23 INFO - Running post-action listener: _resource_record_post_action 05:16:23 INFO - [mozharness: 2016-09-21 12:16:23.098123Z] Finished read-buildbot-config step (success) 05:16:23 INFO - [mozharness: 2016-09-21 12:16:23.098261Z] Running download-and-extract step. 05:16:23 INFO - Running pre-action listener: _resource_record_pre_action 05:16:23 INFO - Running main action method: download_and_extract 05:16:23 INFO - mkdir: /builds/slave/test/build/tests 05:16: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')]} 05:16:23 INFO - trying https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:16:23 INFO - Downloading https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:16:23 INFO - Downloaded 1199 bytes. 05:16:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:16:23 INFO - Using the following test package requirements: 05:16:23 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:16:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:16:23 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:16:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:16:23 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:16:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:16:23 INFO - u'jsshell-mac.zip'], 05:16:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:16:23 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:16:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:16:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:16:23 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:16:23 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:16:23 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:16:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:16:23 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:16:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:16:23 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:16:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:16:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:16:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:16:23 INFO - Fetch https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:16:24 INFO - Expected file size: 16432531 05:16:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:16:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:16:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:16:31 INFO - Fetch https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:16:31 INFO - Expected file size: 16432531 05:16:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:16:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:16:38 INFO - Fetch https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:16:39 INFO - Expected file size: 14414059 05:16: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')]} 05:16:40 INFO - trying https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:16:40 INFO - Downloading https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:16:43 INFO - Downloaded 111317519 bytes. 05:16:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:16:43 INFO - mkdir: /builds/slave/test/properties 05:16:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:43 INFO - Contents: 05:16:43 INFO - build_url:https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:16:44 INFO - Running post-action listener: _resource_record_post_action 05:16:44 INFO - Running post-action listener: set_extra_try_arguments 05:16:44 INFO - [mozharness: 2016-09-21 12:16:44.395767Z] Finished download-and-extract step (success) 05:16:44 INFO - [mozharness: 2016-09-21 12:16:44.395887Z] Running populate-webroot step. 05:16:44 INFO - Running pre-action listener: _resource_record_pre_action 05:16:44 INFO - Running main action method: populate_webroot 05:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:44 INFO - '--tppagecycles', 05:16:44 INFO - '7'], 05:16:44 INFO - 'tests': ['tsvgm']}}, 05:16:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['damp', 'tps']}, 05:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['damp', 'tps']}, 05:16:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['dromaeo_dom']}, 05:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['basic_compositor_video']}, 05:16:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:16:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['a11yr', 05:16:44 INFO - 'ts_paint', 05:16:44 INFO - 'tpaint', 05:16:44 INFO - 'sessionrestore', 05:16:44 INFO - 'sessionrestore_no_auto_restore', 05:16:44 INFO - 'tabpaint']}, 05:16:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['tsvgx', 05:16:44 INFO - 'tsvgr_opacity', 05:16:44 INFO - 'tart', 05:16:44 INFO - 'tscrollx', 05:16:44 INFO - 'cart']}, 05:16:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:44 INFO - 'tsvgr_opacity', 05:16:44 INFO - 'tart', 05:16:44 INFO - 'tscrollx', 05:16:44 INFO - 'cart']}, 05:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--disable-e10s'], 05:16:44 INFO - 'tests': ['tp5o']}, 05:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'tests': ['tp5o']}, 05:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--disable-e10s', 05:16:44 INFO - '--xperf_path', 05:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:44 INFO - 'tests': ['tp5n']}, 05:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:44 INFO - 'talos_options': ['--xperf_path', 05:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:44 INFO - 'tests': ['tp5n']}}, 05:16:44 INFO - 'talos.zip': {'path': '', 05:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:44 INFO - Running post-action listener: _resource_record_post_action 05:16:44 INFO - [mozharness: 2016-09-21 12:16:44.414545Z] Finished populate-webroot step (success) 05:16:44 INFO - [mozharness: 2016-09-21 12:16:44.414685Z] Running create-virtualenv step. 05:16:44 INFO - Running pre-action listener: _resource_record_pre_action 05:16:44 INFO - Running main action method: create_virtualenv 05:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:44 INFO - Using real prefix '/tools/python27' 05:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:48 INFO - Installing pip.................done. 05:16:48 INFO - Return code: 0 05:16:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:48 INFO - 'HOME': '/Users/cltbld', 05:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:48 INFO - 'LOGNAME': 'cltbld', 05:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:48 INFO - 'MOZ_NO_REMOTE': '1', 05:16:48 INFO - 'NO_EM_RESTART': '1', 05:16:48 INFO - 'PAGER': '/bin/cat', 05:16:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:48 INFO - 'PWD': '/builds/slave/test', 05:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:48 INFO - 'SHELL': '/bin/bash', 05:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:16:48 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:48 INFO - 'USER': 'cltbld', 05:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:48 INFO - 'XPC_FLAGS': '0x0', 05:16:48 INFO - 'XPC_SERVICE_NAME': '0', 05:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:16:48 INFO - Cleaning up... 05:16:48 INFO - Return code: 0 05:16:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:48 INFO - 'HOME': '/Users/cltbld', 05:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:48 INFO - 'LOGNAME': 'cltbld', 05:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:48 INFO - 'MOZ_NO_REMOTE': '1', 05:16:48 INFO - 'NO_EM_RESTART': '1', 05:16:48 INFO - 'PAGER': '/bin/cat', 05:16:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:48 INFO - 'PWD': '/builds/slave/test', 05:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:48 INFO - 'SHELL': '/bin/bash', 05:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:16:48 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:48 INFO - 'USER': 'cltbld', 05:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:48 INFO - 'XPC_FLAGS': '0x0', 05:16:48 INFO - 'XPC_SERVICE_NAME': '0', 05:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:48 INFO - Downloading/unpacking psutil>=3.1.1 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:51 INFO - Installing collected packages: psutil 05:16:51 INFO - Running setup.py install for psutil 05:16:51 INFO - building 'psutil._psutil_osx' extension 05:16:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:16:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:16:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:16:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:16:52 INFO - building 'psutil._psutil_posix' extension 05:16:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:16:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:16:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:16:52 INFO - ^ 05:16:52 INFO - 1 warning generated. 05:16:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:52 INFO - Successfully installed psutil 05:16:52 INFO - Cleaning up... 05:16:52 INFO - Return code: 0 05:16:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:52 INFO - 'HOME': '/Users/cltbld', 05:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:52 INFO - 'LOGNAME': 'cltbld', 05:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:52 INFO - 'MOZ_NO_REMOTE': '1', 05:16:52 INFO - 'NO_EM_RESTART': '1', 05:16:52 INFO - 'PAGER': '/bin/cat', 05:16:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:52 INFO - 'PWD': '/builds/slave/test', 05:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:52 INFO - 'SHELL': '/bin/bash', 05:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:16:52 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:52 INFO - 'USER': 'cltbld', 05:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:52 INFO - 'XPC_FLAGS': '0x0', 05:16:52 INFO - 'XPC_SERVICE_NAME': '0', 05:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:16:55 INFO - Installing collected packages: mozsystemmonitor 05:16:55 INFO - Running setup.py install for mozsystemmonitor 05:16:55 INFO - Successfully installed mozsystemmonitor 05:16:55 INFO - Cleaning up... 05:16:55 INFO - Return code: 0 05:16:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:55 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 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:55 INFO - 'HOME': '/Users/cltbld', 05:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:55 INFO - 'LOGNAME': 'cltbld', 05:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:55 INFO - 'MOZ_NO_REMOTE': '1', 05:16:55 INFO - 'NO_EM_RESTART': '1', 05:16:55 INFO - 'PAGER': '/bin/cat', 05:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:55 INFO - 'PWD': '/builds/slave/test', 05:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:55 INFO - 'SHELL': '/bin/bash', 05:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:16:55 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:55 INFO - 'USER': 'cltbld', 05:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:55 INFO - 'XPC_FLAGS': '0x0', 05:16:55 INFO - 'XPC_SERVICE_NAME': '0', 05:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:55 INFO - Downloading/unpacking jsonschema==2.5.1 05:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:58 INFO - warning: no files found matching '*.txt' 05:16:58 INFO - no previously-included directories found matching 'build' 05:16:58 INFO - no previously-included directories found matching 'dist' 05:16:58 INFO - no previously-included directories found matching '.git*' 05:16:58 INFO - Installing collected packages: jsonschema, functools32 05:16:58 INFO - Running setup.py install for functools32 05:16:58 INFO - warning: no files found matching '*.txt' 05:16:58 INFO - no previously-included directories found matching 'build' 05:16:58 INFO - no previously-included directories found matching 'dist' 05:16:58 INFO - no previously-included directories found matching '.git*' 05:16:58 INFO - Successfully installed jsonschema functools32 05:16:58 INFO - Cleaning up... 05:16:59 INFO - Return code: 0 05:16:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:59 INFO - 'HOME': '/Users/cltbld', 05:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:59 INFO - 'LOGNAME': 'cltbld', 05:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:59 INFO - 'MOZ_NO_REMOTE': '1', 05:16:59 INFO - 'NO_EM_RESTART': '1', 05:16:59 INFO - 'PAGER': '/bin/cat', 05:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:59 INFO - 'PWD': '/builds/slave/test', 05:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:59 INFO - 'SHELL': '/bin/bash', 05:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:16:59 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:59 INFO - 'USER': 'cltbld', 05:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:59 INFO - 'XPC_FLAGS': '0x0', 05:16:59 INFO - 'XPC_SERVICE_NAME': '0', 05:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:16:59 INFO - Cleaning up... 05:16:59 INFO - Return code: 0 05:16:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:59 INFO - 'HOME': '/Users/cltbld', 05:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:59 INFO - 'LOGNAME': 'cltbld', 05:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:59 INFO - 'MOZ_NO_REMOTE': '1', 05:16:59 INFO - 'NO_EM_RESTART': '1', 05:16:59 INFO - 'PAGER': '/bin/cat', 05:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:59 INFO - 'PWD': '/builds/slave/test', 05:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:59 INFO - 'SHELL': '/bin/bash', 05:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:16:59 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:59 INFO - 'USER': 'cltbld', 05:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:59 INFO - 'XPC_FLAGS': '0x0', 05:16:59 INFO - 'XPC_SERVICE_NAME': '0', 05:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:03 INFO - Downloading docopt-0.6.1.tar.gz 05:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:03 INFO - Running setup.py install for blobuploader 05:17:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:03 INFO - Running setup.py install for requests 05:17:03 INFO - Running setup.py install for docopt 05:17:04 INFO - Successfully installed blobuploader requests docopt 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:04 INFO - 'HOME': '/Users/cltbld', 05:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PAGER': '/bin/cat', 05:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:17:04 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - 'XPC_FLAGS': '0x0', 05:17:04 INFO - 'XPC_SERVICE_NAME': '0', 05:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:04 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-eJLUFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:04 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-XanhqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:04 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-UjEIl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:04 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-U8kJZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:04 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-bWx6qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:04 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-hkxJNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-bAQjiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-n3Csew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-W9RazN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-d6I4JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-lNHMf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-4uiqZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Xg_SPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-x2yTP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-OoY3Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:05 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-rhZMRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:06 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-kgUAnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:06 INFO - Running setup.py install for manifestparser 05:17:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Running setup.py install for mozcrash 05:17:06 INFO - Running setup.py install for mozdebug 05:17:06 INFO - Running setup.py install for mozdevice 05:17:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:06 INFO - Running setup.py install for mozfile 05:17:06 INFO - Running setup.py install for mozhttpd 05:17:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Running setup.py install for mozinfo 05:17:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Running setup.py install for mozInstall 05:17:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Running setup.py install for mozleak 05:17:07 INFO - Running setup.py install for mozlog 05:17:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Running setup.py install for moznetwork 05:17:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Running setup.py install for mozprocess 05:17:07 INFO - Running setup.py install for mozprofile 05:17:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:08 INFO - Running setup.py install for mozrunner 05:17:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:08 INFO - Running setup.py install for mozscreenshot 05:17:08 INFO - Running setup.py install for moztest 05:17:08 INFO - Running setup.py install for mozversion 05:17:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:08 INFO - Cleaning up... 05:17:08 INFO - Return code: 0 05:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:08 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 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:08 INFO - 'HOME': '/Users/cltbld', 05:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:08 INFO - 'LOGNAME': 'cltbld', 05:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:08 INFO - 'MOZ_NO_REMOTE': '1', 05:17:08 INFO - 'NO_EM_RESTART': '1', 05:17:08 INFO - 'PAGER': '/bin/cat', 05:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:08 INFO - 'PWD': '/builds/slave/test', 05:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:08 INFO - 'SHELL': '/bin/bash', 05:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:17:08 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:08 INFO - 'USER': 'cltbld', 05:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:08 INFO - 'XPC_FLAGS': '0x0', 05:17:08 INFO - 'XPC_SERVICE_NAME': '0', 05:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-g3dzx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-IACBmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-MeION3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Ba3ggq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-PoPTix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-rz_C_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-FeUbh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-ksBasc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-IgXcpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-15KHGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:10 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)) 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-r11gdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Bqr8Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-ETUznH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-WzUios-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-jhCEjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-RU1IJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-bsLLSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:13 INFO - Downloading blessings-1.6.tar.gz 05:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:13 INFO - Installing collected packages: blessings 05:17:13 INFO - Running setup.py install for blessings 05:17:13 INFO - Successfully installed blessings 05:17:13 INFO - Cleaning up... 05:17:13 INFO - Return code: 0 05:17:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:13 INFO - Reading from file tmpfile_stdout 05:17:13 INFO - Current package versions: 05:17:13 INFO - blessings == 1.6 05:17:13 INFO - blobuploader == 1.2.4 05:17:13 INFO - docopt == 0.6.1 05:17:13 INFO - functools32 == 3.2.3-2 05:17:13 INFO - jsonschema == 2.5.1 05:17:13 INFO - manifestparser == 1.1 05:17:13 INFO - mozInstall == 1.12 05:17:13 INFO - mozcrash == 0.17 05:17:13 INFO - mozdebug == 0.1 05:17:13 INFO - mozdevice == 0.48 05:17:13 INFO - mozfile == 1.2 05:17:13 INFO - mozhttpd == 0.7 05:17:13 INFO - mozinfo == 0.9 05:17:13 INFO - mozleak == 0.1 05:17:13 INFO - mozlog == 3.4 05:17:13 INFO - moznetwork == 0.27 05:17:13 INFO - mozprocess == 0.23 05:17:13 INFO - mozprofile == 0.28 05:17:13 INFO - mozrunner == 6.12 05:17:13 INFO - mozscreenshot == 0.1 05:17:13 INFO - mozsystemmonitor == 0.3 05:17:13 INFO - moztest == 0.7 05:17:13 INFO - mozversion == 1.4 05:17:13 INFO - psutil == 3.1.1 05:17:13 INFO - requests == 1.2.3 05:17:13 INFO - wsgiref == 0.1.2 05:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:13 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 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:13 INFO - 'HOME': '/Users/cltbld', 05:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:13 INFO - 'LOGNAME': 'cltbld', 05:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:13 INFO - 'MOZ_NO_REMOTE': '1', 05:17:13 INFO - 'NO_EM_RESTART': '1', 05:17:13 INFO - 'PAGER': '/bin/cat', 05:17:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:13 INFO - 'PWD': '/builds/slave/test', 05:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:13 INFO - 'SHELL': '/bin/bash', 05:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:17:13 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:13 INFO - 'USER': 'cltbld', 05:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:13 INFO - 'XPC_FLAGS': '0x0', 05:17:13 INFO - 'XPC_SERVICE_NAME': '0', 05:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:14 INFO - Cleaning up... 05:17:14 INFO - Return code: 0 05:17:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:14 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 0x103c5b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bd1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f822b5767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, '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.CTe2fVYUBv/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.XoF0G6gt55/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:17:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:17:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:14 INFO - 'HOME': '/Users/cltbld', 05:17:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:14 INFO - 'LOGNAME': 'cltbld', 05:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:14 INFO - 'MOZ_NO_REMOTE': '1', 05:17:14 INFO - 'NO_EM_RESTART': '1', 05:17:14 INFO - 'PAGER': '/bin/cat', 05:17:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:14 INFO - 'PWD': '/builds/slave/test', 05:17:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:14 INFO - 'SHELL': '/bin/bash', 05:17:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:17:14 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:17:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:14 INFO - 'USER': 'cltbld', 05:17:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:14 INFO - 'XPC_FLAGS': '0x0', 05:17:14 INFO - 'XPC_SERVICE_NAME': '0', 05:17:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:14 INFO - Cleaning up... 05:17:14 INFO - Return code: 0 05:17:14 INFO - Running post-action listener: _resource_record_post_action 05:17:14 INFO - Running post-action listener: _start_resource_monitoring 05:17:14 INFO - Starting resource monitoring. 05:17:14 INFO - [mozharness: 2016-09-21 12:17:14.480971Z] Finished create-virtualenv step (success) 05:17:14 INFO - [mozharness: 2016-09-21 12:17:14.481959Z] Running install step. 05:17:14 INFO - Running pre-action listener: _resource_record_pre_action 05:17:14 INFO - Running main action method: install 05:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:14 INFO - Reading from file tmpfile_stdout 05:17:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:14 INFO - Reading from file tmpfile_stdout 05:17:14 INFO - Output received: 05:17:14 INFO - Usage: mozinstall [options] installer 05:17:14 INFO - Options: 05:17:14 INFO - -h, --help show this help message and exit 05:17:14 INFO - -d DEST, --destination=DEST 05:17:14 INFO - Directory to install application into. [default: 05:17:14 INFO - "/builds/slave/test"] 05:17:14 INFO - --app=APP Application being installed. [default: firefox] 05:17:14 INFO - mkdir: /builds/slave/test/build/application 05:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:17:48 INFO - Reading from file tmpfile_stdout 05:17:48 INFO - Output received: 05:17:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:17:48 INFO - Running post-action listener: _resource_record_post_action 05:17:48 INFO - [mozharness: 2016-09-21 12:17:48.863277Z] Finished install step (success) 05:17:48 INFO - [mozharness: 2016-09-21 12:17:48.863420Z] Running run-tests step. 05:17:48 INFO - Running pre-action listener: _resource_record_pre_action 05:17:48 INFO - Running main action method: run_tests 05:17:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:48 INFO - 2016-09-21 05:17:48.877 screenresolution[1937:11570] starting screenresolution argv=screenresolution get 05:17:48 INFO - 2016-09-21 05:17:48.880 screenresolution[1937:11570] Display 0: 1600x1200x32@60 05:17:48 INFO - 2016-09-21 05:17:48.886 screenresolution[1938:11572] starting screenresolution argv=screenresolution list 05:17:48 INFO - Available Modes on Display 0 05:17:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:49 INFO - Intel Iris: 05:17:49 INFO - Chipset Model: Intel Iris 05:17:49 INFO - Type: GPU 05:17:49 INFO - Bus: Built-In 05:17:49 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:49 INFO - Vendor: Intel (0x8086) 05:17:49 INFO - Device ID: 0x0a2e 05:17:49 INFO - Revision ID: 0x0009 05:17:49 INFO - Displays: 05:17:49 INFO - Display: 05:17:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:49 INFO - Display Serial Number: 1600x1200 60 05:17:49 INFO - Main Display: Yes 05:17:49 INFO - Mirror: Off 05:17:49 INFO - Online: Yes 05:17:49 INFO - Rotation: Supported 05:17:49 INFO - Return code: 0 05:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:49 INFO - Python 2.7.3 05:17:49 INFO - Return code: 0 05:17:49 INFO - grabbing minidump binary from tooltool 05:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:49 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 0x103a6fd30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a67b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:17:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:17:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:49 INFO - Return code: 0 05:17:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:17:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:17:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:49 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/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0118', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:17:49 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/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0118 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:17:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTe2fVYUBv/Render', 05:17:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:49 INFO - 'HOME': '/Users/cltbld', 05:17:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:49 INFO - 'LOGNAME': 'cltbld', 05:17:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:49 INFO - 'MOZ_NO_REMOTE': '1', 05:17:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:49 INFO - 'NO_EM_RESTART': '1', 05:17:49 INFO - 'PAGER': '/bin/cat', 05:17:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:49 INFO - 'PWD': '/builds/slave/test', 05:17:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:49 INFO - 'SHELL': '/bin/bash', 05:17:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XoF0G6gt55/Listeners', 05:17:49 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:17:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:49 INFO - 'USER': 'cltbld', 05:17:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:49 INFO - 'XPC_FLAGS': '0x0', 05:17:49 INFO - 'XPC_SERVICE_NAME': '0', 05:17:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:49 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/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0118', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:17:49 INFO - mozversion application_buildid: 20160921030508 05:17:49 INFO - mozversion application_changeset: 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 05:17:49 INFO - mozversion application_display_name: Nightly 05:17:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:49 INFO - mozversion application_name: Firefox 05:17:49 INFO - mozversion application_remotingname: firefox 05:17:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:17:49 INFO - mozversion application_vendor: Mozilla 05:17:49 INFO - mozversion application_version: 52.0a1 05:17:49 INFO - mozversion platform_buildid: 20160921030508 05:17:49 INFO - mozversion platform_changeset: 560b2c805bf7bebeb3ceebc495a81b2aa4c0c755 05:17:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:17:49 INFO - mozversion platform_version: 52.0a1 05:17:49 INFO - using testdate: 1474460269 05:17:49 INFO - actual date: 1474460269 05:17:49 INFO - starting webserver on 'localhost:49737' 05:17:49 INFO - SUITE-START | Running 2 tests 05:17:49 INFO - TEST-START | dromaeo_css 05:17:49 INFO - operating with platform_type : mac_ 05:17:49 INFO - Initialising browser for dromaeo_css test... 05:17:49 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmp0PI1Iz/profile http://localhost:49737/getInfo.html) 05:17:51 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 05:17:51 INFO - PROCESS | 1948 | colorDepth:24 05:17:51 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 05:17:51 INFO - PROCESS | 1948 | __metrics 05:17:52 INFO - PROCESS | 1948 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:17:52 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:52 INFO - TEST-INFO | 1948: exit 0 05:17:52 INFO - Browser initialized. 05:17:52 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:52 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmp0PI1Iz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:04 INFO - PROCESS | 1950 | RSS: Main: 235462656 05:18:04 INFO - PROCESS | 1950 | 05:18:56 INFO - PROCESS | 1950 | 1474460336432 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:21:07 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49737/tests/dromaeo/cssquery-ext.html) 05:21:08 INFO - PROCESS | 1950 | RSS: Main: 372711424 05:21:08 INFO - PROCESS | 1950 | 05:24:11 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-ext.html (next: http://localhost:49737/tests/dromaeo/cssquery-jquery.html) 05:24:12 INFO - PROCESS | 1950 | RSS: Main: 373075968 05:24:12 INFO - PROCESS | 1950 | 05:27:14 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49737/tests/dromaeo/cssquery-mootools.html) 05:27:15 INFO - PROCESS | 1950 | RSS: Main: 363786240 05:27:15 INFO - PROCESS | 1950 | 05:30:17 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49737/tests/dromaeo/cssquery-prototype.html) 05:30:18 INFO - PROCESS | 1950 | RSS: Main: 350613504 05:30:18 INFO - PROCESS | 1950 | 05:33:21 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49737/tests/dromaeo/cssquery-yui.html) 05:33:22 INFO - PROCESS | 1950 | RSS: Main: 330862592 05:33:22 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-yui.html (next: http://localhost:49737/tests/dromaeo/cssquery-dojo.html) 05:36:25 INFO - PROCESS | 1950 | RSS: Main: 387964928 05:36:25 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | __start_tp_report 05:36:25 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 05:36:25 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 05:36:25 INFO - PROCESS | 1950 | |i|pagename|runs| 05:36:25 INFO - PROCESS | 1950 | |0;dojo.html;3275.9836200819;3278.967210327896;3296.3901678189536;3312.354090952264;3360.1935535471493;5488.945110548893;5585.022621041317;5615.045442274813;5666.150077488379;5673.829785106448;4767.332573439712;5614.775408983635;5621.128725047614;5643.971780141093;5668;5076.263941728447;5085.771140298677;5109.846704598868;5138.3577052868395;5168.534831865131;5173.663711858736;5239.764210610512;5260.789568417259;5263.236830659552;5322.0952438085615;4154.50145982481;5237.476252374751;5254.369475662907;5264.368275806889;5336.30628018359;5076.213186956028;5136.974315128437;5155.74221288934;5164.406093299281;5169.302144210558;5178.016176926372;5200.92198617021;5213.452587478336;5224.52979231871;5267.47325267474;5710;5714.942850571482;5736.6558006519745;5738.368779434259;5773.855653608652;6071;6105.084237364386;6120.265568131853;6138.235132557274;6158.168647232611;6111.591738512192;6137.018077107686;6142.723577439026;6178.845528861814;6181.227346581677;5748.532900486952;5827.213326200994;5828.358880523139;5831.679257640871;5859.648421094748;6137.508999280047;6213.130161777355;6214.782482613177;6215.471684906744;6240.843978900564;6014.977453832859;6060.33336333003;6072.544559158081;6094.45149936499;6126.203593532812;6162.506999440034;6175.104609831549;6177.4749146323065;6203.131561581382;6297.96851015742;6158.599691020069;6209.285932117774;6229.314775374705;6235.563510554218;6258.74965001404;6114.01954734555;6114.144019837227;6145.324014358417;6230.875382492415;6237.313895471494;4879.951200488021;4885.267209918541;4899.534544218293;4933.605311575066;4973.676711013773;4404.2512772828695;4409.250427427345;4412.911741765147;4430.047539778963;4455.086707225011;5571.637843540157;5699.800506982236;5733.770649173986;5746.770129194785;5785.421457854265;6097.615421629385;6128.869808884179;6162.383761623802;6172.197614310111;6242.375762423721;5703.258576385043;5715.399883012307;5728.341240757366;5738.913916291259;5757.568182386338;5314.602927374739;5327.920081198785;5334.759935802898;5339.252504649352;5341.893162136736;6229.2524897012645;6243.469305109116;6249.656268905072;6284.937150628435;6286.308506064421;6259.123722678738;6292.811215663537;6299.527535434952;6304.464120549621;6305.90541141874;6278.560500764903;6280.371962803683;6284.528660350401;6287.497000239879;6293.181886354744;5903.586748927534;6001.459868611846;6096.950036952638;6136.662483563268;6180.103884936749;6248.968755156195;6252.030935205051;6301.275353334425;6318.304986451579;6320.841978950563;5326.920096198638;5551.306086739158;6129.049997250433;6133.969330153321;6152.630842149485;5887.735051922759;6004.789832355847;6058.363871793575;6138.723757430837;6143.508519318533;5889;6002.489788368038;6007.339192688713;6047.183630210041;6074.36219196978;6114.296855861633;6133.172021777003;6151.6001459904965;6154.015357542772;6158.04550294705;5787.768489260382;5789.884202315846;5832.387599302012;5861.413858614104;5971.373005834324 05:36:25 INFO - PROCESS | 1950 | |1;ext.html;513.4659953648206;521.4681025354139;525.582162181066;533.3919331961564;559.4712996218575;27683.584746228822;39965.60034399655;41190.38214426786;41259.381109283386;43052.138957220835;42544;43001.78499107508;43047.569524304745;43048.78475607625;43098.13803723932;8717;8885.511296878669;9678.806423871518;9886.110250077492;9886.209103271722;12009.639710808646;12354.567590134347;12358.011359091252;12375.814362784566;12390.256584604953;10232.386056836614;12178.330191839445;12275.140740148194;12276.140670153049;12276.5703200388;12173.026157907347;12248.958838498738;12261.570845020426;12266.32535210563;12269.877301226963;11990.460429280616;12065.276083434934;12074.69813254667;12078.818817717742;12079.094067944852;39927.60072399297;40266.194676106315;40295.59704402948;40346.394804077965;40383;3293.8353082346025;3339.549160863301;3355.0605830367535;3372.5278461015478;3414.641462646411;30310.54534181989;30847.383052339053;31081;31100.68899311023;31850.522242166386;3188.952165717516;3210.3418799146352;3246.675332466758;3312.585926759155;3337.199072222649;494671;494969;496023;496296.5185174087;496803;32117.839410802797;33125.503117453256;55444;55783;55816.74382330271;34259.314813704084;34392;34742;34782.30435391278;34815;14562.344694488773;14629.487967921072;14638.853611463963;14674.853251467563;14676.55970320892;11338.43307834605;11529.538818447169;12213;12408;12532.122751407314;7689.231076892378;7723.304902558797;7760.805979850436;7767.456278060482;7776.300132988058;2927;3121.219695076231;3194.377096466213;3248.691374319436;3283.3090958156567;917.7218322756922;945.394947233771;974.9561269742878;985.5269470654126;1125.6172901213627;28004.859975700398;29629.703702963125;29801.956931507295;30513.542296865566;30532.38935221283;1014;1016.6289304403839;1054.6045233037612;1108.1744100645071;1128.983914476961;11165.553377864957;14865.331060102322;14902.733267672369;15276.923615381851;15285.465008724641;526770;626621;627878;628608;631678;50812.23781643205;54744.72627636916;54766;54837.451625484035;54912;1139.9658010259704;1202.2726250618425;1244.6079484962208;1278.3097127551205;1382.1983249715342;28919.855400723703;30235;30515;30738.690929972414;30841.074767757003;47360.52639473699;47957.801054973905;47961;47965.5203447961;48006.27990580214;416815;498412;501709;502485;502611;25079.49841003206;26234.08180713666;27069.593956091067;27126.593101103896;27824.304392390353;46116.30825537687;46249;46531.767341163075;46757;47364.289535657685;37200.81399592985;37244.80614264857;37348.06629834276;38028.809855950545;38696;37455.81272093731;37473.62526374702;38063.61936380601;38749.6125038746;38967.6103238964;37255;37790.811045944596;38053;38135.237295253384;38155.855324340315;29903.55144672788;30797;32232;34088.65911340855;34125;20329.186832526535;22709;24725.258242252763;25205;25387.746122538538 05:36:25 INFO - PROCESS | 1950 | |2;jquery.html;347.54992284990936;364.5079143156738;368.2781747774362;374.95875453700097;398.7448033258713;14842.628934276636;15357.846421535782;16080.276387562559;20474.38576842697;20496.795032049675;19668.01659917002;20215;20803.68794468084;20919;21063;5335.772772262382;5693.402192769751;5928.7628494860155;5945.108233764927;5958.7616495340135;5679.460451257124;5883.8529036774;5938.0499120140785;5955.583109182359;5957.642541447505;5586.41342659021;5690.174924635925;5888.64668119912;5900.262467191601;5907.232059832238;5755.68343741094;5806.622569532967;5814.127880817869;5814.4766970972605;5823.475887170132;4460.665450091256;5021.5480606745205;5080.568151707109;5081.822136225214;5089.796408143669;25432.74567254341;25570.74429255702;25703.61444578333;25725.35686607831;25812.709364531886;2207.812335951446;2211.701420308254;2272.136588096529;2357.1514254868234;2852.543593025106;15058.397664093423;15302.540923772305;15379.692406151815;15490.9225453872;15740.60648483797;1795.703708888032;1873.1945263536675;1874.9220445530916;1879.586490971984;1896.4879482539775;122332;125427.3728631351;128826.06760898593;129284;131266.343668282;10093.545790439448;10263.538140783683;10740.409277489813;10794.222022292135;10962.671119866416;11170.832437513443;13478.460861565623;13486.865131348757;13489.865101349058;13492;8311.625976831057;8598.355123365773;8627.870581941275;8774.210321071134;8816;8832.470051796912;8842.115788421235;8870.955645221862;9032.503212323385;9073.500957447272;6320.925442674757;6428.1679721279215;6443.7744678936015;6457.515686323544;6582.736690532325;1399.3982587487478;1481.2889812889873;1562.6327812963943;1743.9564010899576;1857.1735577668078;763.6181909045478;769.2499563493097;950.496236994394;986;988.2439933450916;16485.34058637665;17269.827301727073;21496.89251553732;22324.553508930054;22402;808.8827120067557;919.246218101164;978.6250318302796;982.7936133411921;983.9655612053543;11060.723481913017;11649.359285239394;11969.222000569935;12048.879511204776;12306.261624302571;261981;262081;262213;263502;611695.5965284194;140051;146419;147280.2635986813;148704;150092.99070092905;954.0745476887408;958.4297343080856;994.855745916838;1001.0290018681867;1003.1022235099691;14605.926970365505;15687.764683529527;18067.90966045214;19528.8047119527;19561;37901.24197516089;56009.71995139998;57253;57653;60365;79665.60167199127;80010;80239.59880200561;80360.59819700864;80889.59555202187;6756.797296081126;7817.37461003107;8094.271515563628;8122.5126492410645;8146.959265203636;10599.841002384816;10816.783664326513;12778.361081945679;13162.736745265232;13282.468701251843;10162.695119146438;10946.781064378827;11064.723381915517;11530.82703759461;11627.6511704649;9955.153811926068;10105.141063009727;10458.96689959903;10980.505877235704;11400.657980260605;11213.887861121284;11374.658760237206;11453.396524486412;11514.36670983104;11634.70913227176;8006.479578827358;8030.8393832121865;8062.516249025077;8102.87845682327;8135;9054.909450905407;9839.458829764431;10976.464099927052;10993.835092473779;11092 05:36:25 INFO - PROCESS | 1950 | |3;mootools.html;1510.1995942150656;1548.9767653485198;1752.369147107042;1829.5243236758438;1942.3201879342223;8365.874511882319;8892.288616910648;8894.288456923447;8903.243224325925;8915.509646969414;7762.689492420296;8054.355651547862;8066.475679080856;8158.265756081952;8164.346852251821;2064.3497298351044;2163.610550100981;2343.250159948817;2410.734819169899;2423.903043878243;2389.95220095598;2406.4585468269674;2424.7754883783664;2428.4778772563895;2432.5134973005383;1928.7203355513443;2134.5944270588616;2211.8230541556636;2251.4371407148215;2344.2732752846587;2354.5526349993447;2425.0784701813373;2428.101602407103;2440.73151953285;2441.218809980789;2378.1676413255395;2388.116396933146;2397.700287464067;2417.9637305440433;2419.830611857171;8799.648014079428;8883.42257753244;8921.15249051339;8959.820803583892;8978.057303983052;5255.290535777659;5415;5417.972910135463;5419.647722898038;5443.727813609304;3446.60364058134;3577.6422357764277;3585.3904836177912;3640.199156185661;3641.3809652359164;1059.3908502610952;1108.9112870970384;1111.7943180511631;1117.9217454778168;1122.1023181454884;11656.941715291454;11657.76684466306;11720.120990925629;11720.29678219301;11738.882611173864;4620.653450991189;4625.421822272216;4757.35775670287;4829.879253018632;4830.009847981156;8637.309015278763;9851.852222216672;10063.849042264372;10074.848877266846;10083.445410502347;5363.19552067193;5365.356157261153;5366.141417373202;5367.35591728995;5371.731413429391;4844.15227335215;4844.781984810692;4886.53577910098;4920.75396230187;4942.604591632661;3861.691064714816;3926.1362500249897;3962.722609417313;3997.6002399760373;4042.717009809285;1314.0341848741168;1316.0655934286763;1318.156379916854;1331.4141777617817;1334.833145856768;795.2127393880132;886.4504007515382;912.6988093928987;927.5594092805998;941.223490620241;5776.68228247442;5819.563532734977;5915.64506129625;6086.147939288503;6163.506919446433;447.6307046686497;947.1286416496839;957.4638202606424;984.5963155106372;1075.881653018183;3864.6908247340707;3880.4955355803563;3892.2020985697864;3960.6039396060164;4001.339778936443;10440.843387349196;10869.011021969021;10879.456027198608;10886.782264354668;10886.945565272123;10829.458527073615;10830.296030757976;10840.295380800222;10850.620228291971;10854.620088296871;7679.808004799813;8059.959700201462;8062.959685201537;8162.918370816335;8298.717852590586;5878.3239927408895;5902.350741418526;6040.395960403925;6079.513638908965;6131.386861313833;9849.60601575929;10081.89918100839;10111.03945125212;10122.038406351385;10132.138768204784;9652.855207171757;10013.349132306377;10109;10213.897861021294;10252;7435.591042492715;7593.430492712958;7618.847623047397;7621.275978782007;7623.009008828817;8093.3929955252415;8209.09699932995;8293.129221431664;8299.087100418828;8299.834003319778;7300.634968251672;7441.739539116322;7472.626368681435;7503.699852006077;7515.549067055994;5700.971495142498;6483.4164925156965;7170.928290717026;7257.0565826442225;7365.631718413951;5948.226730525004;6852.451803855779;6984.301569842975;6995.321122930358;7007.229204787572;4871.90256194867;4983.426905905867;5000.774965126505;5033.798648054037;5076.060928728197;4330.7401555906745;4654.418197725285;4712.952870471251;4881.8535443936735;5176.9741151294 05:36:25 INFO - PROCESS | 1950 | |4;prototype.html;277.73476330104745;285.5630884746339;297.949348610736;309.1914643208011;311.5902588096653;4476.529964353741;4661.44062712475;5129.435762066174;5264.473552644734;5321.175217841241;5212.577612647438;5276.577873770098;5321.228421878825;5373.892522149555;5400.432954539766;4091.4272001919753;4098.323776576861;4105.651019663333;4142.5857414258635;4147.460830092084;3859.286032084073;4014.7390419622775;4039.0710136668586;4057.6753859691303;4103.958960410402;3388.390089783838;3818.522684664417;3996.220736956295;4090.9386359204486;4094.7133700640966;3649.503703481573;4041.4544036554985;4044.696647751401;4047.433359329696;4061.614146656063;3463.584369875631;3544.556930383702;3575.9808454590575;3586.28274345132;3613.7109031277437;4239.618434340924;5052.494750524955;5095.79616815327;5137.046198435914;5165.926273867043;3885.708571857122;4655.930161047587;4690.226112691402;4691.859244222679;4693.7653117344;4676.462206846222;5296.119877443491;5611.551075913917;5639.4642508962;5676.829695109153;3822.9044273893096;3829.965909204527;3853.477876238898;3858.575556688762;3872.6320999505;5940.6435613863305;5942.554308426886;5946.70266486674;5971.5222782177325;5973.253343332083;3901.54202852207;3920.549136849299;3930.7964009332304;3931.6461518463475;3949.5260568731937;3325.567676202078;3676.356637588411;3951.5455722591696;3953.940690889581;3990.6009399060445;4343.913121737548;4495.280755079171;4515.909681806345;4520.977395113004;4549.363089167519;4810.182269014276;5004.749762511859;5270.576944225115;5614.810224012638;5786.42135786418;1326.7678156322604;1356.5387768158873;1356.5387768158873;1357.3416892806981;1359.0622470495327;715.9176694680074;801.7594721583619;821.5399376349263;822.8765685147276;834.5743670727973;3888.2806680764147;4334.981279399339;4407.382966384709;4482.663800214997;4535.206338890747;4053.3919912013434;4146.709730318848;4310.978445107754;4793.856184314476;4827.62066553414;4227.894302642397;4355.455568053993;4385.780710964439;4422.248217802917;4449.755263460476;2364.3498038039675;2478.5662509060844;2556.539822831908;2565.320190149612;2571.318600570813;4443.800028998703;4560.973780899271;4607.746573938465;4683.063387322549;5057.342545469065;4366.820958341294;4393.83563355711;4513.796879140446;4740.4311482621615;4859.052484765437;5484.506394424521;6032.577719559588;6042.546808989256;6056.939430605637;6061.212042434456;4928.137575924127;5784;5804.912926306193;5870.324912635102;5879.970600147143;4332.6317263033;5456;5677.8864422710485;5787.771707892408;5820.650760954356;4752.952470475251;5100.566451851634;5995.6702381367695;6038.84902877414;6062.211912451353;3278.065751260879;3391.6947474727394;3852.287326844543;3926.3325234709596;3936.8228429720157;4768.546988036131;5522.889542209214;5599.776008959759;5776.56675749312;5923.881522369615;5519.613627046068;5555;5585.385607583244;5669.319681638065;5682.431756824284;4697.483276839476;5109.131447653982;5165.251038599457;5501.944980550144;5641.520470759867;5277.656952298242;5532.114861622121;5587.664740115606;5587.8882422352135;5593.657522194725;5623.437656234344;5639.407862174413;5645.322561292507;5660.85847853807;5674.546036317167;4450.532694067077;4622.260438329851;4876.341693871282;5445.44064289799;5576.637518561281 05:36:25 INFO - PROCESS | 1950 | |5;yui.html;718.4073139659782;762.8588711088449;785.1638005524117;827.1893544326564;827.3587969323773;12870.356482175901;12902.741945161091;12941.094123411365;12951.093423460361;12955.417006234718;14381.280935953213;14540.491082812103;14559.708805823877;14567.053141545792;14586.343614537345;678.9388954994049;698.5633978763273;844.7972486603232;852.4459101583989;873.0919843362894;833.3458235285271;840.6721378662327;844.341413697314;844.7803571071504;846.551327796269;906.1618003346911;909.8089401225717;909.8362294786936;912.1106920752246;912.4662072687453;902.7111324376202;902.9774255643629;903.0337538833451;903.3495882964255;903.9954800226022;536.6511767351213;557.1114073053513;663.151166506872;682.1132527713952;688.2910602079866;14025.579232623038;14044.297785110806;14093.718125637532;14107.717845643132;14156.504522341771;13640.522581709693;14080.225587592678;14193.219372934485;14229.928850355785;14276.85723142776;12533.918595371091;12793.87206127936;12823.487060517567;12835.101542892002;13228.338583070905;4544.818207271705;4584.518625544303;4588.220002599533;4649.86050418488;4792.7124372537755;89179;104472.47763761209;105365.47317263365;116039.91481107402;116836.65306775438;11013.339199648046;11015.504302306415;11076.889231107747;11196.104311655048;11399.202055856176;22447;22488.32535023952;22492;22493.32520024402;22539.32382028542;7681.308682218627;7766.301032906952;7796.259355361345;7817.944577482081;7964.2433968772875;4306.935395969063;4317.07182955666;4378.5183629800695;4384.4519435070615;4490.438695163105;2967.9554806677916;3446.7931924084637;3580.373434648926;3580.6419358063986;3581.1047238190454;652.2824892618082;660.4182981758661;664.880321542127;684.9554778939353;685.7188552693472;603.5402426014458;617.1421723803916;620.3114542857425;621.6860485454816;633.5216911232083;8658.523781191969;8883.955580222058;8993.460392376479;9046.276297896153;9062.954685226532;576.2710171632888;577.4369989260438;588.4733163818444;591.2432086928738;604.782278379783;3449.87925422609;4237.343211802176;4380.698576198087;4468.352088947149;4518.548145185455;96884.06231875464;136591.26817463594;139752;159224;160650;108119.91880081256;136606.63393365938;140192.29903850416;140479.4880128005;143435.2221255682;76599.23400765921;102307;105053;113093.34533273468;117249;6832.863342733217;8541.615627296911;8552.786180345542;8597.613107410307;8686;59921.10118348141;65296;65936.67031664812;66883;67070.66464667645;99748;100240.48917798862;100997;101160.49419753149;101873.49063254637;9518.857217141887;10947.850475699937;11374.601888933848;11489.195756296978;11988.280703157838;10722.946385268024;12007;12190.024798016315;12225.266484010988;12291.139620226499;9854.704358869245;10451.163906887583;11733.589324373606;11825.408729563316;11996.220245684002;12869.51150255554;13362.265075420944;13417.194968301934;13734.725305493634;13738.587842364745;12184.756304873676;13477.528286509925;13675.589732308046;13705.588832334646;13922.09506382082;8473.618687158969;10943.233973621771;11394.974452299333;11521.135914806255;11664.708382290512;10606.098481629147;11309.737335086787;11369.886301136883;11581.478833452684;11606.187566870238 05:36:25 INFO - PROCESS | 1950 | __end_tp_report 05:36:25 INFO - PROCESS | 1950 | __start_cc_report 05:36:25 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,1213 05:36:25 INFO - PROCESS | 1950 | __end_cc_report 05:36:25 INFO - PROCESS | 1950 | __startTimestamp1474461385814__endTimestamp 05:36:25 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | ------- Summary: start ------- 05:36:25 INFO - PROCESS | 1950 | Number of tests: 6 05:36:25 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | [#0] dojo.html Cycles:165 Average:5702.79 Median:5889.00 stddev:650.70 (11.0%) stddev-sans-first:624.22 05:36:25 INFO - PROCESS | 1950 | Values: 3276.0 3279.0 3296.4 3312.4 3360.2 5488.9 5585.0 5615.0 5666.2 5673.8 4767.3 5614.8 5621.1 5644.0 5668.0 5076.3 5085.8 5109.8 5138.4 5168.5 5173.7 5239.8 5260.8 5263.2 5322.1 4154.5 5237.5 5254.4 5264.4 5336.3 5076.2 5137.0 5155.7 5164.4 5169.3 5178.0 5200.9 5213.5 5224.5 5267.5 5710.0 5714.9 5736.7 5738.4 5773.9 6071.0 6105.1 6120.3 6138.2 6158.2 6111.6 6137.0 6142.7 6178.8 6181.2 5748.5 5827.2 5828.4 5831.7 5859.6 6137.5 6213.1 6214.8 6215.5 6240.8 6015.0 6060.3 6072.5 6094.5 6126.2 6162.5 6175.1 6177.5 6203.1 6298.0 6158.6 6209.3 6229.3 6235.6 6258.7 6114.0 6114.1 6145.3 6230.9 6237.3 4880.0 4885.3 4899.5 4933.6 4973.7 4404.3 4409.3 4412.9 4430.0 4455.1 5571.6 5699.8 5733.8 5746.8 5785.4 6097.6 6128.9 6162.4 6172.2 6242.4 5703.3 5715.4 5728.3 5738.9 5757.6 5314.6 5327.9 5334.8 5339.3 5341.9 6229.3 6243.5 6249.7 6284.9 6286.3 6259.1 6292.8 6299.5 6304.5 6305.9 6278.6 6280.4 6284.5 6287.5 6293.2 5903.6 6001.5 6097.0 6136.7 6180.1 6249.0 6252.0 6301.3 6318.3 6320.8 5326.9 5551.3 6129.0 6134.0 6152.6 5887.7 6004.8 6058.4 6138.7 6143.5 5889.0 6002.5 6007.3 6047.2 6074.4 6114.3 6133.2 6151.6 6154.0 6158.0 5787.8 5789.9 5832.4 5861.4 5971.4 05:36:25 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | [#1] ext.html Cycles:180 Average:65201.00 Median:18730.59 stddev:142485.13 (760.7%) stddev-sans-first:142802.06 05:36:25 INFO - PROCESS | 1950 | Values: 513.5 521.5 525.6 533.4 559.5 27683.6 39965.6 41190.4 41259.4 43052.1 42544.0 43001.8 43047.6 43048.8 43098.1 8717.0 8885.5 9678.8 9886.1 9886.2 12009.6 12354.6 12358.0 12375.8 12390.3 10232.4 12178.3 12275.1 12276.1 12276.6 12173.0 12249.0 12261.6 12266.3 12269.9 11990.5 12065.3 12074.7 12078.8 12079.1 39927.6 40266.2 40295.6 40346.4 40383.0 3293.8 3339.5 3355.1 3372.5 3414.6 30310.5 30847.4 31081.0 31100.7 31850.5 3189.0 3210.3 3246.7 3312.6 3337.2 494671.0 494969.0 496023.0 496296.5 496803.0 32117.8 33125.5 55444.0 55783.0 55816.7 34259.3 34392.0 34742.0 34782.3 34815.0 14562.3 14629.5 14638.9 14674.9 14676.6 11338.4 11529.5 12213.0 12408.0 12532.1 7689.2 7723.3 7760.8 7767.5 7776.3 2927.0 3121.2 3194.4 3248.7 3283.3 917.7 945.4 975.0 985.5 1125.6 28004.9 29629.7 29802.0 30513.5 30532.4 1014.0 1016.6 1054.6 1108.2 1129.0 11165.6 14865.3 14902.7 15276.9 15285.5 526770.0 626621.0 627878.0 628608.0 631678.0 50812.2 54744.7 54766.0 54837.5 54912.0 1140.0 1202.3 1244.6 1278.3 1382.2 28919.9 30235.0 30515.0 30738.7 30841.1 47360.5 47957.8 47961.0 47965.5 48006.3 416815.0 498412.0 501709.0 502485.0 502611.0 25079.5 26234.1 27069.6 27126.6 27824.3 46116.3 46249.0 46531.8 46757.0 47364.3 37200.8 37244.8 37348.1 38028.8 38696.0 37455.8 37473.6 38063.6 38749.6 38967.6 37255.0 37790.8 38053.0 38135.2 38155.9 29903.6 30797.0 32232.0 34088.7 34125.0 20329.2 22709.0 24725.3 25205.0 25387.7 05:36:25 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | [#2] jquery.html Cycles:180 Average:28469.71 Median:25714.49 stddev:65110.24 (253.2%) stddev-sans-first:65258.66 05:36:25 INFO - PROCESS | 1950 | Values: 347.5 364.5 368.3 375.0 398.7 14842.6 15357.8 16080.3 20474.4 20496.8 19668.0 20215.0 20803.7 20919.0 21063.0 5335.8 5693.4 5928.8 5945.1 5958.8 5679.5 5883.9 5938.0 5955.6 5957.6 5586.4 5690.2 5888.6 5900.3 5907.2 5755.7 5806.6 5814.1 5814.5 5823.5 4460.7 5021.5 5080.6 5081.8 5089.8 25432.7 25570.7 25703.6 25725.4 25812.7 2207.8 2211.7 2272.1 2357.2 2852.5 15058.4 15302.5 15379.7 15490.9 15740.6 1795.7 1873.2 1874.9 1879.6 1896.5 122332.0 125427.4 128826.1 129284.0 131266.3 10093.5 10263.5 10740.4 10794.2 10962.7 11170.8 13478.5 13486.9 13489.9 13492.0 8311.6 8598.4 8627.9 8774.2 8816.0 8832.5 8842.1 8871.0 9032.5 9073.5 6320.9 6428.2 6443.8 6457.5 6582.7 1399.4 1481.3 1562.6 1744.0 1857.2 763.6 769.2 950.5 986.0 988.2 16485.3 17269.8 21496.9 22324.6 22402.0 808.9 919.2 978.6 982.8 984.0 11060.7 11649.4 11969.2 12048.9 12306.3 261981.0 262081.0 262213.0 263502.0 611695.6 140051.0 146419.0 147280.3 148704.0 150093.0 954.1 958.4 994.9 1001.0 1003.1 14605.9 15687.8 18067.9 19528.8 19561.0 37901.2 56009.7 57253.0 57653.0 60365.0 79665.6 80010.0 80239.6 80360.6 80889.6 6756.8 7817.4 8094.3 8122.5 8147.0 10599.8 10816.8 12778.4 13162.7 13282.5 10162.7 10946.8 11064.7 11530.8 11627.7 9955.2 10105.1 10459.0 10980.5 11400.7 11213.9 11374.7 11453.4 11514.4 11634.7 8006.5 8030.8 8062.5 8102.9 8135.0 9054.9 9839.5 10976.5 10993.8 11092.0 05:36:25 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | [#3] mootools.html Cycles:180 Average:5692.84 Median:4837.08 stddev:3185.51 (65.9%) stddev-sans-first:3178.94 05:36:25 INFO - PROCESS | 1950 | Values: 1510.2 1549.0 1752.4 1829.5 1942.3 8365.9 8892.3 8894.3 8903.2 8915.5 7762.7 8054.4 8066.5 8158.3 8164.3 2064.3 2163.6 2343.3 2410.7 2423.9 2390.0 2406.5 2424.8 2428.5 2432.5 1928.7 2134.6 2211.8 2251.4 2344.3 2354.6 2425.1 2428.1 2440.7 2441.2 2378.2 2388.1 2397.7 2418.0 2419.8 8799.6 8883.4 8921.2 8959.8 8978.1 5255.3 5415.0 5418.0 5419.6 5443.7 3446.6 3577.6 3585.4 3640.2 3641.4 1059.4 1108.9 1111.8 1117.9 1122.1 11656.9 11657.8 11720.1 11720.3 11738.9 4620.7 4625.4 4757.4 4829.9 4830.0 8637.3 9851.9 10063.8 10074.8 10083.4 5363.2 5365.4 5366.1 5367.4 5371.7 4844.2 4844.8 4886.5 4920.8 4942.6 3861.7 3926.1 3962.7 3997.6 4042.7 1314.0 1316.1 1318.2 1331.4 1334.8 795.2 886.5 912.7 927.6 941.2 5776.7 5819.6 5915.6 6086.1 6163.5 447.6 947.1 957.5 984.6 1075.9 3864.7 3880.5 3892.2 3960.6 4001.3 10440.8 10869.0 10879.5 10886.8 10886.9 10829.5 10830.3 10840.3 10850.6 10854.6 7679.8 8060.0 8063.0 8162.9 8298.7 5878.3 5902.4 6040.4 6079.5 6131.4 9849.6 10081.9 10111.0 10122.0 10132.1 9652.9 10013.3 10109.0 10213.9 10252.0 7435.6 7593.4 7618.8 7621.3 7623.0 8093.4 8209.1 8293.1 8299.1 8299.8 7300.6 7441.7 7472.6 7503.7 7515.5 5701.0 6483.4 7170.9 7257.1 7365.6 5948.2 6852.5 6984.3 6995.3 7007.2 4871.9 4983.4 5000.8 5033.8 5076.1 4330.7 4654.4 4713.0 4881.9 5177.0 05:36:25 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | [#4] prototype.html Cycles:180 Average:4390.38 Median:4658.69 stddev:1364.01 (29.3%) stddev-sans-first:1332.45 05:36:25 INFO - PROCESS | 1950 | Values: 277.7 285.6 297.9 309.2 311.6 4476.5 4661.4 5129.4 5264.5 5321.2 5212.6 5276.6 5321.2 5373.9 5400.4 4091.4 4098.3 4105.7 4142.6 4147.5 3859.3 4014.7 4039.1 4057.7 4104.0 3388.4 3818.5 3996.2 4090.9 4094.7 3649.5 4041.5 4044.7 4047.4 4061.6 3463.6 3544.6 3576.0 3586.3 3613.7 4239.6 5052.5 5095.8 5137.0 5165.9 3885.7 4655.9 4690.2 4691.9 4693.8 4676.5 5296.1 5611.6 5639.5 5676.8 3822.9 3830.0 3853.5 3858.6 3872.6 5940.6 5942.6 5946.7 5971.5 5973.3 3901.5 3920.5 3930.8 3931.6 3949.5 3325.6 3676.4 3951.5 3953.9 3990.6 4343.9 4495.3 4515.9 4521.0 4549.4 4810.2 5004.7 5270.6 5614.8 5786.4 1326.8 1356.5 1356.5 1357.3 1359.1 715.9 801.8 821.5 822.9 834.6 3888.3 4335.0 4407.4 4482.7 4535.2 4053.4 4146.7 4311.0 4793.9 4827.6 4227.9 4355.5 4385.8 4422.2 4449.8 2364.3 2478.6 2556.5 2565.3 2571.3 4443.8 4561.0 4607.7 4683.1 5057.3 4366.8 4393.8 4513.8 4740.4 4859.1 5484.5 6032.6 6042.5 6056.9 6061.2 4928.1 5784.0 5804.9 5870.3 5880.0 4332.6 5456.0 5677.9 5787.8 5820.7 4753.0 5100.6 5995.7 6038.8 6062.2 3278.1 3391.7 3852.3 3926.3 3936.8 4768.5 5522.9 5599.8 5776.6 5923.9 5519.6 5555.0 5585.4 5669.3 5682.4 4697.5 5109.1 5165.3 5501.9 5641.5 5277.7 5532.1 5587.7 5587.9 5593.7 5623.4 5639.4 5645.3 5660.9 5674.5 4450.5 4622.3 4876.3 5445.4 5576.6 05:36:25 INFO - PROCESS | 1950 | 05:36:25 INFO - PROCESS | 1950 | [#5] yui.html Cycles:180 Average:24470.55 Median:3515.13 stddev:39443.95 (1122.1%) stddev-sans-first:39514.29 05:36:25 INFO - PROCESS | 1950 | Values: 718.4 762.9 785.2 827.2 827.4 12870.4 12902.7 12941.1 12951.1 12955.4 14381.3 14540.5 14559.7 14567.1 14586.3 678.9 698.6 844.8 852.4 873.1 833.3 840.7 844.3 844.8 846.6 906.2 909.8 909.8 912.1 912.5 902.7 903.0 903.0 903.3 904.0 536.7 557.1 663.2 682.1 688.3 14025.6 14044.3 14093.7 14107.7 14156.5 13640.5 14080.2 14193.2 14229.9 14276.9 12533.9 12793.9 12823.5 12835.1 13228.3 4544.8 4584.5 4588.2 4649.9 4792.7 89179.0 104472.5 105365.5 116039.9 116836.7 11013.3 11015.5 11076.9 11196.1 11399.2 22447.0 22488.3 22492.0 22493.3 22539.3 7681.3 7766.3 7796.3 7817.9 7964.2 4306.9 4317.1 4378.5 4384.5 4490.4 2968.0 3446.8 3580.4 3580.6 3581.1 652.3 660.4 664.9 685.0 685.7 603.5 617.1 620.3 621.7 633.5 8658.5 8884.0 8993.5 9046.3 9063.0 576.3 577.4 588.5 591.2 604.8 3449.9 4237.3 4380.7 4468.4 4518.5 96884.1 136591.3 139752.0 159224.0 160650.0 108119.9 136606.6 140192.3 140479.5 143435.2 76599.2 102307.0 105053.0 113093.3 117249.0 6832.9 8541.6 8552.8 8597.6 8686.0 59921.1 65296.0 65936.7 66883.0 67070.7 99748.0 100240.5 100997.0 101160.5 101873.5 9518.9 10947.9 11374.6 11489.2 11988.3 10722.9 12007.0 12190.0 12225.3 12291.1 9854.7 10451.2 11733.6 11825.4 11996.2 12869.5 13362.3 13417.2 13734.7 13738.6 12184.8 13477.5 13675.6 13705.6 13922.1 8473.6 10943.2 11395.0 11521.1 11664.7 10606.1 11309.7 11369.9 11581.5 11606.2 05:36:25 INFO - PROCESS | 1950 | -------- Summary: end -------- 05:36:25 INFO - PROCESS | 1950 | 05:36:26 INFO - TEST-INFO | 1950: exit 0 05:36:26 INFO - TEST-OK | dromaeo_css | took 1117120ms 05:36:26 INFO - TEST-START | kraken 05:36:26 INFO - operating with platform_type : mac_ 05:36:26 INFO - Initialising browser for kraken test... 05:36:26 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmp1wKM69/profile http://localhost:49737/getInfo.html) 05:36:28 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 05:36:28 INFO - PROCESS | 1955 | colorDepth:24 05:36:28 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 05:36:28 INFO - PROCESS | 1955 | __metrics 05:36:29 INFO - PROCESS | 1955 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:36:29 INFO - PROCESS | 1955 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:29 INFO - TEST-INFO | 1955: exit 0 05:36:29 INFO - Browser initialized. 05:36:29 INFO - Running cycle 1/1 for kraken test... 05:36:29 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmp1wKM69/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:41 INFO - PROCESS | 1956 | RSS: Main: 235155456 05:36:41 INFO - PROCESS | 1956 | 05:36:44 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:45 INFO - PROCESS | 1956 | RSS: Main: 293605376 05:36:45 INFO - PROCESS | 1956 | 05:36:47 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-dft) 05:36:48 INFO - PROCESS | 1956 | RSS: Main: 292417536 05:36:48 INFO - PROCESS | 1956 | 05:36:52 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-fft) 05:36:52 INFO - PROCESS | 1956 | RSS: Main: 382324736 05:36:52 INFO - PROCESS | 1956 | 05:36:54 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-oscillator) 05:36:55 INFO - PROCESS | 1956 | RSS: Main: 285089792 05:36:55 INFO - PROCESS | 1956 | 05:36:57 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:58 INFO - PROCESS | 1956 | RSS: Main: 290529280 05:36:58 INFO - PROCESS | 1956 | 05:37:00 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:01 INFO - PROCESS | 1956 | RSS: Main: 329281536 05:37:01 INFO - PROCESS | 1956 | 05:37:04 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:04 INFO - PROCESS | 1956 | RSS: Main: 328867840 05:37:04 INFO - PROCESS | 1956 | 05:37:07 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49737/tests/kraken/driver.html?testName=json-parse-financial) 05:37:08 INFO - PROCESS | 1956 | RSS: Main: 330358784 05:37:08 INFO - PROCESS | 1956 | 05:37:09 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:10 INFO - PROCESS | 1956 | RSS: Main: 299978752 05:37:10 INFO - PROCESS | 1956 | 05:37:12 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:13 INFO - PROCESS | 1956 | RSS: Main: 303452160 05:37:13 INFO - PROCESS | 1956 | 05:37:15 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:16 INFO - PROCESS | 1956 | RSS: Main: 301879296 05:37:16 INFO - PROCESS | 1956 | 05:37:18 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:19 INFO - PROCESS | 1956 | RSS: Main: 320675840 05:37:19 INFO - PROCESS | 1956 | 05:37:22 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:23 INFO - PROCESS | 1956 | RSS: Main: 316715008 05:37:23 INFO - PROCESS | 1956 | 05:37:24 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49737/tests/kraken/driver.html?testName=ai-astar) 05:37:25 INFO - PROCESS | 1956 | RSS: Main: 360185856 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | __start_tp_report 05:37:25 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 05:37:25 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 05:37:25 INFO - PROCESS | 1956 | |i|pagename|runs| 05:37:25 INFO - PROCESS | 1956 | |0;ai-astar;113;113;113;112;112;113;112;112;112;114 05:37:25 INFO - PROCESS | 1956 | |1;audio-beat-detection;168;140;115;145;110;108;109;108;137;107 05:37:25 INFO - PROCESS | 1956 | |2;audio-dft;183;183;184;184;187;186;184;188;161;260 05:37:25 INFO - PROCESS | 1956 | |3;audio-fft;82;49;73;112;86;83;62;58;81;57 05:37:25 INFO - PROCESS | 1956 | |4;audio-oscillator;86;71;93;70;68;69;92;67;69;88 05:37:25 INFO - PROCESS | 1956 | |5;imaging-gaussian-blur;87;85;88;85;87;83;88;85;91;84 05:37:25 INFO - PROCESS | 1956 | |6;imaging-darkroom;93;93;93;93;93;93;93;93;93;97 05:37:25 INFO - PROCESS | 1956 | |7;imaging-desaturate;87;99;125;135;125;83;87;84;85;85 05:37:25 INFO - PROCESS | 1956 | |8;json-parse-financial;58;54;54;52;54;57;56;56;54;55 05:37:25 INFO - PROCESS | 1956 | |9;json-stringify-tinderbox;74;65;70;77;73;70;71;73;72;72 05:37:25 INFO - PROCESS | 1956 | |10;stanford-crypto-aes;86;90;85;88;97;93;103;107;85;84 05:37:25 INFO - PROCESS | 1956 | |11;stanford-crypto-ccm;141;140;136;139;140;138;140;129;190;150 05:37:25 INFO - PROCESS | 1956 | |12;stanford-crypto-pbkdf2;169;169;169;168;164;165;168;168;167;170 05:37:25 INFO - PROCESS | 1956 | |13;stanford-crypto-sha256-iterative;68;66;69;77;84;87;87;76;66;66 05:37:25 INFO - PROCESS | 1956 | __end_tp_report 05:37:25 INFO - PROCESS | 1956 | __start_cc_report 05:37:25 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,1935 05:37:25 INFO - PROCESS | 1956 | __end_cc_report 05:37:25 INFO - PROCESS | 1956 | __startTimestamp1474461445110__endTimestamp 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | ------- Summary: start ------- 05:37:25 INFO - PROCESS | 1956 | Number of tests: 14 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:37:25 INFO - PROCESS | 1956 | Values: 113.0 113.0 113.0 112.0 112.0 113.0 112.0 112.0 112.0 114.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:126.00 stddev:21.34 (16.9%) stddev-sans-first:15.88 05:37:25 INFO - PROCESS | 1956 | Values: 168.0 140.0 115.0 145.0 110.0 108.0 109.0 108.0 137.0 107.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#2] audio-dft Cycles:10 Average:190.00 Median:185.00 stddev:25.77 (13.9%) stddev-sans-first:27.21 05:37:25 INFO - PROCESS | 1956 | Values: 183.0 183.0 184.0 184.0 187.0 186.0 184.0 188.0 161.0 260.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#3] audio-fft Cycles:10 Average:74.30 Median:77.00 stddev:18.55 (24.1%) stddev-sans-first:19.46 05:37:25 INFO - PROCESS | 1956 | Values: 82.0 49.0 73.0 112.0 86.0 83.0 62.0 58.0 81.0 57.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.50 stddev:10.93 (13.9%) stddev-sans-first:11.14 05:37:25 INFO - PROCESS | 1956 | Values: 86.0 71.0 93.0 70.0 68.0 69.0 92.0 67.0 69.0 88.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:2.36 (2.7%) stddev-sans-first:2.49 05:37:25 INFO - PROCESS | 1956 | Values: 87.0 85.0 88.0 85.0 87.0 83.0 88.0 85.0 91.0 84.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:1.26 (1.4%) stddev-sans-first:1.33 05:37:25 INFO - PROCESS | 1956 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 97.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#7] imaging-desaturate Cycles:10 Average:99.50 Median:85.00 stddev:20.57 (24.2%) stddev-sans-first:21.31 05:37:25 INFO - PROCESS | 1956 | Values: 87.0 99.0 125.0 135.0 125.0 83.0 87.0 84.0 85.0 85.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.76 (3.2%) stddev-sans-first:1.50 05:37:25 INFO - PROCESS | 1956 | Values: 58.0 54.0 54.0 52.0 54.0 57.0 56.0 56.0 54.0 55.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:3.13 (4.3%) stddev-sans-first:3.21 05:37:25 INFO - PROCESS | 1956 | Values: 74.0 65.0 70.0 77.0 73.0 70.0 71.0 73.0 72.0 72.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:87.00 stddev:8.09 (9.3%) stddev-sans-first:8.31 05:37:25 INFO - PROCESS | 1956 | Values: 86.0 90.0 85.0 88.0 97.0 93.0 103.0 107.0 85.0 84.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:140.00 stddev:16.86 (12.0%) stddev-sans-first:17.84 05:37:25 INFO - PROCESS | 1956 | Values: 141.0 140.0 136.0 139.0 140.0 138.0 140.0 129.0 190.0 150.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.50 stddev:1.89 (1.1%) stddev-sans-first:1.94 05:37:25 INFO - PROCESS | 1956 | Values: 169.0 169.0 169.0 168.0 164.0 165.0 168.0 168.0 167.0 170.0 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - PROCESS | 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:76.50 stddev:8.82 (11.5%) stddev-sans-first:9.03 05:37:25 INFO - PROCESS | 1956 | Values: 68.0 66.0 69.0 77.0 84.0 87.0 87.0 76.0 66.0 66.0 05:37:25 INFO - PROCESS | 1956 | -------- Summary: end -------- 05:37:25 INFO - PROCESS | 1956 | 05:37:25 INFO - TEST-INFO | 1956: exit 0 05:37:25 INFO - TEST-OK | kraken | took 59396ms 05:37:25 INFO - SUITE-END | took 1176s 05:37:26 INFO - Completed test suite (00:19:36) 05:37:26 INFO - javascript benchmark 05:37:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.9836200819, 3278.967210327896, 3296.3901678189536, 3312.354090952264, 3360.1935535471493, 5488.945110548893, 5585.022621041317, 5615.045442274813, 5666.150077488379, 5673.829785106448, 4767.332573439712, 5614.775408983635, 5621.128725047614, 5643.971780141093, 5668.0, 5076.263941728447, 5085.771140298677, 5109.846704598868, 5138.3577052868395, 5168.534831865131, 5173.663711858736, 5239.764210610512, 5260.789568417259, 5263.236830659552, 5322.0952438085615, 4154.50145982481, 5237.476252374751, 5254.369475662907, 5264.368275806889, 5336.30628018359, 5076.213186956028, 5136.974315128437, 5155.74221288934, 5164.406093299281, 5169.302144210558, 5178.016176926372, 5200.92198617021, 5213.452587478336, 5224.52979231871, 5267.47325267474, 5710.0, 5714.942850571482, 5736.6558006519745, 5738.368779434259, 5773.855653608652, 6071.0, 6105.084237364386, 6120.265568131853, 6138.235132557274, 6158.168647232611, 6111.591738512192, 6137.018077107686, 6142.723577439026, 6178.845528861814, 6181.227346581677, 5748.532900486952, 5827.213326200994, 5828.358880523139, 5831.679257640871, 5859.648421094748, 6137.508999280047, 6213.130161777355, 6214.782482613177, 6215.471684906744, 6240.843978900564, 6014.977453832859, 6060.33336333003, 6072.544559158081, 6094.45149936499, 6126.203593532812, 6162.506999440034, 6175.104609831549, 6177.4749146323065, 6203.131561581382, 6297.96851015742, 6158.599691020069, 6209.285932117774, 6229.314775374705, 6235.563510554218, 6258.74965001404, 6114.01954734555, 6114.144019837227, 6145.324014358417, 6230.875382492415, 6237.313895471494, 4879.951200488021, 4885.267209918541, 4899.534544218293, 4933.605311575066, 4973.676711013773, 4404.2512772828695, 4409.250427427345, 4412.911741765147, 4430.047539778963, 4455.086707225011, 5571.637843540157, 5699.800506982236, 5733.770649173986, 5746.770129194785, 5785.421457854265, 6097.615421629385, 6128.869808884179, 6162.383761623802, 6172.197614310111, 6242.375762423721, 5703.258576385043, 5715.399883012307, 5728.341240757366, 5738.913916291259, 5757.568182386338, 5314.602927374739, 5327.920081198785, 5334.759935802898, 5339.252504649352, 5341.893162136736, 6229.2524897012645, 6243.469305109116, 6249.656268905072, 6284.937150628435, 6286.308506064421, 6259.123722678738, 6292.811215663537, 6299.527535434952, 6304.464120549621, 6305.90541141874, 6278.560500764903, 6280.371962803683, 6284.528660350401, 6287.497000239879, 6293.181886354744, 5903.586748927534, 6001.459868611846, 6096.950036952638, 6136.662483563268, 6180.103884936749, 6248.968755156195, 6252.030935205051, 6301.275353334425, 6318.304986451579, 6320.841978950563, 5326.920096198638, 5551.306086739158, 6129.049997250433, 6133.969330153321, 6152.630842149485, 5887.735051922759, 6004.789832355847, 6058.363871793575, 6138.723757430837, 6143.508519318533, 5889.0, 6002.489788368038, 6007.339192688713, 6047.183630210041, 6074.36219196978, 6114.296855861633, 6133.172021777003, 6151.6001459904965, 6154.015357542772, 6158.04550294705, 5787.768489260382, 5789.884202315846, 5832.387599302012, 5861.413858614104, 5971.373005834324], "value": 5660.32581144715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.4659953648206, 521.4681025354139, 525.582162181066, 533.3919331961564, 559.4712996218575, 27683.584746228822, 39965.60034399655, 41190.38214426786, 41259.381109283386, 43052.138957220835, 42544.0, 43001.78499107508, 43047.569524304745, 43048.78475607625, 43098.13803723932, 8717.0, 8885.511296878669, 9678.806423871518, 9886.110250077492, 9886.209103271722, 12009.639710808646, 12354.567590134347, 12358.011359091252, 12375.814362784566, 12390.256584604953, 10232.386056836614, 12178.330191839445, 12275.140740148194, 12276.140670153049, 12276.5703200388, 12173.026157907347, 12248.958838498738, 12261.570845020426, 12266.32535210563, 12269.877301226963, 11990.460429280616, 12065.276083434934, 12074.69813254667, 12078.818817717742, 12079.094067944852, 39927.60072399297, 40266.194676106315, 40295.59704402948, 40346.394804077965, 40383.0, 3293.8353082346025, 3339.549160863301, 3355.0605830367535, 3372.5278461015478, 3414.641462646411, 30310.54534181989, 30847.383052339053, 31081.0, 31100.68899311023, 31850.522242166386, 3188.952165717516, 3210.3418799146352, 3246.675332466758, 3312.585926759155, 3337.199072222649, 494671.0, 494969.0, 496023.0, 496296.5185174087, 496803.0, 32117.839410802797, 33125.503117453256, 55444.0, 55783.0, 55816.74382330271, 34259.314813704084, 34392.0, 34742.0, 34782.30435391278, 34815.0, 14562.344694488773, 14629.487967921072, 14638.853611463963, 14674.853251467563, 14676.55970320892, 11338.43307834605, 11529.538818447169, 12213.0, 12408.0, 12532.122751407314, 7689.231076892378, 7723.304902558797, 7760.805979850436, 7767.456278060482, 7776.300132988058, 2927.0, 3121.219695076231, 3194.377096466213, 3248.691374319436, 3283.3090958156567, 917.7218322756922, 945.394947233771, 974.9561269742878, 985.5269470654126, 1125.6172901213627, 28004.859975700398, 29629.703702963125, 29801.956931507295, 30513.542296865566, 30532.38935221283, 1014.0, 1016.6289304403839, 1054.6045233037612, 1108.1744100645071, 1128.983914476961, 11165.553377864957, 14865.331060102322, 14902.733267672369, 15276.923615381851, 15285.465008724641, 526770.0, 626621.0, 627878.0, 628608.0, 631678.0, 50812.23781643205, 54744.72627636916, 54766.0, 54837.451625484035, 54912.0, 1139.9658010259704, 1202.2726250618425, 1244.6079484962208, 1278.3097127551205, 1382.1983249715342, 28919.855400723703, 30235.0, 30515.0, 30738.690929972414, 30841.074767757003, 47360.52639473699, 47957.801054973905, 47961.0, 47965.5203447961, 48006.27990580214, 416815.0, 498412.0, 501709.0, 502485.0, 502611.0, 25079.49841003206, 26234.08180713666, 27069.593956091067, 27126.593101103896, 27824.304392390353, 46116.30825537687, 46249.0, 46531.767341163075, 46757.0, 47364.289535657685, 37200.81399592985, 37244.80614264857, 37348.06629834276, 38028.809855950545, 38696.0, 37455.81272093731, 37473.62526374702, 38063.61936380601, 38749.6125038746, 38967.6103238964, 37255.0, 37790.811045944596, 38053.0, 38135.237295253384, 38155.855324340315, 29903.55144672788, 30797.0, 32232.0, 34088.65911340855, 34125.0, 20329.186832526535, 22709.0, 24725.258242252763, 25205.0, 25387.746122538538], "value": 18651.26016039921, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.54992284990936, 364.5079143156738, 368.2781747774362, 374.95875453700097, 398.7448033258713, 14842.628934276636, 15357.846421535782, 16080.276387562559, 20474.38576842697, 20496.795032049675, 19668.01659917002, 20215.0, 20803.68794468084, 20919.0, 21063.0, 5335.772772262382, 5693.402192769751, 5928.7628494860155, 5945.108233764927, 5958.7616495340135, 5679.460451257124, 5883.8529036774, 5938.0499120140785, 5955.583109182359, 5957.642541447505, 5586.41342659021, 5690.174924635925, 5888.64668119912, 5900.262467191601, 5907.232059832238, 5755.68343741094, 5806.622569532967, 5814.127880817869, 5814.4766970972605, 5823.475887170132, 4460.665450091256, 5021.5480606745205, 5080.568151707109, 5081.822136225214, 5089.796408143669, 25432.74567254341, 25570.74429255702, 25703.61444578333, 25725.35686607831, 25812.709364531886, 2207.812335951446, 2211.701420308254, 2272.136588096529, 2357.1514254868234, 2852.543593025106, 15058.397664093423, 15302.540923772305, 15379.692406151815, 15490.9225453872, 15740.60648483797, 1795.703708888032, 1873.1945263536675, 1874.9220445530916, 1879.586490971984, 1896.4879482539775, 122332.0, 125427.3728631351, 128826.06760898593, 129284.0, 131266.343668282, 10093.545790439448, 10263.538140783683, 10740.409277489813, 10794.222022292135, 10962.671119866416, 11170.832437513443, 13478.460861565623, 13486.865131348757, 13489.865101349058, 13492.0, 8311.625976831057, 8598.355123365773, 8627.870581941275, 8774.210321071134, 8816.0, 8832.470051796912, 8842.115788421235, 8870.955645221862, 9032.503212323385, 9073.500957447272, 6320.925442674757, 6428.1679721279215, 6443.7744678936015, 6457.515686323544, 6582.736690532325, 1399.3982587487478, 1481.2889812889873, 1562.6327812963943, 1743.9564010899576, 1857.1735577668078, 763.6181909045478, 769.2499563493097, 950.496236994394, 986.0, 988.2439933450916, 16485.34058637665, 17269.827301727073, 21496.89251553732, 22324.553508930054, 22402.0, 808.8827120067557, 919.246218101164, 978.6250318302796, 982.7936133411921, 983.9655612053543, 11060.723481913017, 11649.359285239394, 11969.222000569935, 12048.879511204776, 12306.261624302571, 261981.0, 262081.0, 262213.0, 263502.0, 611695.5965284194, 140051.0, 146419.0, 147280.2635986813, 148704.0, 150092.99070092905, 954.0745476887408, 958.4297343080856, 994.855745916838, 1001.0290018681867, 1003.1022235099691, 14605.926970365505, 15687.764683529527, 18067.90966045214, 19528.8047119527, 19561.0, 37901.24197516089, 56009.71995139998, 57253.0, 57653.0, 60365.0, 79665.60167199127, 80010.0, 80239.59880200561, 80360.59819700864, 80889.59555202187, 6756.797296081126, 7817.37461003107, 8094.271515563628, 8122.5126492410645, 8146.959265203636, 10599.841002384816, 10816.783664326513, 12778.361081945679, 13162.736745265232, 13282.468701251843, 10162.695119146438, 10946.781064378827, 11064.723381915517, 11530.82703759461, 11627.6511704649, 9955.153811926068, 10105.141063009727, 10458.96689959903, 10980.505877235704, 11400.657980260605, 11213.887861121284, 11374.658760237206, 11453.396524486412, 11514.36670983104, 11634.70913227176, 8006.479578827358, 8030.8393832121865, 8062.516249025077, 8102.87845682327, 8135.0, 9054.909450905407, 9839.458829764431, 10976.464099927052, 10993.835092473779, 11092.0], "value": 9468.068322149538, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.1995942150656, 1548.9767653485198, 1752.369147107042, 1829.5243236758438, 1942.3201879342223, 8365.874511882319, 8892.288616910648, 8894.288456923447, 8903.243224325925, 8915.509646969414, 7762.689492420296, 8054.355651547862, 8066.475679080856, 8158.265756081952, 8164.346852251821, 2064.3497298351044, 2163.610550100981, 2343.250159948817, 2410.734819169899, 2423.903043878243, 2389.95220095598, 2406.4585468269674, 2424.7754883783664, 2428.4778772563895, 2432.5134973005383, 1928.7203355513443, 2134.5944270588616, 2211.8230541556636, 2251.4371407148215, 2344.2732752846587, 2354.5526349993447, 2425.0784701813373, 2428.101602407103, 2440.73151953285, 2441.218809980789, 2378.1676413255395, 2388.116396933146, 2397.700287464067, 2417.9637305440433, 2419.830611857171, 8799.648014079428, 8883.42257753244, 8921.15249051339, 8959.820803583892, 8978.057303983052, 5255.290535777659, 5415.0, 5417.972910135463, 5419.647722898038, 5443.727813609304, 3446.60364058134, 3577.6422357764277, 3585.3904836177912, 3640.199156185661, 3641.3809652359164, 1059.3908502610952, 1108.9112870970384, 1111.7943180511631, 1117.9217454778168, 1122.1023181454884, 11656.941715291454, 11657.76684466306, 11720.120990925629, 11720.29678219301, 11738.882611173864, 4620.653450991189, 4625.421822272216, 4757.35775670287, 4829.879253018632, 4830.009847981156, 8637.309015278763, 9851.852222216672, 10063.849042264372, 10074.848877266846, 10083.445410502347, 5363.19552067193, 5365.356157261153, 5366.141417373202, 5367.35591728995, 5371.731413429391, 4844.15227335215, 4844.781984810692, 4886.53577910098, 4920.75396230187, 4942.604591632661, 3861.691064714816, 3926.1362500249897, 3962.722609417313, 3997.6002399760373, 4042.717009809285, 1314.0341848741168, 1316.0655934286763, 1318.156379916854, 1331.4141777617817, 1334.833145856768, 795.2127393880132, 886.4504007515382, 912.6988093928987, 927.5594092805998, 941.223490620241, 5776.68228247442, 5819.563532734977, 5915.64506129625, 6086.147939288503, 6163.506919446433, 447.6307046686497, 947.1286416496839, 957.4638202606424, 984.5963155106372, 1075.881653018183, 3864.6908247340707, 3880.4955355803563, 3892.2020985697864, 3960.6039396060164, 4001.339778936443, 10440.843387349196, 10869.011021969021, 10879.456027198608, 10886.782264354668, 10886.945565272123, 10829.458527073615, 10830.296030757976, 10840.295380800222, 10850.620228291971, 10854.620088296871, 7679.808004799813, 8059.959700201462, 8062.959685201537, 8162.918370816335, 8298.717852590586, 5878.3239927408895, 5902.350741418526, 6040.395960403925, 6079.513638908965, 6131.386861313833, 9849.60601575929, 10081.89918100839, 10111.03945125212, 10122.038406351385, 10132.138768204784, 9652.855207171757, 10013.349132306377, 10109.0, 10213.897861021294, 10252.0, 7435.591042492715, 7593.430492712958, 7618.847623047397, 7621.275978782007, 7623.009008828817, 8093.3929955252415, 8209.09699932995, 8293.129221431664, 8299.087100418828, 8299.834003319778, 7300.634968251672, 7441.739539116322, 7472.626368681435, 7503.699852006077, 7515.549067055994, 5700.971495142498, 6483.4164925156965, 7170.928290717026, 7257.0565826442225, 7365.631718413951, 5948.226730525004, 6852.451803855779, 6984.301569842975, 6995.321122930358, 7007.229204787572, 4871.90256194867, 4983.426905905867, 5000.774965126505, 5033.798648054037, 5076.060928728197, 4330.7401555906745, 4654.418197725285, 4712.952870471251, 4881.8535443936735, 5176.9741151294], "value": 4583.183332416886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.73476330104745, 285.5630884746339, 297.949348610736, 309.1914643208011, 311.5902588096653, 4476.529964353741, 4661.44062712475, 5129.435762066174, 5264.473552644734, 5321.175217841241, 5212.577612647438, 5276.577873770098, 5321.228421878825, 5373.892522149555, 5400.432954539766, 4091.4272001919753, 4098.323776576861, 4105.651019663333, 4142.5857414258635, 4147.460830092084, 3859.286032084073, 4014.7390419622775, 4039.0710136668586, 4057.6753859691303, 4103.958960410402, 3388.390089783838, 3818.522684664417, 3996.220736956295, 4090.9386359204486, 4094.7133700640966, 3649.503703481573, 4041.4544036554985, 4044.696647751401, 4047.433359329696, 4061.614146656063, 3463.584369875631, 3544.556930383702, 3575.9808454590575, 3586.28274345132, 3613.7109031277437, 4239.618434340924, 5052.494750524955, 5095.79616815327, 5137.046198435914, 5165.926273867043, 3885.708571857122, 4655.930161047587, 4690.226112691402, 4691.859244222679, 4693.7653117344, 4676.462206846222, 5296.119877443491, 5611.551075913917, 5639.4642508962, 5676.829695109153, 3822.9044273893096, 3829.965909204527, 3853.477876238898, 3858.575556688762, 3872.6320999505, 5940.6435613863305, 5942.554308426886, 5946.70266486674, 5971.5222782177325, 5973.253343332083, 3901.54202852207, 3920.549136849299, 3930.7964009332304, 3931.6461518463475, 3949.5260568731937, 3325.567676202078, 3676.356637588411, 3951.5455722591696, 3953.940690889581, 3990.6009399060445, 4343.913121737548, 4495.280755079171, 4515.909681806345, 4520.977395113004, 4549.363089167519, 4810.182269014276, 5004.749762511859, 5270.576944225115, 5614.810224012638, 5786.42135786418, 1326.7678156322604, 1356.5387768158873, 1356.5387768158873, 1357.3416892806981, 1359.0622470495327, 715.9176694680074, 801.7594721583619, 821.5399376349263, 822.8765685147276, 834.5743670727973, 3888.2806680764147, 4334.981279399339, 4407.382966384709, 4482.663800214997, 4535.206338890747, 4053.3919912013434, 4146.709730318848, 4310.978445107754, 4793.856184314476, 4827.62066553414, 4227.894302642397, 4355.455568053993, 4385.780710964439, 4422.248217802917, 4449.755263460476, 2364.3498038039675, 2478.5662509060844, 2556.539822831908, 2565.320190149612, 2571.318600570813, 4443.800028998703, 4560.973780899271, 4607.746573938465, 4683.063387322549, 5057.342545469065, 4366.820958341294, 4393.83563355711, 4513.796879140446, 4740.4311482621615, 4859.052484765437, 5484.506394424521, 6032.577719559588, 6042.546808989256, 6056.939430605637, 6061.212042434456, 4928.137575924127, 5784.0, 5804.912926306193, 5870.324912635102, 5879.970600147143, 4332.6317263033, 5456.0, 5677.8864422710485, 5787.771707892408, 5820.650760954356, 4752.952470475251, 5100.566451851634, 5995.6702381367695, 6038.84902877414, 6062.211912451353, 3278.065751260879, 3391.6947474727394, 3852.287326844543, 3926.3325234709596, 3936.8228429720157, 4768.546988036131, 5522.889542209214, 5599.776008959759, 5776.56675749312, 5923.881522369615, 5519.613627046068, 5555.0, 5585.385607583244, 5669.319681638065, 5682.431756824284, 4697.483276839476, 5109.131447653982, 5165.251038599457, 5501.944980550144, 5641.520470759867, 5277.656952298242, 5532.114861622121, 5587.664740115606, 5587.8882422352135, 5593.657522194725, 5623.437656234344, 5639.407862174413, 5645.322561292507, 5660.85847853807, 5674.546036317167, 4450.532694067077, 4622.260438329851, 4876.341693871282, 5445.44064289799, 5576.637518561281], "value": 3954.908769202202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4073139659782, 762.8588711088449, 785.1638005524117, 827.1893544326564, 827.3587969323773, 12870.356482175901, 12902.741945161091, 12941.094123411365, 12951.093423460361, 12955.417006234718, 14381.280935953213, 14540.491082812103, 14559.708805823877, 14567.053141545792, 14586.343614537345, 678.9388954994049, 698.5633978763273, 844.7972486603232, 852.4459101583989, 873.0919843362894, 833.3458235285271, 840.6721378662327, 844.341413697314, 844.7803571071504, 846.551327796269, 906.1618003346911, 909.8089401225717, 909.8362294786936, 912.1106920752246, 912.4662072687453, 902.7111324376202, 902.9774255643629, 903.0337538833451, 903.3495882964255, 903.9954800226022, 536.6511767351213, 557.1114073053513, 663.151166506872, 682.1132527713952, 688.2910602079866, 14025.579232623038, 14044.297785110806, 14093.718125637532, 14107.717845643132, 14156.504522341771, 13640.522581709693, 14080.225587592678, 14193.219372934485, 14229.928850355785, 14276.85723142776, 12533.918595371091, 12793.87206127936, 12823.487060517567, 12835.101542892002, 13228.338583070905, 4544.818207271705, 4584.518625544303, 4588.220002599533, 4649.86050418488, 4792.7124372537755, 89179.0, 104472.47763761209, 105365.47317263365, 116039.91481107402, 116836.65306775438, 11013.339199648046, 11015.504302306415, 11076.889231107747, 11196.104311655048, 11399.202055856176, 22447.0, 22488.32535023952, 22492.0, 22493.32520024402, 22539.32382028542, 7681.308682218627, 7766.301032906952, 7796.259355361345, 7817.944577482081, 7964.2433968772875, 4306.935395969063, 4317.07182955666, 4378.5183629800695, 4384.4519435070615, 4490.438695163105, 2967.9554806677916, 3446.7931924084637, 3580.373434648926, 3580.6419358063986, 3581.1047238190454, 652.2824892618082, 660.4182981758661, 664.880321542127, 684.9554778939353, 685.7188552693472, 603.5402426014458, 617.1421723803916, 620.3114542857425, 621.6860485454816, 633.5216911232083, 8658.523781191969, 8883.955580222058, 8993.460392376479, 9046.276297896153, 9062.954685226532, 576.2710171632888, 577.4369989260438, 588.4733163818444, 591.2432086928738, 604.782278379783, 3449.87925422609, 4237.343211802176, 4380.698576198087, 4468.352088947149, 4518.548145185455, 96884.06231875464, 136591.26817463594, 139752.0, 159224.0, 160650.0, 108119.91880081256, 136606.63393365938, 140192.29903850416, 140479.4880128005, 143435.2221255682, 76599.23400765921, 102307.0, 105053.0, 113093.34533273468, 117249.0, 6832.863342733217, 8541.615627296911, 8552.786180345542, 8597.613107410307, 8686.0, 59921.10118348141, 65296.0, 65936.67031664812, 66883.0, 67070.66464667645, 99748.0, 100240.48917798862, 100997.0, 101160.49419753149, 101873.49063254637, 9518.857217141887, 10947.850475699937, 11374.601888933848, 11489.195756296978, 11988.280703157838, 10722.946385268024, 12007.0, 12190.024798016315, 12225.266484010988, 12291.139620226499, 9854.704358869245, 10451.163906887583, 11733.589324373606, 11825.408729563316, 11996.220245684002, 12869.51150255554, 13362.265075420944, 13417.194968301934, 13734.725305493634, 13738.587842364745, 12184.756304873676, 13477.528286509925, 13675.589732308046, 13705.588832334646, 13922.09506382082, 8473.618687158969, 10943.233973621771, 11394.974452299333, 11521.135914806255, 11664.708382290512, 10606.098481629147, 11309.737335086787, 11369.886301136883, 11581.478833452684, 11606.187566870238], "value": 7622.696043139258, "unit": "score"}], "name": "dromaeo_css", "value": 7189.710102493581, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 140.0, 115.0, 145.0, 110.0, 108.0, 109.0, 108.0, 137.0, 107.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 184.0, 184.0, 187.0, 186.0, 184.0, 188.0, 161.0, 260.0], "value": 190.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 49.0, 73.0, 112.0, 86.0, 83.0, 62.0, 58.0, 81.0, 57.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 93.0, 70.0, 68.0, 69.0, 92.0, 67.0, 69.0, 88.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 83.0, 88.0, 85.0, 91.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 97.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 99.0, 125.0, 135.0, 125.0, 83.0, 87.0, 84.0, 85.0, 85.0], "value": 99.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 52.0, 54.0, 57.0, 56.0, 56.0, 54.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 65.0, 70.0, 77.0, 73.0, 70.0, 71.0, 73.0, 72.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 85.0, 88.0, 97.0, 93.0, 103.0, 107.0, 85.0, 84.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 136.0, 139.0, 140.0, 138.0, 140.0, 129.0, 190.0, 150.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 169.0, 168.0, 164.0, 165.0, 168.0, 168.0, 167.0, 170.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 77.0, 84.0, 87.0, 87.0, 76.0, 66.0, 66.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1463.1999999999998, "alertThreshold": 2.0}]} 05:37:26 INFO - Return code: 0 05:37:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:26 INFO - # TBPL SUCCESS # 05:37:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:26 INFO - 2016-09-21 05:37:26.412 screenresolution[1960:13784] starting screenresolution argv=screenresolution get 05:37:26 INFO - 2016-09-21 05:37:26.415 screenresolution[1960:13784] Display 0: 1600x1200x32@60 05:37:26 INFO - 2016-09-21 05:37:26.421 screenresolution[1961:13787] starting screenresolution argv=screenresolution list 05:37:26 INFO - Available Modes on Display 0 05:37:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:26 INFO - Intel Iris: 05:37:26 INFO - Chipset Model: Intel Iris 05:37:26 INFO - Type: GPU 05:37:26 INFO - Bus: Built-In 05:37:26 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:26 INFO - Vendor: Intel (0x8086) 05:37:26 INFO - Device ID: 0x0a2e 05:37:26 INFO - Revision ID: 0x0009 05:37:26 INFO - Displays: 05:37:26 INFO - Display: 05:37:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:26 INFO - Display Serial Number: 1600x1200 60 05:37:26 INFO - Main Display: Yes 05:37:26 INFO - Mirror: Off 05:37:26 INFO - Online: Yes 05:37:26 INFO - Rotation: Supported 05:37:26 INFO - Return code: 0 05:37:26 INFO - Running post-action listener: _resource_record_post_action 05:37:26 INFO - [mozharness: 2016-09-21 12:37:26.656509Z] Finished run-tests step (success) 05:37:26 INFO - Running post-run listener: _resource_record_post_run 05:37:26 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 1277952; Write bytes: 704126976; Read time: 14; Write time: 2152 05:37:26 INFO - TinderboxPrint: CPU usage
53.4% 05:37:26 INFO - TinderboxPrint: I/O read bytes / time
1,277,952 / 14 05:37:26 INFO - TinderboxPrint: I/O write bytes / time
704,126,976 / 2,152 05:37:26 INFO - TinderboxPrint: CPU idle
2,257.6 (46.6%) 05:37:26 INFO - TinderboxPrint: CPU system
965.1 (19.9%) 05:37:26 INFO - TinderboxPrint: CPU user
1,623.0 (33.5%) 05:37:26 INFO - TinderboxPrint: Swap in / out
406,421,504 / 0 05:37:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399571456; Write bytes: 394467328; Read time: 29840; Write time: 694 05:37:26 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 413696; Write bytes: 294787072; Read time: 9; Write time: 1420 05:37:27 INFO - Running post-run listener: _upload_blobber_files 05:37:27 INFO - Blob upload gear active. 05:37:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:28 INFO - (blobuploader) - INFO - Done attempting. 05:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:29 INFO - (blobuploader) - INFO - Done attempting. 05:37:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:31 INFO - (blobuploader) - INFO - Done attempting. 05:37:31 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:31 INFO - Return code: 0 05:37:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49670607955e2b18e950297168ec07df031b538199aad93a850c078729ea8ce1767866b5c71752d108c4e16a17f165fbd09b7294b40179bfb86615da0501bafb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44ce7f73f70ebcc24c4294da2a0e31e1318986af0becb3ad019c20b00a0140613219aa166b703c34a6c607ad53dee5e5995c5bf38f01e8afe0e95beb5f080801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5cba4f0e5d9d7e3c3ae04827b3b9bb9c17e6b63e756ef8b7e2aba656a76f1e91b6c2904cf09bdf03207ca765c94eede8f3abe48158c99e0a86995e378b403de"} 05:37:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:31 INFO - Contents: 05:37:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49670607955e2b18e950297168ec07df031b538199aad93a850c078729ea8ce1767866b5c71752d108c4e16a17f165fbd09b7294b40179bfb86615da0501bafb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44ce7f73f70ebcc24c4294da2a0e31e1318986af0becb3ad019c20b00a0140613219aa166b703c34a6c607ad53dee5e5995c5bf38f01e8afe0e95beb5f080801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5cba4f0e5d9d7e3c3ae04827b3b9bb9c17e6b63e756ef8b7e2aba656a76f1e91b6c2904cf09bdf03207ca765c94eede8f3abe48158c99e0a86995e378b403de"} 05:37:31 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:31 INFO - Copying logs to upload dir... 05:37:31 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.901738 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-21 05:37:31.952666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 05:37:31.955930) ========= 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.CTe2fVYUBv/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.XoF0G6gt55/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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/49670607955e2b18e950297168ec07df031b538199aad93a850c078729ea8ce1767866b5c71752d108c4e16a17f165fbd09b7294b40179bfb86615da0501bafb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44ce7f73f70ebcc24c4294da2a0e31e1318986af0becb3ad019c20b00a0140613219aa166b703c34a6c607ad53dee5e5995c5bf38f01e8afe0e95beb5f080801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5cba4f0e5d9d7e3c3ae04827b3b9bb9c17e6b63e756ef8b7e2aba656a76f1e91b6c2904cf09bdf03207ca765c94eede8f3abe48158c99e0a86995e378b403de"} build_url:https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/GcTKDhpBQGO_3tiBoFTlqA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49670607955e2b18e950297168ec07df031b538199aad93a850c078729ea8ce1767866b5c71752d108c4e16a17f165fbd09b7294b40179bfb86615da0501bafb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44ce7f73f70ebcc24c4294da2a0e31e1318986af0becb3ad019c20b00a0140613219aa166b703c34a6c607ad53dee5e5995c5bf38f01e8afe0e95beb5f080801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5cba4f0e5d9d7e3c3ae04827b3b9bb9c17e6b63e756ef8b7e2aba656a76f1e91b6c2904cf09bdf03207ca765c94eede8f3abe48158c99e0a86995e378b403de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 05:37:31.989309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:37:31.989707) ========= 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.CTe2fVYUBv/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.XoF0G6gt55/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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.005116 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:37:32.038195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 05:37:32.038490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 05:37:32.038799) ========= ========= Total master_lag: 0.18 =========