builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0182 starttime: 1491908294.66 results: success (0) buildid: 20170411023020 builduid: d1bd7829d0e34145abfe71361b4ac8a2 revision: f914d40a48009c5acd1093e9939cc0ec035696dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:14.664428) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:14.664872) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:14.665143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:14.691490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:14.691838) ========= 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.O73eukBHkE/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.yjFBLmPSOs/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-11 03:58:14-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.32M=0.001s 2017-04-11 03:58:14 (9.32 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:14.831574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:14.831884) ========= 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.O73eukBHkE/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.yjFBLmPSOs/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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.034350 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:14.888257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-11 03:58:14.888609) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f914d40a48009c5acd1093e9939cc0ec035696dd --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 f914d40a48009c5acd1093e9939cc0ec035696dd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O73eukBHkE/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.yjFBLmPSOs/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-11 03:58:14,982 truncating revision to first 12 chars 2017-04-11 03:58:14,982 Setting DEBUG logging. 2017-04-11 03:58:14,982 attempt 1/10 2017-04-11 03:58:14,982 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f914d40a4800?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 03:58:17,053 unpacking tar archive at: mozilla-central-f914d40a4800/testing/mozharness/ program finished with exit code 0 elapsedTime=2.354645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-11 03:58:17.266992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:17.267309) ========= script_repo_revision: f914d40a48009c5acd1093e9939cc0ec035696dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:17.267699) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:17.267983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 03:58:17.288056) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-04-11 03:58:17.288416) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O73eukBHkE/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.yjFBLmPSOs/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:58:17 INFO - MultiFileLogger online at 20170411 03:58:17 in /builds/slave/test 03:58:17 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 03:58:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:58:17 INFO - {'append_to_log': False, 03:58:17 INFO - 'base_work_dir': '/builds/slave/test', 03:58:17 INFO - 'blob_upload_branch': 'Firefox', 03:58:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:58:17 INFO - 'branch': 'Firefox', 03:58:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:58:17 INFO - 'config_files': ('talos/mac_config.py',), 03:58:17 INFO - 'default_actions': ('clobber', 03:58:17 INFO - 'read-buildbot-config', 03:58:17 INFO - 'download-and-extract', 03:58:17 INFO - 'populate-webroot', 03:58:17 INFO - 'create-virtualenv', 03:58:17 INFO - 'install', 03:58:17 INFO - 'run-tests'), 03:58:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:58:17 INFO - 'download_minidump_stackwalk': True, 03:58:17 INFO - 'download_symbols': 'ondemand', 03:58:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:58:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:58:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:58:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:58:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:58:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:58:17 INFO - 'gecko_profile': False, 03:58:17 INFO - 'gecko_profile_interval': 0, 03:58:17 INFO - 'installer_path': 'installer.exe', 03:58:17 INFO - 'log_level': 'info', 03:58:17 INFO - 'log_name': 'talos', 03:58:17 INFO - 'log_to_console': True, 03:58:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:58:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:58:17 INFO - 'opt_config_files': (), 03:58:17 INFO - 'pip_index': False, 03:58:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:58:17 INFO - 'cmd': ('bash', 03:58:17 INFO - '-c', 03:58:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:58:17 INFO - 'enabled': True, 03:58:17 INFO - 'halt_on_failure': False, 03:58:17 INFO - 'name': 'check_screen_resolution'},), 03:58:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:58:17 INFO - 'cmd': ('bash', 03:58:17 INFO - '-c', 03:58:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:58:17 INFO - 'enabled': True, 03:58:17 INFO - 'halt_on_failure': False, 03:58:17 INFO - 'name': 'check_screen_resolution'},), 03:58:17 INFO - 'run_cmd_checks_enabled': True, 03:58:17 INFO - 'suite': 'dromaeojs', 03:58:17 INFO - 'system_bits': '32', 03:58:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:58:17 INFO - 'title': 't-yosemite-r7-0182', 03:58:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:58:17 INFO - 'use_talos_json': True, 03:58:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:58:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:58:17 INFO - 'work_dir': 'build'} 03:58:17 INFO - [mozharness: 2017-04-11 10:58:17.485328Z] Running clobber step. 03:58:17 INFO - Running pre-action listener: _resource_record_pre_action 03:58:17 INFO - Running main action method: clobber 03:58:17 INFO - rmtree: /builds/slave/test/build 03:58:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:58:20 INFO - Running post-action listener: _resource_record_post_action 03:58:20 INFO - [mozharness: 2017-04-11 10:58:20.091508Z] Finished clobber step (success) 03:58:20 INFO - [mozharness: 2017-04-11 10:58:20.091662Z] Running read-buildbot-config step. 03:58:20 INFO - Running pre-action listener: _resource_record_pre_action 03:58:20 INFO - Running main action method: read_buildbot_config 03:58:20 INFO - Using buildbot properties: 03:58:20 INFO - { 03:58:20 INFO - "project": "", 03:58:20 INFO - "product": "firefox", 03:58:20 INFO - "script_repo_revision": "production", 03:58:20 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:58:20 INFO - "repository": "", 03:58:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:58:20 INFO - "buildid": "20170411023020", 03:58:20 INFO - "pgo_build": "False", 03:58:20 INFO - "basedir": "/builds/slave/test", 03:58:20 INFO - "buildnumber": 98, 03:58:20 INFO - "slavename": "t-yosemite-r7-0182", 03:58:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:58:20 INFO - "platform": "yosemite_r7", 03:58:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:58:20 INFO - "branch": "mozilla-central", 03:58:20 INFO - "repo_path": "mozilla-central", 03:58:20 INFO - "revision": "f914d40a48009c5acd1093e9939cc0ec035696dd", 03:58:20 INFO - "stage_platform": "macosx64", 03:58:20 INFO - "builduid": "d1bd7829d0e34145abfe71361b4ac8a2", 03:58:20 INFO - "slavebuilddir": "test" 03:58:20 INFO - } 03:58:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:58:20 INFO - Running post-action listener: _resource_record_post_action 03:58:20 INFO - [mozharness: 2017-04-11 10:58:20.095090Z] Finished read-buildbot-config step (success) 03:58:20 INFO - [mozharness: 2017-04-11 10:58:20.095241Z] Running download-and-extract step. 03:58:20 INFO - Running pre-action listener: _resource_record_pre_action 03:58:20 INFO - Running main action method: download_and_extract 03:58:20 INFO - mkdir: /builds/slave/test/build/tests 03:58:20 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')]} 03:58:20 INFO - trying https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:58:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 03:58:21 INFO - Downloaded 1325 bytes. 03:58:21 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:58:21 INFO - Using the following test package requirements: 03:58:21 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:58:21 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:58:21 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:58:21 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:58:21 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'jsshell-mac.zip'], 03:58:21 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:58:21 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:58:21 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:58:21 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:58:21 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:58:21 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:21 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:58:21 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:58:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:58:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:58:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:58:22 INFO - Expected file size: 52582296 03:58:22 INFO - Obtained file size: 52582296 03:58:39 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:58:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:58:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:58:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:58:41 INFO - Expected file size: 52582296 03:58:41 INFO - Obtained file size: 52582296 03:58:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:58:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:58:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:58:58 INFO - Expected file size: 14405596 03:58:58 INFO - Obtained file size: 14405596 03:58:58 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')]} 03:58:58 INFO - trying https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:58:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 03:59:00 INFO - Downloaded 70923999 bytes. 03:59:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:59:00 INFO - mkdir: /builds/slave/test/properties 03:59:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:00 INFO - Contents: 03:59:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:59:01 INFO - Running post-action listener: _resource_record_post_action 03:59:01 INFO - Running post-action listener: set_extra_try_arguments 03:59:01 INFO - [mozharness: 2017-04-11 10:59:01.380212Z] Finished download-and-extract step (success) 03:59:01 INFO - [mozharness: 2017-04-11 10:59:01.380335Z] Running populate-webroot step. 03:59:01 INFO - Running pre-action listener: _resource_record_pre_action 03:59:01 INFO - Running main action method: populate_webroot 03:59:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:59:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:59:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:59:01 INFO - '--tppagecycles', 03:59:01 INFO - '7'], 03:59:01 INFO - 'tests': ['tsvgm']}}, 03:59:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:59:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:59:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:59:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:59:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:59:01 INFO - 'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:59:01 INFO - 'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['damp', 'tps']}, 03:59:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:59:01 INFO - 'tests': ['damp', 'tps']}, 03:59:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['dromaeo_dom']}, 03:59:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['basic_compositor_video']}, 03:59:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:59:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['a11yr', 03:59:01 INFO - 'ts_paint', 03:59:01 INFO - 'tpaint', 03:59:01 INFO - 'sessionrestore', 03:59:01 INFO - 'sessionrestore_no_auto_restore', 03:59:01 INFO - 'tabpaint']}, 03:59:01 INFO - 'other-e10s': {'tests': ['a11yr', 03:59:01 INFO - 'ts_paint', 03:59:01 INFO - 'tpaint', 03:59:01 INFO - 'sessionrestore', 03:59:01 INFO - 'sessionrestore_no_auto_restore', 03:59:01 INFO - 'tabpaint']}, 03:59:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:59:01 INFO - 'ts_paint', 03:59:01 INFO - 'tpaint', 03:59:01 INFO - 'sessionrestore', 03:59:01 INFO - 'sessionrestore_no_auto_restore', 03:59:01 INFO - 'tabpaint']}, 03:59:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:59:01 INFO - 'ts_paint', 03:59:01 INFO - 'tpaint', 03:59:01 INFO - 'sessionrestore', 03:59:01 INFO - 'sessionrestore_no_auto_restore', 03:59:01 INFO - 'tabpaint']}, 03:59:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['a11yr', 03:59:01 INFO - 'ts_paint', 03:59:01 INFO - 'tpaint', 03:59:01 INFO - 'sessionrestore', 03:59:01 INFO - 'sessionrestore_no_auto_restore', 03:59:01 INFO - 'tabpaint']}, 03:59:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['a11yr', 03:59:01 INFO - 'ts_paint', 03:59:01 INFO - 'tpaint', 03:59:01 INFO - 'sessionrestore', 03:59:01 INFO - 'sessionrestore_no_auto_restore', 03:59:01 INFO - 'tabpaint']}, 03:59:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['tsvgx', 03:59:01 INFO - 'tsvgr_opacity', 03:59:01 INFO - 'tart', 03:59:01 INFO - 'tscrollx', 03:59:01 INFO - 'cart', 03:59:01 INFO - 'tsvg_static']}, 03:59:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:59:01 INFO - 'tsvgr_opacity', 03:59:01 INFO - 'tart', 03:59:01 INFO - 'tscrollx', 03:59:01 INFO - 'cart', 03:59:01 INFO - 'tsvg_static']}, 03:59:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:59:01 INFO - 'talos_options': ['--disable-e10s'], 03:59:01 INFO - 'tests': ['tp5o']}, 03:59:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:59:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:59:01 INFO - 'talos_options': ['--disable-e10s', 03:59:01 INFO - '--xperf_path', 03:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:01 INFO - 'tests': ['tp5n']}, 03:59:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:59:01 INFO - 'talos_options': ['--xperf_path', 03:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:01 INFO - 'tests': ['tp5n']}}, 03:59:01 INFO - 'talos.zip': {'path': '', 03:59:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:59:01 INFO - Running post-action listener: _resource_record_post_action 03:59:01 INFO - [mozharness: 2017-04-11 10:59:01.398955Z] Finished populate-webroot step (success) 03:59:01 INFO - [mozharness: 2017-04-11 10:59:01.399090Z] Running create-virtualenv step. 03:59:01 INFO - Running pre-action listener: _resource_record_pre_action 03:59:01 INFO - Running main action method: create_virtualenv 03:59:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:01 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 03:59:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:01 INFO - Using real prefix '/tools/python27' 03:59:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:05 INFO - Installing pip.................done. 03:59:05 INFO - Return code: 0 03:59:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:59:05 INFO - Reading from file tmpfile_stdout 03:59:05 INFO - Output received: 03:59:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:59:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59:05 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')]} 03:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:05 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')]} 03:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:05 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:05 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 03:59:05 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 03:59:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:05 INFO - 'HOME': '/Users/cltbld', 03:59:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:05 INFO - 'LOGNAME': 'cltbld', 03:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:05 INFO - 'MOZ_NO_REMOTE': '1', 03:59:05 INFO - 'NO_EM_RESTART': '1', 03:59:05 INFO - 'PAGER': '/bin/cat', 03:59:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:05 INFO - 'PWD': '/builds/slave/test', 03:59:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:05 INFO - 'SHELL': '/bin/bash', 03:59:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:05 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:05 INFO - 'USER': 'cltbld', 03:59:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:05 INFO - 'XPC_FLAGS': '0x0', 03:59:05 INFO - 'XPC_SERVICE_NAME': '0', 03:59:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:05 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 03:59:05 INFO - Cleaning up... 03:59:05 INFO - Return code: 0 03:59:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:59:05 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')]} 03:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:05 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')]} 03:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:05 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:05 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 03:59:05 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 03:59:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:05 INFO - 'HOME': '/Users/cltbld', 03:59:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:05 INFO - 'LOGNAME': 'cltbld', 03:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:05 INFO - 'MOZ_NO_REMOTE': '1', 03:59:05 INFO - 'NO_EM_RESTART': '1', 03:59:05 INFO - 'PAGER': '/bin/cat', 03:59:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:05 INFO - 'PWD': '/builds/slave/test', 03:59:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:05 INFO - 'SHELL': '/bin/bash', 03:59:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:05 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:05 INFO - 'USER': 'cltbld', 03:59:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:05 INFO - 'XPC_FLAGS': '0x0', 03:59:05 INFO - 'XPC_SERVICE_NAME': '0', 03:59:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:05 INFO - Downloading/unpacking psutil>=3.1.1 03:59:05 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 03:59:05 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 03:59:05 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 03:59:05 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 03:59:05 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 03:59:05 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 03:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:09 INFO - Installing collected packages: psutil 03:59:09 INFO - Running setup.py install for psutil 03:59:09 INFO - building 'psutil._psutil_osx' extension 03:59:09 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 03:59:10 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 03:59:10 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 03:59:10 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 03:59:10 INFO - building 'psutil._psutil_posix' extension 03:59:10 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 03:59:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:59:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:59:10 INFO - ^ 03:59:10 INFO - 1 warning generated. 03:59:10 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 03:59:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:10 INFO - Successfully installed psutil 03:59:10 INFO - Cleaning up... 03:59:10 INFO - Return code: 0 03:59:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:11 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')]} 03:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:11 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:11 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 03:59:11 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 03:59:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:11 INFO - 'HOME': '/Users/cltbld', 03:59:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:11 INFO - 'LOGNAME': 'cltbld', 03:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:11 INFO - 'MOZ_NO_REMOTE': '1', 03:59:11 INFO - 'NO_EM_RESTART': '1', 03:59:11 INFO - 'PAGER': '/bin/cat', 03:59:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:11 INFO - 'PWD': '/builds/slave/test', 03:59:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:11 INFO - 'SHELL': '/bin/bash', 03:59:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:11 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:11 INFO - 'USER': 'cltbld', 03:59:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:11 INFO - 'XPC_FLAGS': '0x0', 03:59:11 INFO - 'XPC_SERVICE_NAME': '0', 03:59:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:59:12 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 03:59:12 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 03:59:12 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 03:59:12 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 03:59:12 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 03:59:12 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 03:59:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:59:15 INFO - Installing collected packages: mozsystemmonitor 03:59:15 INFO - Running setup.py install for mozsystemmonitor 03:59:15 INFO - Successfully installed mozsystemmonitor 03:59:15 INFO - Cleaning up... 03:59:15 INFO - Return code: 0 03:59:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:59:15 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')]} 03:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:15 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')]} 03:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:15 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:15 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 03:59:15 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 03:59:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:15 INFO - 'HOME': '/Users/cltbld', 03:59:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:15 INFO - 'LOGNAME': 'cltbld', 03:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:15 INFO - 'MOZ_NO_REMOTE': '1', 03:59:15 INFO - 'NO_EM_RESTART': '1', 03:59:15 INFO - 'PAGER': '/bin/cat', 03:59:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:15 INFO - 'PWD': '/builds/slave/test', 03:59:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:15 INFO - 'SHELL': '/bin/bash', 03:59:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:15 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:15 INFO - 'USER': 'cltbld', 03:59:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:15 INFO - 'XPC_FLAGS': '0x0', 03:59:15 INFO - 'XPC_SERVICE_NAME': '0', 03:59:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:15 INFO - Downloading/unpacking jsonschema==2.5.1 03:59:15 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 03:59:15 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 03:59:15 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 03:59:15 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 03:59:15 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 03:59:15 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 03:59:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:59:19 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 03:59:19 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 03:59:19 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 03:59:19 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 03:59:19 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 03:59:19 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 03:59:19 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:19 INFO - warning: no files found matching '*.txt' 03:59:19 INFO - no previously-included directories found matching 'build' 03:59:19 INFO - no previously-included directories found matching 'dist' 03:59:19 INFO - no previously-included directories found matching '.git*' 03:59:19 INFO - Installing collected packages: jsonschema, functools32 03:59:19 INFO - Running setup.py install for functools32 03:59:20 INFO - warning: no files found matching '*.txt' 03:59:20 INFO - no previously-included directories found matching 'build' 03:59:20 INFO - no previously-included directories found matching 'dist' 03:59:20 INFO - no previously-included directories found matching '.git*' 03:59:20 INFO - Successfully installed jsonschema functools32 03:59:20 INFO - Cleaning up... 03:59:20 INFO - Return code: 0 03:59:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:59:20 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')]} 03:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:20 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')]} 03:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:20 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:20 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 03:59:20 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 03:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:20 INFO - 'HOME': '/Users/cltbld', 03:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:20 INFO - 'LOGNAME': 'cltbld', 03:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:20 INFO - 'MOZ_NO_REMOTE': '1', 03:59:20 INFO - 'NO_EM_RESTART': '1', 03:59:20 INFO - 'PAGER': '/bin/cat', 03:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:20 INFO - 'PWD': '/builds/slave/test', 03:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:20 INFO - 'SHELL': '/bin/bash', 03:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:20 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:20 INFO - 'USER': 'cltbld', 03:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:20 INFO - 'XPC_FLAGS': '0x0', 03:59:20 INFO - 'XPC_SERVICE_NAME': '0', 03:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:59:20 INFO - Cleaning up... 03:59:20 INFO - Return code: 0 03:59:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:20 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')]} 03:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:20 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')]} 03:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:20 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:20 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 03:59:20 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 03:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:20 INFO - 'HOME': '/Users/cltbld', 03:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:20 INFO - 'LOGNAME': 'cltbld', 03:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:20 INFO - 'MOZ_NO_REMOTE': '1', 03:59:20 INFO - 'NO_EM_RESTART': '1', 03:59:20 INFO - 'PAGER': '/bin/cat', 03:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:20 INFO - 'PWD': '/builds/slave/test', 03:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:20 INFO - 'SHELL': '/bin/bash', 03:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:20 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:20 INFO - 'USER': 'cltbld', 03:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:20 INFO - 'XPC_FLAGS': '0x0', 03:59:20 INFO - 'XPC_SERVICE_NAME': '0', 03:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:20 INFO - Downloading/unpacking blobuploader==1.2.4 03:59:20 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 03:59:20 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 03:59:20 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 03:59:20 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 03:59:20 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 03:59:20 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 03:59:23 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59:24 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 03:59:24 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 03:59:24 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 03:59:24 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 03:59:24 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 03:59:24 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 03:59:24 INFO - Downloading docopt-0.6.1.tar.gz 03:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:24 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:24 INFO - Running setup.py install for blobuploader 03:59:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:24 INFO - Running setup.py install for requests 03:59:25 INFO - Running setup.py install for docopt 03:59:25 INFO - Successfully installed blobuploader requests docopt 03:59:25 INFO - Cleaning up... 03:59:25 INFO - Return code: 0 03:59:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:25 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:25 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 03:59:25 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 03:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:25 INFO - 'HOME': '/Users/cltbld', 03:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:25 INFO - 'LOGNAME': 'cltbld', 03:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:25 INFO - 'MOZ_NO_REMOTE': '1', 03:59:25 INFO - 'NO_EM_RESTART': '1', 03:59:25 INFO - 'PAGER': '/bin/cat', 03:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:25 INFO - 'PWD': '/builds/slave/test', 03:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:25 INFO - 'SHELL': '/bin/bash', 03:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:25 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:25 INFO - 'USER': 'cltbld', 03:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:25 INFO - 'XPC_FLAGS': '0x0', 03:59:25 INFO - 'XPC_SERVICE_NAME': '0', 03:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:25 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-U7flUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:25 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-zQKOtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:25 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-f6LuYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-gnhEn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-XfE_qU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-Qa9eCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-HRdYmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ITTUQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-RLtUXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-P9dHaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-oel1R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-UnnxXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:26 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-TqrNtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:27 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-hokZco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:27 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-q4fMNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:27 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-BNi0Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:27 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-eJ7VkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:27 INFO - Running setup.py install for manifestparser 03:59:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:27 INFO - Running setup.py install for mozcrash 03:59:27 INFO - Running setup.py install for mozdebug 03:59:27 INFO - Running setup.py install for mozdevice 03:59:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:28 INFO - Running setup.py install for mozfile 03:59:28 INFO - Running setup.py install for mozhttpd 03:59:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:28 INFO - Running setup.py install for mozinfo 03:59:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:28 INFO - Running setup.py install for mozInstall 03:59:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:28 INFO - Running setup.py install for mozleak 03:59:28 INFO - Running setup.py install for mozlog 03:59:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:28 INFO - Running setup.py install for moznetwork 03:59:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:29 INFO - Running setup.py install for mozprocess 03:59:29 INFO - Running setup.py install for mozprofile 03:59:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:29 INFO - Running setup.py install for mozrunner 03:59:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:29 INFO - Running setup.py install for mozscreenshot 03:59:29 INFO - Running setup.py install for moztest 03:59:29 INFO - Running setup.py install for mozversion 03:59:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:30 INFO - Cleaning up... 03:59:30 INFO - Return code: 0 03:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:30 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:30 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 03:59:30 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 03:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:30 INFO - 'HOME': '/Users/cltbld', 03:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:30 INFO - 'LOGNAME': 'cltbld', 03:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:30 INFO - 'MOZ_NO_REMOTE': '1', 03:59:30 INFO - 'NO_EM_RESTART': '1', 03:59:30 INFO - 'PAGER': '/bin/cat', 03:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:30 INFO - 'PWD': '/builds/slave/test', 03:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:30 INFO - 'SHELL': '/bin/bash', 03:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:30 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:30 INFO - 'USER': 'cltbld', 03:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:30 INFO - 'XPC_FLAGS': '0x0', 03:59:30 INFO - 'XPC_SERVICE_NAME': '0', 03:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-sDAnKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:30 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)) 03:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-d2Bqv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-DpL_JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:30 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)) 03:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-fhPYL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 03:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-OtmkGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:30 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)) 03:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-zXLIks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:30 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)) 03:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:30 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-Culvov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:31 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)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-27XDTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:31 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)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-7DmFFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:31 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)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-2EfvCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:31 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)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-GtHrgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:31 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)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-I3Kcyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-muvwRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:31 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)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-u_vZBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-reqBMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:31 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)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:31 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-1N8M8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:32 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-wnKLyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:32 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)) 03:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:32 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)) 03:59:32 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:32 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:34 INFO - Downloading blessings-1.6.tar.gz 03:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:34 INFO - Installing collected packages: blessings 03:59:34 INFO - Running setup.py install for blessings 03:59:34 INFO - Successfully installed blessings 03:59:34 INFO - Cleaning up... 03:59:35 INFO - Return code: 0 03:59:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:35 INFO - Reading from file tmpfile_stdout 03:59:35 INFO - Current package versions: 03:59:35 INFO - blessings == 1.6 03:59:35 INFO - blobuploader == 1.2.4 03:59:35 INFO - docopt == 0.6.1 03:59:35 INFO - functools32 == 3.2.3-2 03:59:35 INFO - jsonschema == 2.5.1 03:59:35 INFO - manifestparser == 1.1 03:59:35 INFO - mozInstall == 1.12 03:59:35 INFO - mozcrash == 1.0 03:59:35 INFO - mozdebug == 0.1 03:59:35 INFO - mozdevice == 0.50 03:59:35 INFO - mozfile == 1.2 03:59:35 INFO - mozhttpd == 0.7 03:59:35 INFO - mozinfo == 0.9 03:59:35 INFO - mozleak == 0.1 03:59:35 INFO - mozlog == 3.4 03:59:35 INFO - moznetwork == 0.27 03:59:35 INFO - mozprocess == 0.25 03:59:35 INFO - mozprofile == 0.28 03:59:35 INFO - mozrunner == 6.13 03:59:35 INFO - mozscreenshot == 0.1 03:59:35 INFO - mozsystemmonitor == 0.3 03:59:35 INFO - moztest == 0.8 03:59:35 INFO - mozversion == 1.4 03:59:35 INFO - psutil == 3.1.1 03:59:35 INFO - requests == 1.2.3 03:59:35 INFO - wsgiref == 0.1.2 03:59:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:35 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 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:35 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 03:59:35 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 03:59:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:35 INFO - 'HOME': '/Users/cltbld', 03:59:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:35 INFO - 'LOGNAME': 'cltbld', 03:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:35 INFO - 'MOZ_NO_REMOTE': '1', 03:59:35 INFO - 'NO_EM_RESTART': '1', 03:59:35 INFO - 'PAGER': '/bin/cat', 03:59:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:35 INFO - 'PWD': '/builds/slave/test', 03:59:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:35 INFO - 'SHELL': '/bin/bash', 03:59:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:35 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:35 INFO - 'USER': 'cltbld', 03:59:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:35 INFO - 'XPC_FLAGS': '0x0', 03:59:35 INFO - 'XPC_SERVICE_NAME': '0', 03:59:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 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)) 03:59:35 INFO - Cleaning up... 03:59:35 INFO - Return code: 0 03:59:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100734b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100737768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b594a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, '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.O73eukBHkE/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.yjFBLmPSOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 03:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:59:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:35 INFO - 'HOME': '/Users/cltbld', 03:59:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:35 INFO - 'LOGNAME': 'cltbld', 03:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:35 INFO - 'MOZ_NO_REMOTE': '1', 03:59:35 INFO - 'NO_EM_RESTART': '1', 03:59:35 INFO - 'PAGER': '/bin/cat', 03:59:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:35 INFO - 'PWD': '/builds/slave/test', 03:59:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:35 INFO - 'SHELL': '/bin/bash', 03:59:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:35 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:35 INFO - 'USER': 'cltbld', 03:59:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:35 INFO - 'XPC_FLAGS': '0x0', 03:59:35 INFO - 'XPC_SERVICE_NAME': '0', 03:59:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:59:35 INFO - Cleaning up... 03:59:35 INFO - Return code: 0 03:59:35 INFO - Running post-action listener: _resource_record_post_action 03:59:35 INFO - Running post-action listener: _start_resource_monitoring 03:59:35 INFO - Starting resource monitoring. 03:59:35 INFO - [mozharness: 2017-04-11 10:59:35.890405Z] Finished create-virtualenv step (success) 03:59:35 INFO - [mozharness: 2017-04-11 10:59:35.891365Z] Running install step. 03:59:35 INFO - Running pre-action listener: _resource_record_pre_action 03:59:35 INFO - Running main action method: install 03:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:36 INFO - Reading from file tmpfile_stdout 03:59:36 INFO - Detecting whether we're running mozinstall >=1.0... 03:59:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:59:36 INFO - Reading from file tmpfile_stdout 03:59:36 INFO - Output received: 03:59:36 INFO - Usage: mozinstall [options] installer 03:59:36 INFO - Options: 03:59:36 INFO - -h, --help show this help message and exit 03:59:36 INFO - -d DEST, --destination=DEST 03:59:36 INFO - Directory to install application into. [default: 03:59:36 INFO - "/builds/slave/test"] 03:59:36 INFO - --app=APP Application being installed. [default: firefox] 03:59:36 INFO - mkdir: /builds/slave/test/build/application 03:59:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:59:56 INFO - Reading from file tmpfile_stdout 03:59:56 INFO - Output received: 03:59:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:59:56 INFO - Running post-action listener: _resource_record_post_action 03:59:56 INFO - [mozharness: 2017-04-11 10:59:56.021592Z] Finished install step (success) 03:59:56 INFO - [mozharness: 2017-04-11 10:59:56.021749Z] Running run-tests step. 03:59:56 INFO - Running pre-action listener: _resource_record_pre_action 03:59:56 INFO - Running main action method: run_tests 03:59:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:59:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:59:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:59:56 INFO - 2017-04-11 03:59:56.035 screenresolution[1619:7271] starting screenresolution argv=screenresolution get 03:59:56 INFO - 2017-04-11 03:59:56.038 screenresolution[1619:7271] Display 0: 1600x1200x32@60 03:59:56 INFO - 2017-04-11 03:59:56.044 screenresolution[1620:7274] starting screenresolution argv=screenresolution list 03:59:56 INFO - Available Modes on Display 0 03:59:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:59:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:59:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:59:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:59:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:59:56 INFO - Intel Iris: 03:59:56 INFO - Chipset Model: Intel Iris 03:59:56 INFO - Type: GPU 03:59:56 INFO - Bus: Built-In 03:59:56 INFO - VRAM (Dynamic, Max): 1536 MB 03:59:56 INFO - Vendor: Intel (0x8086) 03:59:56 INFO - Device ID: 0x0a2e 03:59:56 INFO - Revision ID: 0x0009 03:59:56 INFO - Displays: 03:59:56 INFO - Display: 03:59:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:59:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:59:56 INFO - Display Serial Number: 1600x1200 60 03:59:56 INFO - Main Display: Yes 03:59:56 INFO - Mirror: Off 03:59:56 INFO - Online: Yes 03:59:56 INFO - Rotation: Supported 03:59:56 INFO - Return code: 0 03:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:59:56 INFO - Python 2.7.3 03:59:56 INFO - Return code: 0 03:59:56 INFO - grabbing minidump binary from tooltool 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:56 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 0x100512d30>, '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 0x100439db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100507be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:59:56 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 03:59:56 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 03:59:56 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 03:59:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:56 INFO - Return code: 0 03:59:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:59:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:59:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:59:56 INFO - ENV: RUST_BACKTRACE is now 1 03:59:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:59:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:59:56 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/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 03:59:56 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/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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 03:59:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O73eukBHkE/Render', 03:59:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:56 INFO - 'HOME': '/Users/cltbld', 03:59:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:56 INFO - 'LOGNAME': 'cltbld', 03:59:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:56 INFO - 'MOZ_NO_REMOTE': '1', 03:59:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:56 INFO - 'NO_EM_RESTART': '1', 03:59:56 INFO - 'PAGER': '/bin/cat', 03:59:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:56 INFO - 'PWD': '/builds/slave/test', 03:59:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:56 INFO - 'RUST_BACKTRACE': '1', 03:59:56 INFO - 'SHELL': '/bin/bash', 03:59:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yjFBLmPSOs/Listeners', 03:59:56 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 03:59:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:56 INFO - 'USER': 'cltbld', 03:59:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:56 INFO - 'XPC_FLAGS': '0x0', 03:59:56 INFO - 'XPC_SERVICE_NAME': '0', 03:59:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:56 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/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 03:59:56 INFO - mozversion application_buildid: 20170411023020 03:59:56 INFO - mozversion application_changeset: f914d40a48009c5acd1093e9939cc0ec035696dd 03:59:56 INFO - mozversion application_display_name: Nightly 03:59:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:56 INFO - mozversion application_name: Firefox 03:59:56 INFO - mozversion application_remotingname: firefox 03:59:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:59:56 INFO - mozversion application_vendor: Mozilla 03:59:56 INFO - mozversion application_version: 55.0a1 03:59:56 INFO - mozversion platform_buildid: 20170411023020 03:59:56 INFO - mozversion platform_changeset: f914d40a48009c5acd1093e9939cc0ec035696dd 03:59:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:59:56 INFO - mozversion platform_version: 55.0a1 03:59:56 INFO - using testdate: 1491908396 03:59:56 INFO - actual date: 1491908396 03:59:56 INFO - starting webserver on 'localhost:49236' 03:59:56 INFO - SUITE-START | Running 2 tests 03:59:56 INFO - TEST-START | dromaeo_css 03:59:56 INFO - operating with platform_type : mac_ 03:59:56 INFO - Initialising browser for dromaeo_css test... 03:59:56 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpucm5mQ/profile http://localhost:49236/getInfo.html) 03:59:59 INFO - PID 1630 | __metrics Screen width/height:1600/1200 03:59:59 INFO - PID 1630 | colorDepth:24 03:59:59 INFO - PID 1630 | Browser inner width/height: 1024/689 03:59:59 INFO - PID 1630 | __metrics 03:59:59 INFO - PID 1630 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:59:59 INFO - PID 1630 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:00:00 INFO - TEST-INFO | 1630: exit 0 04:00:00 INFO - Browser initialized. 04:00:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:00 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpucm5mQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:12 INFO - PID 1631 | RSS: Main: 239407104 04:00:12 INFO - PID 1631 | 04:03:18 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 04:03:19 INFO - PID 1631 | RSS: Main: 390770688 04:03:19 INFO - PID 1631 | 04:05:02 INFO - PID 1631 | ************************* 04:05:02 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 04:05:02 INFO - PID 1631 | 04:05:02 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:05:02 INFO - PID 1631 | Full stack: 04:05:02 INFO - PID 1631 | ************************* 04:05:02 INFO - PID 1631 | ************************* 04:05:02 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 04:05:02 INFO - PID 1631 | 04:05:02 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:05:02 INFO - PID 1631 | Full stack: 04:05:02 INFO - PID 1631 | ************************* 04:05:02 INFO - PID 1631 | ************************* 04:05:02 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 04:05:02 INFO - PID 1631 | 04:05:02 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:05:02 INFO - PID 1631 | Full stack: 04:05:02 INFO - PID 1631 | ************************* 04:05:02 INFO - PID 1631 | ************************* 04:05:02 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 04:05:02 INFO - PID 1631 | 04:05:02 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:05:02 INFO - PID 1631 | Full stack: 04:05:02 INFO - PID 1631 | ************************* 04:06:22 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 04:06:23 INFO - PID 1631 | RSS: Main: 374669312 04:06:23 INFO - PID 1631 | 04:09:25 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 04:09:26 INFO - PID 1631 | RSS: Main: 327942144 04:09:26 INFO - PID 1631 | 04:12:28 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 04:12:29 INFO - PID 1631 | RSS: Main: 330866688 04:12:29 INFO - PID 1631 | 04:15:32 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 04:15:33 INFO - PID 1631 | RSS: Main: 339656704 04:15:33 INFO - PID 1631 | 04:18:35 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 04:18:36 INFO - PID 1631 | RSS: Main: 378560512 04:18:36 INFO - PID 1631 | 04:18:36 INFO - PID 1631 | __start_tp_report 04:18:36 INFO - PID 1631 | _x_x_mozilla_page_load 04:18:36 INFO - PID 1631 | _x_x_mozilla_page_load_details 04:18:36 INFO - PID 1631 | |i|pagename|runs| 04:18:36 INFO - PID 1631 | |0;dojo.html;3154.80117555329;3422.1615704152478;3430.6054803697566;3445.758796884219;3492.70312023478;5245.531251249657;5458.563314934806;6115.327313995457;6139.171211886394;6140.385961403857;5878.441548052939;5981.5214782817375;6058.969705151468;6090.756369745205;6136.785212517563;5093.108705976458;5187.507186817246;5192.792288308463;5206.114960456732;5209.895802083956;5262.526372626463;5320.122179840322;5344.198370244475;5345.839624811242;5387.0303345397815;5151.716655583941;5218.269442278084;5236.607254455893;5238.738063096868;5296.655717378358;5198.532132108128;5206.401263854667;5213.635045546814;5217.034848553029;5217.060929032773;5109.772103567624;5158.329417175781;5159.277701121809;5193.68837869729;5290.947090529123;5202;5934.732937017845;6012.729427175744;6130.908036379458;6131.202943617302;6356;6398.16823812906;6403.0715546246;6403.48772098231;6404.7117879695525;6216.595921265103;6404.807855764335;6436.903446448307;6445.033245013238;6455.354464553554;5964.7912323068485;5998.070299103646;6002.729877155539;6005.39946005396;6007.36922623127;6399.200099987502;6399.264084630234;6407.775727849503;6424.71088801005;6424.935750642434;6314.778982735582;6327.810165695037;6366.6180029198395;6372.776952806629;6396.808095757135;6428.19647544057;6442.484601231984;6451.451626611697;6456.870862582816;6458;6382.808515744535;6394.840128996812;6403.423691867754;6408.967955160288;6421.197350331208;6274.843128921813;6300.054991751183;6377.5535712500605;6382.074599183093;6408.743650254031;5129.384473863161;5202.03762303975;5247.291615631917;5252;5254.605904557174;4620.514845941195;4633.559811817872;4636;4675.2052151134385;4691.366665500182;4650.604698600657;6080.391960803884;6136.9079463808075;6145.108959200891;6148.754049837957;6306.24325080984;6373.107764912916;6388.616682999035;6418.646974416359;6487.448566871774;6024.096385542204;6110.7106460192745;6114.358196333954;6120.812855101315;6129.389354848322;5664.943350566524;5717;5725.59920805548;5726;5748.137779333133;5213.6350455467755;6420.711068002044;6485.967570162119;6625.834354141089;6628.403443690091;5467.781288748564;5495.53287970527;6369.14016607752;6430.807075787734;6485.902711459426;6623.801285961429;6646;6653.0020496925845;6653.201615806134;6654.3012983637955;6233.719482623384;6356.237251529846;6383.36166383358;6403.743850245938;6416.390442907917;6360.936390636034;6426.068220108152;6447.3552644735155;6494.285628580947;6495.512836537184;6344.270408903035;6351.2060992375955;6353.205849268841;6370;6370.55406121567;6320.1467801848;6343.619382837044;6352.68236588178;6357.110004599267;6375.904361434489;6127.050307202391;6145.555794388404;6183;6184.350643182401;6246.625202487865;6335.619862808247;6367.07677386767;6375.266844312778;6380.93619063822;6381.29805721361;6175;6242.65665388408;6242.969909964805;6263.342349053284;6275.466585340298 04:18:36 INFO - PID 1631 | |1;ext.html;548.6050043968341;675.9662016899154;784.1296161260999;1072.0994364733622;1150.321310426848;27072.86463567682;36633.26733465333;37178.25643487132;37189.07027324318;37211;38580.80709596455;39050.60949390505;39058;39093.60906390935;39112;8546.273566746819;8695.130486951317;8701.47791132534;8711.172438618321;8716.564171791417;6136.601120927147;6274.278457977322;8402.285805706522;8564.700235491759;8613.22480976715;8562.828743425127;8648;8660.047394786568;8665.480071195749;8667.4366166199;8562.486250824939;8623.913760862437;8634.654613815439;8638.697645582437;8644.999999999969;8500.064992850781;8549.273311768507;8562.143785621389;8567.95716021422;8583.227509524111;36512.81743591265;36799.816000920095;36825;36837;36873.81563092194;3622.5471816022996;3660.670539651444;3666.6150054244185;3670.944935825965;3671.8531258749617;30237.848810755804;30262.84868575665;30368.240793980105;30411.391772164432;30418.695813041806;3101.705337992887;3158.1788734928855;3171.476706343474;3186.8406579671155;3194.6166460024947;262875;267949;268564;269007.96488052694;270021;47914.760426197645;47964.5203547967;47985.56043318706;47998.800029998834;48083.27875081877;50103.74948125236;50162.74918625384;50186.74906625444;50223.995520090124;50307;14021.649458763408;14036.929815350857;14154.292285385689;14155.433782648579;14183.71632567343;9947.104760571583;11603.187776855539;11619.88380116205;11625.24435911663;11718.70703232409;10276.897231027744;10330.173586113093;11557;11675.76648467026;11739.706507337385;4380.627646650007;5105.412877519058;5157.613179011589;5182.2485739567555;5190;972.8929817720045;1010.4897027001464;1034.2863424237253;1048.8793788714243;1075.596651255779;23171;24340.21400622827;24400.02399903984;24442.846159569595;24454.633180502307;1130.2596799096605;1131.3357044161046;1149.5401839264362;1175.4710380328715;1182.1252273317682;12292.078094142975;12387.876121238673;12403.75192496145;12419.813702794465;12592.622221333191;335525.9013344405;336269.3186534052;336763;338333;338510;52048.47951520512;52147.30674239337;52169;52195.73902130465;52336.738316308176;1518.5444366689949;1524.8322684504697;1566.1934103936483;1574.2994367506349;1576.085870195284;23466.76533234646;23484;23540.646890297;23544;23547.76452235456;37035.074123146056;37139.25721485501;37146.44280335743;37151.62848371482;37161.25677486381;306370;306703;306903;307481;308388;32747.017589472354;33065.834670826494;33387.332253355286;33396.499052514715;33426.99719008434;44097;44342.334864977696;44384.556154439335;44390.3341449872;44427;23665.171718989754;28517.42965140644;28994.7100528992;30205;30623.08130756081;30112.397752045275;30173.943911962975;30517.847410762803;30798.076057718303;31015.534766978966;33725.15687107842;35085.47371789476;36116.735914242876;36472.63527364693;36530.452043218844;27806.86096569585;28558.857205713837;28932.98734544281;31172.908948186705;31761.682383176798;20896.68654970207;22542.436439089153;23226;23321.650175247047;23880.88059559691 04:18:36 INFO - PID 1631 | |2;jquery.html;385.4821492112441;419.80551273474697;437.6564396948396;438.7630679433106;450.6980323183467;17807.55481112973;21640.567188656216;21822.563548729056;22380.440488987762;22661.433464163405;18964.051797410142;22628.20801271956;22941.77058229417;23451.882740586272;24479.75520244797;6076.635401875901;6180.536459765524;6207.131001659771;6292.0247361658785;6358.84102897429;3717.57247916489;3904.5509766376945;6142.447179753821;6290.025046117859;6293.5909165904295;3840.5007349044586;3886;3892.9294444027837;3944.3097457944887;6318.936810631903;6293.811185664437;6300;6324.241091069055;6329.620222786624;6335.89121903665;4640;4859.465458799529;5408.188771684239;5509.090999985037;5515.779368825242;28372.858135709397;28472.28819279514;28702.712972870213;28714.994975175978;29064.128076157536;2176.62997290461;2239.6304609739373;2242.5627002734473;2244.494988627562;2245.0234148145446;15112.848871511364;17986.91006544972;18102.45692629223;18730.81269187304;18878.81121188784;2148.924787632441;2159.406163305088;2235.184157782414;2240.2943072931976;2242.260054182132;152260.2386988058;152492;155129.2243538775;160545.39454605538;171111.43332849894;11681.415929203506;11699.473523691455;11927;12484.126111172312;12607.306598137191;15516.379344826306;15565.455209067628;16517.33930642761;16817;17002.914985424995;9022.909770902339;9053.004169541346;9154.633814647339;9286.210672092948;9301.069893010645;8742.737717868475;8760.167784060504;8794.120587941283;8955.149260820212;8957.238634716123;7839.824870927284;7971.880421793678;8021.799455013671;8022.358211343078;8038.477498962666;2174.3042226487373;2174.467255522407;2177.4338671945407;2181.4110190248543;2331.2306938710185;812.4110020235282;955.9665411710696;956.9425784508157;964.1370972979284;1001.2590682894605;20649.793502065088;21246.2563810269;21270;21337.46656333573;21644.35066947994;869.8474521259357;956.321012081416;970.0978090375877;994.2112374788643;1010.0656892374524;10725.51735171919;10884.129269658566;10904.836427453594;10943.616973405893;11029.393383363991;706333;715901;722720;724722;732635;126659;144968.27515862352;153426.6985995211;159418;159892;1153.659670397218;1163.9010684091777;1186.3119390753343;1189.4766302826729;1191.797394442964;16571.751423728412;17981.73027404564;18253.81350212232;18668.439946801616;18889.811101888805;64763.67618161879;65683.83887971501;66202.33797662155;66464.66767666131;67048.32951670421;88948.76819708815;89707.55146224228;89919.55040224757;90272.54863725639;92988.60517092113;8824;8897.332700047393;9055.818883622422;9062.682806101755;9065.184133428023;13829.585112446643;14453.783193251898;14591.635209119857;14795.482158124414;14902.329395177027;12114.091443141624;12256.38718064111;12358.50565977351;12526.937365313115;12657.556985505464;11418.771624567627;11460.94269528647;11599.942000289944;11615.303081815118;11837.526498939946;9569.521523923915;11712;12025;12077.879221207675;12506.874931250572;8761.956190219009;8792.824143517222;8815.779605509913;9230.123138301851;9282.489463079595;10516.26386152962;11893.702657433287;12010;12140.453679584616;12347.62957111288 04:18:36 INFO - PID 1631 | |3;mootools.html;1318.18272670944;1430.7996880436733;1447.1751101871935;1454.5490897821683;1454.5636309107265;11299.717507062327;11356.886431135687;11897.226680265776;11902.34537100459;11908.40457977101;11522.942385288063;11966.34185119818;12002.279863208214;12016.519339226421;12017.978471829905;2485.7887079598254;2557.0538900606707;2560.1679454177374;2561.1420174241557;2564.3717289264155;2126.383348828838;2408.3738228060743;2505.1482495951373;2550.7321731218235;2552.8213025088253;2165.566886622682;2166.2201607421393;2192.6710993350966;2457.979938325602;2527.9241622751347;2484.3789052736815;2506.2982364937848;2516.9748302517014;2517.7230504644476;2521.0798058708438;2491.750824917512;2492.7507249274927;2503.249025292405;2504.3613878460874;2507.059852555292;11732.472038758277;11965.581204657796;11974.161808673396;11997.400129993553;12060.517579296818;5481.808136715235;6372.522060845409;6701.296363881771;6720.462363010996;6723.899141512881;4002.9199416011807;4215.557366476537;4308.095299987007;4319.157764235975;4376.409184760048;1245.875412458756;1253.9874601253962;1271.7011502296953;1311.4360824845312;1319.155740326192;16166.353345866151;16528.83471165285;16535.338586456528;16545.91727041369;16572;5776.855578610484;5853.853653658693;6062.484688801413;6086.2696476422225;6104.786332478431;14039.157650540796;14042;14056.367463464168;14057.22685252321;14064.226467544178;6756.189257289058;6775.1531058617675;6777.2545020047755;6777.72889084441;6778.084958530535;6052.848678782978;6069.575129740964;6115.510759139258;6217.937820621826;6224.751009959641;4559.430071241095;4712.246040633482;4725.36207611968;4761.928571071437;4765.642576806753;1435.2321507993381;1485.5543336998858;1487.5983484459352;1505.3376514333659;1518.627936155649;663.1017102869945;698.6332175607846;780.2197802197802;790.7469609724833;804.8752443371287;6624.966875165594;6802.421794147553;6803.523753337219;6898.862022759517;6921.792346229621;557.9386267510571;571.451406649621;592.8517870532366;603.8279090459198;713.8108401273666;4145.3781932710335;4163.375493675912;4172.228137794517;4263.445752052276;4267.8079486423185;14318.498852540111;15033.098014119189;15038.323275452412;15061.623459413602;15063.623409414853;14628.561143165722;14891.106533608017;14926.402943882124;15225.467108651366;15229.1623960681;10707.62523311696;10992.725181870357;10993;11002.50488728025;11021.83467247992;6642.6014439133805;6908.516403851682;7102.786916392516;7121.572705637678;7143.249958754256;13340.733185336432;13530.864691352961;13738.313084345942;13767.173969561858;13793.24137172465;13837.654058648613;13871.237081960186;13909.930450347683;14046.578602641937;14168.787468188191;9376.906230937604;9490.478023708762;9589.42463452195;9593.90406095958;9599.760005999906;10491.895081049091;10498.685039448828;10648.201384896009;10652.946735266274;10657.307275027099;8928.86606700913;9066.863997039918;9093.090690930854;9270.953645231732;9299.442033477742;8722.91277087221;8784.648614055623;8881.600327985127;8897.332700047393;8959.910400895908;7857.85835424326;7894.960525197567;8004.599770011592;8012.879806803019;8044.477108987897;5602.915956260741;5966.224390829165;6016.157737916607;6110.388961103854;6117.755289788359;5628.183913332462;6043.848903777441;6182.28903676083;6250.187475628321;6342.714577843916 04:18:36 INFO - PID 1631 | |4;prototype.html;345.8707320598249;381.8052793075531;398.2214770124407;407.055630936228;408.28142469254124;5856.795012174574;5873.647581145135;5897.3218079920825;5935.347111817697;5967.433093856082;5086.821961231358;5383.407825139241;5730.885382292352;5816.302043754756;5830.854228644275;4418.332783789447;4443.488998765135;4448.55237191177;4467.82128714851;4476.7090139140855;4429.667774916878;4459.732416055031;4462.620677242438;4462.638895136982;4487.416635837337;3582.767120137196;3863.343231650612;4286.6871126001015;4369.90752311922;4372.97813510932;3594.8741794037082;3612.1577995222365;3744.4570537271943;4373.059792144704;4429.269170586866;3369.5956485221686;3681.4845921571;3885.9611403886165;3908.55051669056;3915.9804200979097;4407.691461597689;5506.752196151183;5653.265075540154;5723.599348045638;5736.397678243766;3779.244151169777;4829.855104346875;5120.590352771769;5323.973380133113;5367.973160134175;5432;6206.472449841769;6218.564700470969;6246.094316324153;6246.906296405557;4260.9147817043795;4469.418975533193;4476.418065651477;4484.215262329079;4491.595756381941;5863.912041319383;6233.470155036782;6428.903566446507;6470.482361411123;6498.187726534231;3878.534575850916;4574.565416285448;4666.253399456071;4706.3175839503765;4707.223308154116;4146.5853414658895;4791.448983366888;4792.592629626521;4794.113089078532;4808.471068182497;4681.531846815291;4953.925691114636;5085.516421251455;5361.195820626859;5438.492172548684;4821.9035619287415;6335.556511044183;6368.949123394681;6372.107904893319;6373.235211774524;1584.247482445852;1599.4002249156567;1638.9836101639069;1639.2705246165342;1648.250046228963;1077.3482043363808;1134.8354488599107;1142.405948906564;1144.3019757947645;1155.7110722319421;5949.553783466257;5956.940430595725;5958.999999999914;5972.193753843176;5972.223610930551;5772.758856845799;6255;6546.934530654633;6581.473482121419;6609.182474819463;4924.532169443897;5706.400827913092;5851.531877449794;5861.736221869941;5870.207521984563;2949;3372.51098590703;3379;3395.828439188476;3396.711279541267;5755.827325180251;5850.444207800252;6319.462845658079;6530.934690653127;6638.5684930479365;5060.367454068241;5534.529564987021;6215.787921355382;6694.230163531256;6789.287124851919;4999.42506611737;5281.230787686168;5446.2647542582035;5974.834907193055;6686.398224159849;5095.617828662791;5288.130175505263;6143.232095988002;6459.354064593503;6570.995846266935;6146.385361463817;6202.596831205957;6309.242890852944;6482.546221764431;6497.252815926229;4927.384076990376;6251.4061164189325;6605.768798092044;6742.258351581224;6756.493263005196;4294.024748615671;4319.805608747551;4326.437563116775;4336.869893903188;4351.021020270414;5708.200851880823;6261.467775239155;6507.381798729113;6577.572457790228;6591.5056370773345;5638.915416268677;6031.24609423822;6368.363163683594;6380.617162970237;6396.456301214449;5509;6096.725647345791;6313.46335561464;6360.77737279193;6377.23473183221;4408.691391602557;5244.426671998462;6109.450149486567;6178.227721534809;6187.3503282154725;5510.641808282448;6089.903817312927;6294.244690637152;6354.936450635434;6399.8720025598295;6083.49880808414;6142.775043102407;6152.846178845564;6181;6237.4074462927765 04:18:36 INFO - PID 1631 | |5;yui.html;690.0994202565649;836.5315423362915;854.4488804720951;854.6581367453022;863.4991704811212;13362.732745345087;17924.82075179248;18104.728429073573;18630.62738745224;18658.97375644339;17066.23201955912;17143.914280428613;17553.3856315029;17578.033208173547;17595.38416155435;948.9620415183384;992.4045572656421;997.8154041502308;998.2762497189552;999.9900001000007;663.4692246203042;683.4498228925713;965.4689920543708;1009.7627057641448;1017.3234798858787;1042.6298663974294;1047.7799662070975;1050.6217761605815;1051.1800795379577;1053.836655318427;1042.3589492462156;1044.1281529922485;1045.3571053801895;1047.1413440978401;1047.1779652972457;775.7982924439686;776.4836383804763;776.6543887969856;776.763087258386;776.7863837444692;16234.918825405797;16541;16715.91642041782;16738.24677889498;17010.31958721662;16415;16451.753223701653;16580.917095414447;16848.57878553046;16872.746908796376;13520.18878867271;13656.590302290948;13725.313734313244;13842.792358114637;13876.722465550733;2980.5678176664264;3350.5141754445467;3365.932681346384;3370.814605196738;3371.258323168899;109527;109999;110010;110098;111271;11074.39090850011;11881;11989.520419183134;12103;12120.757584848254;17324.220410081576;19072.904635476734;19408.514787130152;19479.565054368202;24507.897144628536;8778.517181555077;8793.91206087931;8983.775405614912;8992.685256016008;9003.639854405881;4868.440129385095;4939.135651261015;4978.825741099116;4979.850604481871;4981.32752078472;4204.789760511962;4260.10537787062;4295.4201182839915;4322.595156574063;4329.264025115738;909.4134283387178;930.8976012638605;931.2689538712214;937.8640097186006;938.9671361502315;540.2814257038129;636.38270877249;642.7750287399466;646.1180488632982;677.6340775981014;11364.886351136549;11427.142964277546;11816.877396647305;11900.228389231215;12211.69470763238;624.1106423346713;642.1459458919626;647.6179054357951;656.2748163279603;673.8888083466173;4850.296706977469;5140.588752899759;5287.920681189786;5348.438413966555;5516.806911758069;105231;107393;108207;108802.91197088086;112029.87970120195;86383.70424443639;87113;88030.99612548431;88855.55572222098;89471.55264223638;63772.043419348745;78617.60691196508;78742.60628696819;79176.60411697904;79192;9806.754831128994;10122.785265768154;10932.0707739843;11105.888941110485;11164.776704466027;41134;41324.793376032925;42672;42712.145757084065;43526;37016;45537.861553460105;46904.82737931579;51057.489425105276;51934;13445.058845881085;14060.367283472473;14135.293235338399;14329.426822927384;14344.713105738036;15468.84531154674;15475.613109672347;15478;15626.687466250838;15645.295961681524;14521.564353069425;14602.85397146015;14719.337629806898;16109.194540273174;17302.134893255537;16619.41832035873;16861.91569042147;17016.57458563546;17196.312147514458;17328;16177.75733364024;16512.25694843711;16525.256363463912;16777.077260750775;16783.832161678714;9087.818243634958;10447.00753428423;12035.277883327028;12163.695907602027;12231.204971676812;11086.390248536409;11898.583549575724;12405.007599392207;13070.281134537692;13080.476780929037 04:18:36 INFO - PID 1631 | __end_tp_report 04:18:36 INFO - PID 1631 | __start_cc_report 04:18:36 INFO - PID 1631 | _x_x_mozilla_cycle_collect,1620 04:18:36 INFO - PID 1631 | __end_cc_report 04:18:36 INFO - PID 1631 | __startTimestamp1491909516061__endTimestamp 04:18:36 INFO - PID 1631 | 04:18:36 INFO - PID 1631 | ------- Summary: start ------- 04:18:36 INFO - PID 1631 | Number of tests: 6 04:18:36 INFO - PID 1631 | 04:18:36 INFO - PID 1631 | [#0] dojo.html Cycles:165 Average:5914.44 Median:6184.35 stddev:696.50 (11.3%) stddev-sans-first:664.14 04:18:36 INFO - PID 1631 | Values: 3154.8 3422.2 3430.6 3445.8 3492.7 5245.5 5458.6 6115.3 6139.2 6140.4 5878.4 5981.5 6059.0 6090.8 6136.8 5093.1 5187.5 5192.8 5206.1 5209.9 5262.5 5320.1 5344.2 5345.8 5387.0 5151.7 5218.3 5236.6 5238.7 5296.7 5198.5 5206.4 5213.6 5217.0 5217.1 5109.8 5158.3 5159.3 5193.7 5290.9 5202.0 5934.7 6012.7 6130.9 6131.2 6356.0 6398.2 6403.1 6403.5 6404.7 6216.6 6404.8 6436.9 6445.0 6455.4 5964.8 5998.1 6002.7 6005.4 6007.4 6399.2 6399.3 6407.8 6424.7 6424.9 6314.8 6327.8 6366.6 6372.8 6396.8 6428.2 6442.5 6451.5 6456.9 6458.0 6382.8 6394.8 6403.4 6409.0 6421.2 6274.8 6300.1 6377.6 6382.1 6408.7 5129.4 5202.0 5247.3 5252.0 5254.6 4620.5 4633.6 4636.0 4675.2 4691.4 4650.6 6080.4 6136.9 6145.1 6148.8 6306.2 6373.1 6388.6 6418.6 6487.4 6024.1 6110.7 6114.4 6120.8 6129.4 5664.9 5717.0 5725.6 5726.0 5748.1 5213.6 6420.7 6486.0 6625.8 6628.4 5467.8 5495.5 6369.1 6430.8 6485.9 6623.8 6646.0 6653.0 6653.2 6654.3 6233.7 6356.2 6383.4 6403.7 6416.4 6360.9 6426.1 6447.4 6494.3 6495.5 6344.3 6351.2 6353.2 6370.0 6370.6 6320.1 6343.6 6352.7 6357.1 6375.9 6127.1 6145.6 6183.0 6184.4 6246.6 6335.6 6367.1 6375.3 6380.9 6381.3 6175.0 6242.7 6243.0 6263.3 6275.5 04:18:36 INFO - PID 1631 | 04:18:36 INFO - PID 1631 | [#1] ext.html Cycles:180 Average:45004.23 Median:184476.45 stddev:80209.10 (43.5%) stddev-sans-first:80364.66 04:18:36 INFO - PID 1631 | Values: 548.6 676.0 784.1 1072.1 1150.3 27072.9 36633.3 37178.3 37189.1 37211.0 38580.8 39050.6 39058.0 39093.6 39112.0 8546.3 8695.1 8701.5 8711.2 8716.6 6136.6 6274.3 8402.3 8564.7 8613.2 8562.8 8648.0 8660.0 8665.5 8667.4 8562.5 8623.9 8634.7 8638.7 8645.0 8500.1 8549.3 8562.1 8568.0 8583.2 36512.8 36799.8 36825.0 36837.0 36873.8 3622.5 3660.7 3666.6 3670.9 3671.9 30237.8 30262.8 30368.2 30411.4 30418.7 3101.7 3158.2 3171.5 3186.8 3194.6 262875.0 267949.0 268564.0 269008.0 270021.0 47914.8 47964.5 47985.6 47998.8 48083.3 50103.7 50162.7 50186.7 50224.0 50307.0 14021.6 14036.9 14154.3 14155.4 14183.7 9947.1 11603.2 11619.9 11625.2 11718.7 10276.9 10330.2 11557.0 11675.8 11739.7 4380.6 5105.4 5157.6 5182.2 5190.0 972.9 1010.5 1034.3 1048.9 1075.6 23171.0 24340.2 24400.0 24442.8 24454.6 1130.3 1131.3 1149.5 1175.5 1182.1 12292.1 12387.9 12403.8 12419.8 12592.6 335525.9 336269.3 336763.0 338333.0 338510.0 52048.5 52147.3 52169.0 52195.7 52336.7 1518.5 1524.8 1566.2 1574.3 1576.1 23466.8 23484.0 23540.6 23544.0 23547.8 37035.1 37139.3 37146.4 37151.6 37161.3 306370.0 306703.0 306903.0 307481.0 308388.0 32747.0 33065.8 33387.3 33396.5 33427.0 44097.0 44342.3 44384.6 44390.3 44427.0 23665.2 28517.4 28994.7 30205.0 30623.1 30112.4 30173.9 30517.8 30798.1 31015.5 33725.2 35085.5 36116.7 36472.6 36530.5 27806.9 28558.9 28933.0 31172.9 31761.7 20896.7 22542.4 23226.0 23321.7 23880.9 04:18:36 INFO - PID 1631 | 04:18:36 INFO - PID 1631 | [#2] jquery.html Cycles:180 Average:41558.12 Median:22644.82 stddev:120713.71 (533.1%) stddev-sans-first:121012.76 04:18:36 INFO - PID 1631 | Values: 385.5 419.8 437.7 438.8 450.7 17807.6 21640.6 21822.6 22380.4 22661.4 18964.1 22628.2 22941.8 23451.9 24479.8 6076.6 6180.5 6207.1 6292.0 6358.8 3717.6 3904.6 6142.4 6290.0 6293.6 3840.5 3886.0 3892.9 3944.3 6318.9 6293.8 6300.0 6324.2 6329.6 6335.9 4640.0 4859.5 5408.2 5509.1 5515.8 28372.9 28472.3 28702.7 28715.0 29064.1 2176.6 2239.6 2242.6 2244.5 2245.0 15112.8 17986.9 18102.5 18730.8 18878.8 2148.9 2159.4 2235.2 2240.3 2242.3 152260.2 152492.0 155129.2 160545.4 171111.4 11681.4 11699.5 11927.0 12484.1 12607.3 15516.4 15565.5 16517.3 16817.0 17002.9 9022.9 9053.0 9154.6 9286.2 9301.1 8742.7 8760.2 8794.1 8955.1 8957.2 7839.8 7971.9 8021.8 8022.4 8038.5 2174.3 2174.5 2177.4 2181.4 2331.2 812.4 956.0 956.9 964.1 1001.3 20649.8 21246.3 21270.0 21337.5 21644.4 869.8 956.3 970.1 994.2 1010.1 10725.5 10884.1 10904.8 10943.6 11029.4 706333.0 715901.0 722720.0 724722.0 732635.0 126659.0 144968.3 153426.7 159418.0 159892.0 1153.7 1163.9 1186.3 1189.5 1191.8 16571.8 17981.7 18253.8 18668.4 18889.8 64763.7 65683.8 66202.3 66464.7 67048.3 88948.8 89707.6 89919.6 90272.5 92988.6 8824.0 8897.3 9055.8 9062.7 9065.2 13829.6 14453.8 14591.6 14795.5 14902.3 12114.1 12256.4 12358.5 12526.9 12657.6 11418.8 11460.9 11599.9 11615.3 11837.5 9569.5 11712.0 12025.0 12077.9 12506.9 8762.0 8792.8 8815.8 9230.1 9282.5 10516.3 11893.7 12010.0 12140.5 12347.6 04:18:36 INFO - PID 1631 | 04:18:36 INFO - PID 1631 | [#3] mootools.html Cycles:180 Average:7295.84 Median:2554.94 stddev:4644.21 (181.8%) stddev-sans-first:4635.51 04:18:36 INFO - PID 1631 | Values: 1318.2 1430.8 1447.2 1454.5 1454.6 11299.7 11356.9 11897.2 11902.3 11908.4 11522.9 11966.3 12002.3 12016.5 12018.0 2485.8 2557.1 2560.2 2561.1 2564.4 2126.4 2408.4 2505.1 2550.7 2552.8 2165.6 2166.2 2192.7 2458.0 2527.9 2484.4 2506.3 2517.0 2517.7 2521.1 2491.8 2492.8 2503.2 2504.4 2507.1 11732.5 11965.6 11974.2 11997.4 12060.5 5481.8 6372.5 6701.3 6720.5 6723.9 4002.9 4215.6 4308.1 4319.2 4376.4 1245.9 1254.0 1271.7 1311.4 1319.2 16166.4 16528.8 16535.3 16545.9 16572.0 5776.9 5853.9 6062.5 6086.3 6104.8 14039.2 14042.0 14056.4 14057.2 14064.2 6756.2 6775.2 6777.3 6777.7 6778.1 6052.8 6069.6 6115.5 6217.9 6224.8 4559.4 4712.2 4725.4 4761.9 4765.6 1435.2 1485.6 1487.6 1505.3 1518.6 663.1 698.6 780.2 790.7 804.9 6625.0 6802.4 6803.5 6898.9 6921.8 557.9 571.5 592.9 603.8 713.8 4145.4 4163.4 4172.2 4263.4 4267.8 14318.5 15033.1 15038.3 15061.6 15063.6 14628.6 14891.1 14926.4 15225.5 15229.2 10707.6 10992.7 10993.0 11002.5 11021.8 6642.6 6908.5 7102.8 7121.6 7143.2 13340.7 13530.9 13738.3 13767.2 13793.2 13837.7 13871.2 13909.9 14046.6 14168.8 9376.9 9490.5 9589.4 9593.9 9599.8 10491.9 10498.7 10648.2 10652.9 10657.3 8928.9 9066.9 9093.1 9271.0 9299.4 8722.9 8784.6 8881.6 8897.3 8959.9 7857.9 7895.0 8004.6 8012.9 8044.5 5602.9 5966.2 6016.2 6110.4 6117.8 5628.2 6043.8 6182.3 6250.2 6342.7 04:18:36 INFO - PID 1631 | 04:18:36 INFO - PID 1631 | [#4] prototype.html Cycles:180 Average:5036.83 Median:5507.88 stddev:1527.37 (27.7%) stddev-sans-first:1490.52 04:18:36 INFO - PID 1631 | Values: 345.9 381.8 398.2 407.1 408.3 5856.8 5873.6 5897.3 5935.3 5967.4 5086.8 5383.4 5730.9 5816.3 5830.9 4418.3 4443.5 4448.6 4467.8 4476.7 4429.7 4459.7 4462.6 4462.6 4487.4 3582.8 3863.3 4286.7 4369.9 4373.0 3594.9 3612.2 3744.5 4373.1 4429.3 3369.6 3681.5 3886.0 3908.6 3916.0 4407.7 5506.8 5653.3 5723.6 5736.4 3779.2 4829.9 5120.6 5324.0 5368.0 5432.0 6206.5 6218.6 6246.1 6246.9 4260.9 4469.4 4476.4 4484.2 4491.6 5863.9 6233.5 6428.9 6470.5 6498.2 3878.5 4574.6 4666.3 4706.3 4707.2 4146.6 4791.4 4792.6 4794.1 4808.5 4681.5 4953.9 5085.5 5361.2 5438.5 4821.9 6335.6 6368.9 6372.1 6373.2 1584.2 1599.4 1639.0 1639.3 1648.3 1077.3 1134.8 1142.4 1144.3 1155.7 5949.6 5956.9 5959.0 5972.2 5972.2 5772.8 6255.0 6546.9 6581.5 6609.2 4924.5 5706.4 5851.5 5861.7 5870.2 2949.0 3372.5 3379.0 3395.8 3396.7 5755.8 5850.4 6319.5 6530.9 6638.6 5060.4 5534.5 6215.8 6694.2 6789.3 4999.4 5281.2 5446.3 5974.8 6686.4 5095.6 5288.1 6143.2 6459.4 6571.0 6146.4 6202.6 6309.2 6482.5 6497.3 4927.4 6251.4 6605.8 6742.3 6756.5 4294.0 4319.8 4326.4 4336.9 4351.0 5708.2 6261.5 6507.4 6577.6 6591.5 5638.9 6031.2 6368.4 6380.6 6396.5 5509.0 6096.7 6313.5 6360.8 6377.2 4408.7 5244.4 6109.5 6178.2 6187.4 5510.6 6089.9 6294.2 6354.9 6399.9 6083.5 6142.8 6152.8 6181.0 6237.4 04:18:36 INFO - PID 1631 | 04:18:36 INFO - PID 1631 | [#5] yui.html Cycles:180 Average:20654.66 Median:17586.71 stddev:28886.19 (164.3%) stddev-sans-first:28928.32 04:18:36 INFO - PID 1631 | Values: 690.1 836.5 854.4 854.7 863.5 13362.7 17924.8 18104.7 18630.6 18659.0 17066.2 17143.9 17553.4 17578.0 17595.4 949.0 992.4 997.8 998.3 1000.0 663.5 683.4 965.5 1009.8 1017.3 1042.6 1047.8 1050.6 1051.2 1053.8 1042.4 1044.1 1045.4 1047.1 1047.2 775.8 776.5 776.7 776.8 776.8 16234.9 16541.0 16715.9 16738.2 17010.3 16415.0 16451.8 16580.9 16848.6 16872.7 13520.2 13656.6 13725.3 13842.8 13876.7 2980.6 3350.5 3365.9 3370.8 3371.3 109527.0 109999.0 110010.0 110098.0 111271.0 11074.4 11881.0 11989.5 12103.0 12120.8 17324.2 19072.9 19408.5 19479.6 24507.9 8778.5 8793.9 8983.8 8992.7 9003.6 4868.4 4939.1 4978.8 4979.9 4981.3 4204.8 4260.1 4295.4 4322.6 4329.3 909.4 930.9 931.3 937.9 939.0 540.3 636.4 642.8 646.1 677.6 11364.9 11427.1 11816.9 11900.2 12211.7 624.1 642.1 647.6 656.3 673.9 4850.3 5140.6 5287.9 5348.4 5516.8 105231.0 107393.0 108207.0 108802.9 112029.9 86383.7 87113.0 88031.0 88855.6 89471.6 63772.0 78617.6 78742.6 79176.6 79192.0 9806.8 10122.8 10932.1 11105.9 11164.8 41134.0 41324.8 42672.0 42712.1 43526.0 37016.0 45537.9 46904.8 51057.5 51934.0 13445.1 14060.4 14135.3 14329.4 14344.7 15468.8 15475.6 15478.0 15626.7 15645.3 14521.6 14602.9 14719.3 16109.2 17302.1 16619.4 16861.9 17016.6 17196.3 17328.0 16177.8 16512.3 16525.3 16777.1 16783.8 9087.8 10447.0 12035.3 12163.7 12231.2 11086.4 11898.6 12405.0 13070.3 13080.5 04:18:36 INFO - PID 1631 | -------- Summary: end -------- 04:18:36 INFO - PID 1631 | 04:18:36 INFO - TEST-INFO | 1631: exit 0 04:18:36 INFO - TEST-OK | dromaeo_css | took 1120251ms 04:18:36 INFO - TEST-START | kraken 04:18:36 INFO - operating with platform_type : mac_ 04:18:36 INFO - Initialising browser for kraken test... 04:18:36 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmp43gxF2/profile http://localhost:49236/getInfo.html) 04:18:39 INFO - PID 1642 | __metrics Screen width/height:1600/1200 04:18:39 INFO - PID 1642 | colorDepth:24 04:18:39 INFO - PID 1642 | Browser inner width/height: 1024/689 04:18:39 INFO - PID 1642 | __metrics 04:18:39 INFO - PID 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:18:39 INFO - PID 1642 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:40 INFO - TEST-INFO | 1642: exit 0 04:18:40 INFO - Browser initialized. 04:18:40 INFO - Running cycle 1/1 for kraken test... 04:18:40 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmp43gxF2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:53 INFO - PID 1643 | RSS: Main: 232091648 04:18:53 INFO - PID 1643 | 04:18:56 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:57 INFO - PID 1643 | RSS: Main: 292265984 04:18:57 INFO - PID 1643 | 04:18:59 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 04:19:00 INFO - PID 1643 | RSS: Main: 294850560 04:19:00 INFO - PID 1643 | 04:19:04 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 04:19:04 INFO - PID 1643 | RSS: Main: 387960832 04:19:04 INFO - PID 1643 | 04:19:07 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 04:19:07 INFO - PID 1643 | RSS: Main: 290160640 04:19:07 INFO - PID 1643 | 04:19:09 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:10 INFO - PID 1643 | RSS: Main: 292020224 04:19:10 INFO - PID 1643 | 04:19:13 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:14 INFO - PID 1643 | RSS: Main: 334761984 04:19:14 INFO - PID 1643 | 04:19:17 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:18 INFO - PID 1643 | RSS: Main: 344481792 04:19:18 INFO - PID 1643 | 04:19:21 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 04:19:22 INFO - PID 1643 | RSS: Main: 351637504 04:19:22 INFO - PID 1643 | 04:19:23 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:24 INFO - PID 1643 | RSS: Main: 311037952 04:19:24 INFO - PID 1643 | 04:19:26 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:26 INFO - PID 1643 | RSS: Main: 315424768 04:19:26 INFO - PID 1643 | 04:19:29 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:29 INFO - PID 1643 | RSS: Main: 317251584 04:19:29 INFO - PID 1643 | 04:19:32 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:33 INFO - PID 1643 | RSS: Main: 334467072 04:19:33 INFO - PID 1643 | 04:19:37 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:37 INFO - PID 1643 | RSS: Main: 317353984 04:19:37 INFO - PID 1643 | 04:19:39 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 04:19:40 INFO - PID 1643 | RSS: Main: 383414272 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | __start_tp_report 04:19:40 INFO - PID 1643 | _x_x_mozilla_page_load 04:19:40 INFO - PID 1643 | _x_x_mozilla_page_load_details 04:19:40 INFO - PID 1643 | |i|pagename|runs| 04:19:40 INFO - PID 1643 | |0;ai-astar;110;123;124;124;123;122;123;124;122;123 04:19:40 INFO - PID 1643 | |1;audio-beat-detection;153;139;154;193;117;122;132;150;185;119 04:19:40 INFO - PID 1643 | |2;audio-dft;212;218;217;209;213;298;222;217;211;210 04:19:40 INFO - PID 1643 | |3;audio-fft;84;61;66;96;67;67;64;63;82;63 04:19:40 INFO - PID 1643 | |4;audio-oscillator;96;104;133;102;74;74;94;75;72;91 04:19:40 INFO - PID 1643 | |5;imaging-gaussian-blur;93;94;93;99;139;96;94;93;94;94 04:19:40 INFO - PID 1643 | |6;imaging-darkroom;101;102;102;102;102;103;109;101;102;102 04:19:40 INFO - PID 1643 | |7;imaging-desaturate;100;102;136;158;129;100;101;101;101;104 04:19:40 INFO - PID 1643 | |8;json-parse-financial;54;51;50;51;51;52;53;52;52;51 04:19:40 INFO - PID 1643 | |9;json-stringify-tinderbox;61;63;59;65;67;72;66;65;64;65 04:19:40 INFO - PID 1643 | |10;stanford-crypto-aes;95;117;113;92;92;95;106;115;117;92 04:19:40 INFO - PID 1643 | |11;stanford-crypto-ccm;155;151;154;153;152;153;158;150;192;157 04:19:40 INFO - PID 1643 | |12;stanford-crypto-pbkdf2;198;211;212;211;231;264;210;217;250;208 04:19:40 INFO - PID 1643 | |13;stanford-crypto-sha256-iterative;75;76;75;89;104;106;106;102;75;73 04:19:40 INFO - PID 1643 | __end_tp_report 04:19:40 INFO - PID 1643 | __start_cc_report 04:19:40 INFO - PID 1643 | _x_x_mozilla_cycle_collect,2177 04:19:40 INFO - PID 1643 | __end_cc_report 04:19:40 INFO - PID 1643 | __startTimestamp1491909580105__endTimestamp 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | ------- Summary: start ------- 04:19:40 INFO - PID 1643 | Number of tests: 14 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#0] ai-astar Cycles:10 Average:121.80 Median:123.00 stddev:4.21 (3.4%) stddev-sans-first:0.78 04:19:40 INFO - PID 1643 | Values: 110.0 123.0 124.0 124.0 123.0 122.0 123.0 124.0 122.0 123.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:151.50 stddev:26.35 (17.4%) stddev-sans-first:27.84 04:19:40 INFO - PID 1643 | Values: 153.0 139.0 154.0 193.0 117.0 122.0 132.0 150.0 185.0 119.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#2] audio-dft Cycles:10 Average:222.70 Median:217.00 stddev:26.77 (12.3%) stddev-sans-first:28.12 04:19:40 INFO - PID 1643 | Values: 212.0 218.0 217.0 209.0 213.0 298.0 222.0 217.0 211.0 210.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#3] audio-fft Cycles:10 Average:71.30 Median:67.00 stddev:11.78 (17.6%) stddev-sans-first:11.56 04:19:40 INFO - PID 1643 | Values: 84.0 61.0 66.0 96.0 67.0 67.0 64.0 63.0 82.0 63.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:74.50 stddev:19.09 (25.6%) stddev-sans-first:20.18 04:19:40 INFO - PID 1643 | Values: 96.0 104.0 133.0 102.0 74.0 74.0 94.0 75.0 72.0 91.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#5] imaging-gaussian-blur Cycles:10 Average:98.90 Median:94.00 stddev:14.21 (15.1%) stddev-sans-first:14.91 04:19:40 INFO - PID 1643 | Values: 93.0 94.0 93.0 99.0 139.0 96.0 94.0 93.0 94.0 94.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:102.00 stddev:2.32 (2.3%) stddev-sans-first:2.39 04:19:40 INFO - PID 1643 | Values: 101.0 102.0 102.0 102.0 102.0 103.0 109.0 101.0 102.0 102.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#7] imaging-desaturate Cycles:10 Average:113.20 Median:103.00 stddev:20.50 (19.9%) stddev-sans-first:21.18 04:19:40 INFO - PID 1643 | Values: 100.0 102.0 136.0 158.0 129.0 100.0 101.0 101.0 101.0 104.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.16 (2.2%) stddev-sans-first:0.88 04:19:40 INFO - PID 1643 | Values: 54.0 51.0 50.0 51.0 51.0 52.0 53.0 52.0 52.0 51.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:3.50 (5.4%) stddev-sans-first:3.44 04:19:40 INFO - PID 1643 | Values: 61.0 63.0 59.0 65.0 67.0 72.0 66.0 65.0 64.0 65.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#10] stanford-crypto-aes Cycles:10 Average:103.40 Median:92.00 stddev:11.23 (12.2%) stddev-sans-first:11.49 04:19:40 INFO - PID 1643 | Values: 95.0 117.0 113.0 92.0 92.0 95.0 106.0 115.0 117.0 92.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#11] stanford-crypto-ccm Cycles:10 Average:157.50 Median:154.50 stddev:12.38 (8.0%) stddev-sans-first:13.09 04:19:40 INFO - PID 1643 | Values: 155.0 151.0 154.0 153.0 152.0 153.0 158.0 150.0 192.0 157.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:221.20 Median:214.50 stddev:20.83 (9.7%) stddev-sans-first:20.33 04:19:40 INFO - PID 1643 | Values: 198.0 211.0 212.0 211.0 231.0 264.0 210.0 217.0 250.0 208.0 04:19:40 INFO - PID 1643 | 04:19:40 INFO - PID 1643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.10 Median:75.00 stddev:14.82 (19.8%) stddev-sans-first:14.94 04:19:40 INFO - PID 1643 | Values: 75.0 76.0 75.0 89.0 104.0 106.0 106.0 102.0 75.0 73.0 04:19:40 INFO - PID 1643 | -------- Summary: end -------- 04:19:40 INFO - PID 1643 | 04:19:41 INFO - TEST-INFO | 1643: exit 0 04:19:41 INFO - TEST-OK | kraken | took 64332ms 04:19:41 INFO - SUITE-END | took 1184s 04:19:41 INFO - Completed test suite (00:19:44) 04:19:41 INFO - javascript benchmark 04:19:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7739.198111466161, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.80117555329, 3422.1615704152478, 3430.6054803697566, 3445.758796884219, 3492.70312023478, 5245.531251249657, 5458.563314934806, 6115.327313995457, 6139.171211886394, 6140.385961403857, 5878.441548052939, 5981.5214782817375, 6058.969705151468, 6090.756369745205, 6136.785212517563, 5093.108705976458, 5187.507186817246, 5192.792288308463, 5206.114960456732, 5209.895802083956, 5262.526372626463, 5320.122179840322, 5344.198370244475, 5345.839624811242, 5387.0303345397815, 5151.716655583941, 5218.269442278084, 5236.607254455893, 5238.738063096868, 5296.655717378358, 5198.532132108128, 5206.401263854667, 5213.635045546814, 5217.034848553029, 5217.060929032773, 5109.772103567624, 5158.329417175781, 5159.277701121809, 5193.68837869729, 5290.947090529123, 5202.0, 5934.732937017845, 6012.729427175744, 6130.908036379458, 6131.202943617302, 6356.0, 6398.16823812906, 6403.0715546246, 6403.48772098231, 6404.7117879695525, 6216.595921265103, 6404.807855764335, 6436.903446448307, 6445.033245013238, 6455.354464553554, 5964.7912323068485, 5998.070299103646, 6002.729877155539, 6005.39946005396, 6007.36922623127, 6399.200099987502, 6399.264084630234, 6407.775727849503, 6424.71088801005, 6424.935750642434, 6314.778982735582, 6327.810165695037, 6366.6180029198395, 6372.776952806629, 6396.808095757135, 6428.19647544057, 6442.484601231984, 6451.451626611697, 6456.870862582816, 6458.0, 6382.808515744535, 6394.840128996812, 6403.423691867754, 6408.967955160288, 6421.197350331208, 6274.843128921813, 6300.054991751183, 6377.5535712500605, 6382.074599183093, 6408.743650254031, 5129.384473863161, 5202.03762303975, 5247.291615631917, 5252.0, 5254.605904557174, 4620.514845941195, 4633.559811817872, 4636.0, 4675.2052151134385, 4691.366665500182, 4650.604698600657, 6080.391960803884, 6136.9079463808075, 6145.108959200891, 6148.754049837957, 6306.24325080984, 6373.107764912916, 6388.616682999035, 6418.646974416359, 6487.448566871774, 6024.096385542204, 6110.7106460192745, 6114.358196333954, 6120.812855101315, 6129.389354848322, 5664.943350566524, 5717.0, 5725.59920805548, 5726.0, 5748.137779333133, 5213.6350455467755, 6420.711068002044, 6485.967570162119, 6625.834354141089, 6628.403443690091, 5467.781288748564, 5495.53287970527, 6369.14016607752, 6430.807075787734, 6485.902711459426, 6623.801285961429, 6646.0, 6653.0020496925845, 6653.201615806134, 6654.3012983637955, 6233.719482623384, 6356.237251529846, 6383.36166383358, 6403.743850245938, 6416.390442907917, 6360.936390636034, 6426.068220108152, 6447.3552644735155, 6494.285628580947, 6495.512836537184, 6344.270408903035, 6351.2060992375955, 6353.205849268841, 6370.0, 6370.55406121567, 6320.1467801848, 6343.619382837044, 6352.68236588178, 6357.110004599267, 6375.904361434489, 6127.050307202391, 6145.555794388404, 6183.0, 6184.350643182401, 6246.625202487865, 6335.619862808247, 6367.07677386767, 6375.266844312778, 6380.93619063822, 6381.29805721361, 6175.0, 6242.65665388408, 6242.969909964805, 6263.342349053284, 6275.466585340298], "value": 5869.158158956911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.6050043968341, 675.9662016899154, 784.1296161260999, 1072.0994364733622, 1150.321310426848, 27072.86463567682, 36633.26733465333, 37178.25643487132, 37189.07027324318, 37211.0, 38580.80709596455, 39050.60949390505, 39058.0, 39093.60906390935, 39112.0, 8546.273566746819, 8695.130486951317, 8701.47791132534, 8711.172438618321, 8716.564171791417, 6136.601120927147, 6274.278457977322, 8402.285805706522, 8564.700235491759, 8613.22480976715, 8562.828743425127, 8648.0, 8660.047394786568, 8665.480071195749, 8667.4366166199, 8562.486250824939, 8623.913760862437, 8634.654613815439, 8638.697645582437, 8644.999999999969, 8500.064992850781, 8549.273311768507, 8562.143785621389, 8567.95716021422, 8583.227509524111, 36512.81743591265, 36799.816000920095, 36825.0, 36837.0, 36873.81563092194, 3622.5471816022996, 3660.670539651444, 3666.6150054244185, 3670.944935825965, 3671.8531258749617, 30237.848810755804, 30262.84868575665, 30368.240793980105, 30411.391772164432, 30418.695813041806, 3101.705337992887, 3158.1788734928855, 3171.476706343474, 3186.8406579671155, 3194.6166460024947, 262875.0, 267949.0, 268564.0, 269007.96488052694, 270021.0, 47914.760426197645, 47964.5203547967, 47985.56043318706, 47998.800029998834, 48083.27875081877, 50103.74948125236, 50162.74918625384, 50186.74906625444, 50223.995520090124, 50307.0, 14021.649458763408, 14036.929815350857, 14154.292285385689, 14155.433782648579, 14183.71632567343, 9947.104760571583, 11603.187776855539, 11619.88380116205, 11625.24435911663, 11718.70703232409, 10276.897231027744, 10330.173586113093, 11557.0, 11675.76648467026, 11739.706507337385, 4380.627646650007, 5105.412877519058, 5157.613179011589, 5182.2485739567555, 5190.0, 972.8929817720045, 1010.4897027001464, 1034.2863424237253, 1048.8793788714243, 1075.596651255779, 23171.0, 24340.21400622827, 24400.02399903984, 24442.846159569595, 24454.633180502307, 1130.2596799096605, 1131.3357044161046, 1149.5401839264362, 1175.4710380328715, 1182.1252273317682, 12292.078094142975, 12387.876121238673, 12403.75192496145, 12419.813702794465, 12592.622221333191, 335525.9013344405, 336269.3186534052, 336763.0, 338333.0, 338510.0, 52048.47951520512, 52147.30674239337, 52169.0, 52195.73902130465, 52336.738316308176, 1518.5444366689949, 1524.8322684504697, 1566.1934103936483, 1574.2994367506349, 1576.085870195284, 23466.76533234646, 23484.0, 23540.646890297, 23544.0, 23547.76452235456, 37035.074123146056, 37139.25721485501, 37146.44280335743, 37151.62848371482, 37161.25677486381, 306370.0, 306703.0, 306903.0, 307481.0, 308388.0, 32747.017589472354, 33065.834670826494, 33387.332253355286, 33396.499052514715, 33426.99719008434, 44097.0, 44342.334864977696, 44384.556154439335, 44390.3341449872, 44427.0, 23665.171718989754, 28517.42965140644, 28994.7100528992, 30205.0, 30623.08130756081, 30112.397752045275, 30173.943911962975, 30517.847410762803, 30798.076057718303, 31015.534766978966, 33725.15687107842, 35085.47371789476, 36116.735914242876, 36472.63527364693, 36530.452043218844, 27806.86096569585, 28558.857205713837, 28932.98734544281, 31172.908948186705, 31761.682383176798, 20896.68654970207, 22542.436439089153, 23226.0, 23321.650175247047, 23880.88059559691], "value": 17177.65060516018, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.4821492112441, 419.80551273474697, 437.6564396948396, 438.7630679433106, 450.6980323183467, 17807.55481112973, 21640.567188656216, 21822.563548729056, 22380.440488987762, 22661.433464163405, 18964.051797410142, 22628.20801271956, 22941.77058229417, 23451.882740586272, 24479.75520244797, 6076.635401875901, 6180.536459765524, 6207.131001659771, 6292.0247361658785, 6358.84102897429, 3717.57247916489, 3904.5509766376945, 6142.447179753821, 6290.025046117859, 6293.5909165904295, 3840.5007349044586, 3886.0, 3892.9294444027837, 3944.3097457944887, 6318.936810631903, 6293.811185664437, 6300.0, 6324.241091069055, 6329.620222786624, 6335.89121903665, 4640.0, 4859.465458799529, 5408.188771684239, 5509.090999985037, 5515.779368825242, 28372.858135709397, 28472.28819279514, 28702.712972870213, 28714.994975175978, 29064.128076157536, 2176.62997290461, 2239.6304609739373, 2242.5627002734473, 2244.494988627562, 2245.0234148145446, 15112.848871511364, 17986.91006544972, 18102.45692629223, 18730.81269187304, 18878.81121188784, 2148.924787632441, 2159.406163305088, 2235.184157782414, 2240.2943072931976, 2242.260054182132, 152260.2386988058, 152492.0, 155129.2243538775, 160545.39454605538, 171111.43332849894, 11681.415929203506, 11699.473523691455, 11927.0, 12484.126111172312, 12607.306598137191, 15516.379344826306, 15565.455209067628, 16517.33930642761, 16817.0, 17002.914985424995, 9022.909770902339, 9053.004169541346, 9154.633814647339, 9286.210672092948, 9301.069893010645, 8742.737717868475, 8760.167784060504, 8794.120587941283, 8955.149260820212, 8957.238634716123, 7839.824870927284, 7971.880421793678, 8021.799455013671, 8022.358211343078, 8038.477498962666, 2174.3042226487373, 2174.467255522407, 2177.4338671945407, 2181.4110190248543, 2331.2306938710185, 812.4110020235282, 955.9665411710696, 956.9425784508157, 964.1370972979284, 1001.2590682894605, 20649.793502065088, 21246.2563810269, 21270.0, 21337.46656333573, 21644.35066947994, 869.8474521259357, 956.321012081416, 970.0978090375877, 994.2112374788643, 1010.0656892374524, 10725.51735171919, 10884.129269658566, 10904.836427453594, 10943.616973405893, 11029.393383363991, 706333.0, 715901.0, 722720.0, 724722.0, 732635.0, 126659.0, 144968.27515862352, 153426.6985995211, 159418.0, 159892.0, 1153.659670397218, 1163.9010684091777, 1186.3119390753343, 1189.4766302826729, 1191.797394442964, 16571.751423728412, 17981.73027404564, 18253.81350212232, 18668.439946801616, 18889.811101888805, 64763.67618161879, 65683.83887971501, 66202.33797662155, 66464.66767666131, 67048.32951670421, 88948.76819708815, 89707.55146224228, 89919.55040224757, 90272.54863725639, 92988.60517092113, 8824.0, 8897.332700047393, 9055.818883622422, 9062.682806101755, 9065.184133428023, 13829.585112446643, 14453.783193251898, 14591.635209119857, 14795.482158124414, 14902.329395177027, 12114.091443141624, 12256.38718064111, 12358.50565977351, 12526.937365313115, 12657.556985505464, 11418.771624567627, 11460.94269528647, 11599.942000289944, 11615.303081815118, 11837.526498939946, 9569.521523923915, 11712.0, 12025.0, 12077.879221207675, 12506.874931250572, 8761.956190219009, 8792.824143517222, 8815.779605509913, 9230.123138301851, 9282.489463079595, 10516.26386152962, 11893.702657433287, 12010.0, 12140.453679584616, 12347.62957111288], "value": 10554.279781246301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.18272670944, 1430.7996880436733, 1447.1751101871935, 1454.5490897821683, 1454.5636309107265, 11299.717507062327, 11356.886431135687, 11897.226680265776, 11902.34537100459, 11908.40457977101, 11522.942385288063, 11966.34185119818, 12002.279863208214, 12016.519339226421, 12017.978471829905, 2485.7887079598254, 2557.0538900606707, 2560.1679454177374, 2561.1420174241557, 2564.3717289264155, 2126.383348828838, 2408.3738228060743, 2505.1482495951373, 2550.7321731218235, 2552.8213025088253, 2165.566886622682, 2166.2201607421393, 2192.6710993350966, 2457.979938325602, 2527.9241622751347, 2484.3789052736815, 2506.2982364937848, 2516.9748302517014, 2517.7230504644476, 2521.0798058708438, 2491.750824917512, 2492.7507249274927, 2503.249025292405, 2504.3613878460874, 2507.059852555292, 11732.472038758277, 11965.581204657796, 11974.161808673396, 11997.400129993553, 12060.517579296818, 5481.808136715235, 6372.522060845409, 6701.296363881771, 6720.462363010996, 6723.899141512881, 4002.9199416011807, 4215.557366476537, 4308.095299987007, 4319.157764235975, 4376.409184760048, 1245.875412458756, 1253.9874601253962, 1271.7011502296953, 1311.4360824845312, 1319.155740326192, 16166.353345866151, 16528.83471165285, 16535.338586456528, 16545.91727041369, 16572.0, 5776.855578610484, 5853.853653658693, 6062.484688801413, 6086.2696476422225, 6104.786332478431, 14039.157650540796, 14042.0, 14056.367463464168, 14057.22685252321, 14064.226467544178, 6756.189257289058, 6775.1531058617675, 6777.2545020047755, 6777.72889084441, 6778.084958530535, 6052.848678782978, 6069.575129740964, 6115.510759139258, 6217.937820621826, 6224.751009959641, 4559.430071241095, 4712.246040633482, 4725.36207611968, 4761.928571071437, 4765.642576806753, 1435.2321507993381, 1485.5543336998858, 1487.5983484459352, 1505.3376514333659, 1518.627936155649, 663.1017102869945, 698.6332175607846, 780.2197802197802, 790.7469609724833, 804.8752443371287, 6624.966875165594, 6802.421794147553, 6803.523753337219, 6898.862022759517, 6921.792346229621, 557.9386267510571, 571.451406649621, 592.8517870532366, 603.8279090459198, 713.8108401273666, 4145.3781932710335, 4163.375493675912, 4172.228137794517, 4263.445752052276, 4267.8079486423185, 14318.498852540111, 15033.098014119189, 15038.323275452412, 15061.623459413602, 15063.623409414853, 14628.561143165722, 14891.106533608017, 14926.402943882124, 15225.467108651366, 15229.1623960681, 10707.62523311696, 10992.725181870357, 10993.0, 11002.50488728025, 11021.83467247992, 6642.6014439133805, 6908.516403851682, 7102.786916392516, 7121.572705637678, 7143.249958754256, 13340.733185336432, 13530.864691352961, 13738.313084345942, 13767.173969561858, 13793.24137172465, 13837.654058648613, 13871.237081960186, 13909.930450347683, 14046.578602641937, 14168.787468188191, 9376.906230937604, 9490.478023708762, 9589.42463452195, 9593.90406095958, 9599.760005999906, 10491.895081049091, 10498.685039448828, 10648.201384896009, 10652.946735266274, 10657.307275027099, 8928.86606700913, 9066.863997039918, 9093.090690930854, 9270.953645231732, 9299.442033477742, 8722.91277087221, 8784.648614055623, 8881.600327985127, 8897.332700047393, 8959.910400895908, 7857.85835424326, 7894.960525197567, 8004.599770011592, 8012.879806803019, 8044.477108987897, 5602.915956260741, 5966.224390829165, 6016.157737916607, 6110.388961103854, 6117.755289788359, 5628.183913332462, 6043.848903777441, 6182.28903676083, 6250.187475628321, 6342.714577843916], "value": 5435.723257942895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.8707320598249, 381.8052793075531, 398.2214770124407, 407.055630936228, 408.28142469254124, 5856.795012174574, 5873.647581145135, 5897.3218079920825, 5935.347111817697, 5967.433093856082, 5086.821961231358, 5383.407825139241, 5730.885382292352, 5816.302043754756, 5830.854228644275, 4418.332783789447, 4443.488998765135, 4448.55237191177, 4467.82128714851, 4476.7090139140855, 4429.667774916878, 4459.732416055031, 4462.620677242438, 4462.638895136982, 4487.416635837337, 3582.767120137196, 3863.343231650612, 4286.6871126001015, 4369.90752311922, 4372.97813510932, 3594.8741794037082, 3612.1577995222365, 3744.4570537271943, 4373.059792144704, 4429.269170586866, 3369.5956485221686, 3681.4845921571, 3885.9611403886165, 3908.55051669056, 3915.9804200979097, 4407.691461597689, 5506.752196151183, 5653.265075540154, 5723.599348045638, 5736.397678243766, 3779.244151169777, 4829.855104346875, 5120.590352771769, 5323.973380133113, 5367.973160134175, 5432.0, 6206.472449841769, 6218.564700470969, 6246.094316324153, 6246.906296405557, 4260.9147817043795, 4469.418975533193, 4476.418065651477, 4484.215262329079, 4491.595756381941, 5863.912041319383, 6233.470155036782, 6428.903566446507, 6470.482361411123, 6498.187726534231, 3878.534575850916, 4574.565416285448, 4666.253399456071, 4706.3175839503765, 4707.223308154116, 4146.5853414658895, 4791.448983366888, 4792.592629626521, 4794.113089078532, 4808.471068182497, 4681.531846815291, 4953.925691114636, 5085.516421251455, 5361.195820626859, 5438.492172548684, 4821.9035619287415, 6335.556511044183, 6368.949123394681, 6372.107904893319, 6373.235211774524, 1584.247482445852, 1599.4002249156567, 1638.9836101639069, 1639.2705246165342, 1648.250046228963, 1077.3482043363808, 1134.8354488599107, 1142.405948906564, 1144.3019757947645, 1155.7110722319421, 5949.553783466257, 5956.940430595725, 5958.999999999914, 5972.193753843176, 5972.223610930551, 5772.758856845799, 6255.0, 6546.934530654633, 6581.473482121419, 6609.182474819463, 4924.532169443897, 5706.400827913092, 5851.531877449794, 5861.736221869941, 5870.207521984563, 2949.0, 3372.51098590703, 3379.0, 3395.828439188476, 3396.711279541267, 5755.827325180251, 5850.444207800252, 6319.462845658079, 6530.934690653127, 6638.5684930479365, 5060.367454068241, 5534.529564987021, 6215.787921355382, 6694.230163531256, 6789.287124851919, 4999.42506611737, 5281.230787686168, 5446.2647542582035, 5974.834907193055, 6686.398224159849, 5095.617828662791, 5288.130175505263, 6143.232095988002, 6459.354064593503, 6570.995846266935, 6146.385361463817, 6202.596831205957, 6309.242890852944, 6482.546221764431, 6497.252815926229, 4927.384076990376, 6251.4061164189325, 6605.768798092044, 6742.258351581224, 6756.493263005196, 4294.024748615671, 4319.805608747551, 4326.437563116775, 4336.869893903188, 4351.021020270414, 5708.200851880823, 6261.467775239155, 6507.381798729113, 6577.572457790228, 6591.5056370773345, 5638.915416268677, 6031.24609423822, 6368.363163683594, 6380.617162970237, 6396.456301214449, 5509.0, 6096.725647345791, 6313.46335561464, 6360.77737279193, 6377.23473183221, 4408.691391602557, 5244.426671998462, 6109.450149486567, 6178.227721534809, 6187.3503282154725, 5510.641808282448, 6089.903817312927, 6294.244690637152, 6354.936450635434, 6399.8720025598295, 6083.49880808414, 6142.775043102407, 6152.846178845564, 6181.0, 6237.4074462927765], "value": 4584.230729370698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.0994202565649, 836.5315423362915, 854.4488804720951, 854.6581367453022, 863.4991704811212, 13362.732745345087, 17924.82075179248, 18104.728429073573, 18630.62738745224, 18658.97375644339, 17066.23201955912, 17143.914280428613, 17553.3856315029, 17578.033208173547, 17595.38416155435, 948.9620415183384, 992.4045572656421, 997.8154041502308, 998.2762497189552, 999.9900001000007, 663.4692246203042, 683.4498228925713, 965.4689920543708, 1009.7627057641448, 1017.3234798858787, 1042.6298663974294, 1047.7799662070975, 1050.6217761605815, 1051.1800795379577, 1053.836655318427, 1042.3589492462156, 1044.1281529922485, 1045.3571053801895, 1047.1413440978401, 1047.1779652972457, 775.7982924439686, 776.4836383804763, 776.6543887969856, 776.763087258386, 776.7863837444692, 16234.918825405797, 16541.0, 16715.91642041782, 16738.24677889498, 17010.31958721662, 16415.0, 16451.753223701653, 16580.917095414447, 16848.57878553046, 16872.746908796376, 13520.18878867271, 13656.590302290948, 13725.313734313244, 13842.792358114637, 13876.722465550733, 2980.5678176664264, 3350.5141754445467, 3365.932681346384, 3370.814605196738, 3371.258323168899, 109527.0, 109999.0, 110010.0, 110098.0, 111271.0, 11074.39090850011, 11881.0, 11989.520419183134, 12103.0, 12120.757584848254, 17324.220410081576, 19072.904635476734, 19408.514787130152, 19479.565054368202, 24507.897144628536, 8778.517181555077, 8793.91206087931, 8983.775405614912, 8992.685256016008, 9003.639854405881, 4868.440129385095, 4939.135651261015, 4978.825741099116, 4979.850604481871, 4981.32752078472, 4204.789760511962, 4260.10537787062, 4295.4201182839915, 4322.595156574063, 4329.264025115738, 909.4134283387178, 930.8976012638605, 931.2689538712214, 937.8640097186006, 938.9671361502315, 540.2814257038129, 636.38270877249, 642.7750287399466, 646.1180488632982, 677.6340775981014, 11364.886351136549, 11427.142964277546, 11816.877396647305, 11900.228389231215, 12211.69470763238, 624.1106423346713, 642.1459458919626, 647.6179054357951, 656.2748163279603, 673.8888083466173, 4850.296706977469, 5140.588752899759, 5287.920681189786, 5348.438413966555, 5516.806911758069, 105231.0, 107393.0, 108207.0, 108802.91197088086, 112029.87970120195, 86383.70424443639, 87113.0, 88030.99612548431, 88855.55572222098, 89471.55264223638, 63772.043419348745, 78617.60691196508, 78742.60628696819, 79176.60411697904, 79192.0, 9806.754831128994, 10122.785265768154, 10932.0707739843, 11105.888941110485, 11164.776704466027, 41134.0, 41324.793376032925, 42672.0, 42712.145757084065, 43526.0, 37016.0, 45537.861553460105, 46904.82737931579, 51057.489425105276, 51934.0, 13445.058845881085, 14060.367283472473, 14135.293235338399, 14329.426822927384, 14344.713105738036, 15468.84531154674, 15475.613109672347, 15478.0, 15626.687466250838, 15645.295961681524, 14521.564353069425, 14602.85397146015, 14719.337629806898, 16109.194540273174, 17302.134893255537, 16619.41832035873, 16861.91569042147, 17016.57458563546, 17196.312147514458, 17328.0, 16177.75733364024, 16512.25694843711, 16525.256363463912, 16777.077260750775, 16783.832161678714, 9087.818243634958, 10447.00753428423, 12035.277883327028, 12163.695907602027, 12231.204971676812, 11086.390248536409, 11898.583549575724, 12405.007599392207, 13070.281134537692, 13080.476780929037], "value": 8103.112105960699, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1655.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 123.0, 124.0, 124.0, 123.0, 122.0, 123.0, 124.0, 122.0, 123.0], "value": 121.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 139.0, 154.0, 193.0, 117.0, 122.0, 132.0, 150.0, 185.0, 119.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 218.0, 217.0, 209.0, 213.0, 298.0, 222.0, 217.0, 211.0, 210.0], "value": 222.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 66.0, 96.0, 67.0, 67.0, 64.0, 63.0, 82.0, 63.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 104.0, 133.0, 102.0, 74.0, 74.0, 94.0, 75.0, 72.0, 91.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 99.0, 139.0, 96.0, 94.0, 93.0, 94.0, 94.0], "value": 98.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 102.0, 102.0, 102.0, 102.0, 103.0, 109.0, 101.0, 102.0, 102.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 102.0, 136.0, 158.0, 129.0, 100.0, 101.0, 101.0, 101.0, 104.0], "value": 113.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 50.0, 51.0, 51.0, 52.0, 53.0, 52.0, 52.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 59.0, 65.0, 67.0, 72.0, 66.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 117.0, 113.0, 92.0, 92.0, 95.0, 106.0, 115.0, 117.0, 92.0], "value": 103.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 154.0, 153.0, 152.0, 153.0, 158.0, 150.0, 192.0, 157.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 211.0, 212.0, 211.0, 231.0, 264.0, 210.0, 217.0, 250.0, 208.0], "value": 221.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 89.0, 104.0, 106.0, 106.0, 102.0, 75.0, 73.0], "value": 88.1, "unit": "score"}]}]} 04:19:41 INFO - Return code: 0 04:19:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:19:41 ERROR - # TBPL SUCCESS # 04:19:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:19:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:19:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:19:41 INFO - 2017-04-11 04:19:41.406 screenresolution[1647:9633] starting screenresolution argv=screenresolution get 04:19:41 INFO - 2017-04-11 04:19:41.409 screenresolution[1647:9633] Display 0: 1600x1200x32@60 04:19:41 INFO - 2017-04-11 04:19:41.415 screenresolution[1648:9636] starting screenresolution argv=screenresolution list 04:19:41 INFO - Available Modes on Display 0 04:19:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:19:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:19:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:19:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:19:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:19:41 INFO - Intel Iris: 04:19:41 INFO - Chipset Model: Intel Iris 04:19:41 INFO - Type: GPU 04:19:41 INFO - Bus: Built-In 04:19:41 INFO - VRAM (Dynamic, Max): 1536 MB 04:19:41 INFO - Vendor: Intel (0x8086) 04:19:41 INFO - Device ID: 0x0a2e 04:19:41 INFO - Revision ID: 0x0009 04:19:41 INFO - Displays: 04:19:41 INFO - Display: 04:19:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:19:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:19:41 INFO - Display Serial Number: 1600x1200 60 04:19:41 INFO - Main Display: Yes 04:19:41 INFO - Mirror: Off 04:19:41 INFO - Online: Yes 04:19:41 INFO - Rotation: Supported 04:19:41 INFO - Return code: 0 04:19:41 INFO - Running post-action listener: _resource_record_post_action 04:19:41 INFO - [mozharness: 2017-04-11 11:19:41.662222Z] Finished run-tests step (success) 04:19:41 INFO - Running post-run listener: _resource_record_post_run 04:19:41 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 36574208; Write bytes: 518574080; Read time: 373; Write time: 2040 04:19:41 INFO - TinderboxPrint: CPU usage
53.3% 04:19:41 INFO - TinderboxPrint: I/O read bytes / time
36,574,208 / 373 04:19:41 INFO - TinderboxPrint: I/O write bytes / time
518,574,080 / 2,040 04:19:41 INFO - TinderboxPrint: CPU idle
2,250.2 (46.7%) 04:19:41 INFO - TinderboxPrint: CPU system
962.7 (20.0%) 04:19:41 INFO - TinderboxPrint: CPU user
1,608.8 (33.4%) 04:19:41 INFO - TinderboxPrint: Swap in / out
244,215,808 / 0 04:19:41 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208878080; Write bytes: 210900480; Read time: 16050; Write time: 573 04:19:41 INFO - run-tests - Wall time: 1186s; CPU: 53.0%; Read bytes: 34333696; Write bytes: 306293248; Read time: 347; Write time: 1462 04:19:42 INFO - Running post-run listener: _upload_blobber_files 04:19:42 INFO - Blob upload gear active. 04:19:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:42 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 04:19:42 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'] 04:19:42 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 04:19:43 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:19:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:19:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:46 INFO - (blobuploader) - INFO - Done attempting. 04:19:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:19:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:49 INFO - (blobuploader) - INFO - Done attempting. 04:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:19:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:51 INFO - (blobuploader) - INFO - Done attempting. 04:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:08 INFO - (blobuploader) - INFO - Done attempting. 04:20:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:08 INFO - Return code: 0 04:20:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d82e73a7f28986c36e7ed945bc680d9ba984e8938f113a48378e2981fc80d485811d5662f5b8e6d4000560b7a5c82e43dc02a6b2ad6a9a1035e07f0eaa38e0fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/883e1570c1a2988cc59498ab33d07cb457020683ebcd2a1a24921402ddb548b96450ee6932a1d559a1be7a96064bec63bce34827aecc7766006a54e72e1d2f4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a9c925cca033a79e06b4b7cb5753c2c4f44e335c64353a3ab6fe51232b876dfdcb715abd4d0a240649444d38a8d01aab4cdab08821c326c79bbe9c01d2fe2b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47caf190ef2c4f0d0844e5e484a7501c919ef09fbe7e4aed69ab31948bec47279f798661dedd3625eb29ea42cffd7840438ce941819e8f3c5327fedb8013580c"} 04:20:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:08 INFO - Contents: 04:20:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d82e73a7f28986c36e7ed945bc680d9ba984e8938f113a48378e2981fc80d485811d5662f5b8e6d4000560b7a5c82e43dc02a6b2ad6a9a1035e07f0eaa38e0fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/883e1570c1a2988cc59498ab33d07cb457020683ebcd2a1a24921402ddb548b96450ee6932a1d559a1be7a96064bec63bce34827aecc7766006a54e72e1d2f4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a9c925cca033a79e06b4b7cb5753c2c4f44e335c64353a3ab6fe51232b876dfdcb715abd4d0a240649444d38a8d01aab4cdab08821c326c79bbe9c01d2fe2b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47caf190ef2c4f0d0844e5e484a7501c919ef09fbe7e4aed69ab31948bec47279f798661dedd3625eb29ea42cffd7840438ce941819e8f3c5327fedb8013580c"} 04:20:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:08 INFO - Copying logs to upload dir... 04:20:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1310.890563 ========= master_lag: 1.18 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2017-04-11 04:20:09.357035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 04:20:09.360972) ========= 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.O73eukBHkE/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.yjFBLmPSOs/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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/d82e73a7f28986c36e7ed945bc680d9ba984e8938f113a48378e2981fc80d485811d5662f5b8e6d4000560b7a5c82e43dc02a6b2ad6a9a1035e07f0eaa38e0fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/883e1570c1a2988cc59498ab33d07cb457020683ebcd2a1a24921402ddb548b96450ee6932a1d559a1be7a96064bec63bce34827aecc7766006a54e72e1d2f4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a9c925cca033a79e06b4b7cb5753c2c4f44e335c64353a3ab6fe51232b876dfdcb715abd4d0a240649444d38a8d01aab4cdab08821c326c79bbe9c01d2fe2b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47caf190ef2c4f0d0844e5e484a7501c919ef09fbe7e4aed69ab31948bec47279f798661dedd3625eb29ea42cffd7840438ce941819e8f3c5327fedb8013580c"} build_url:https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/Th7r0DFVRkmddX9U_wLWmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d82e73a7f28986c36e7ed945bc680d9ba984e8938f113a48378e2981fc80d485811d5662f5b8e6d4000560b7a5c82e43dc02a6b2ad6a9a1035e07f0eaa38e0fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/883e1570c1a2988cc59498ab33d07cb457020683ebcd2a1a24921402ddb548b96450ee6932a1d559a1be7a96064bec63bce34827aecc7766006a54e72e1d2f4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a9c925cca033a79e06b4b7cb5753c2c4f44e335c64353a3ab6fe51232b876dfdcb715abd4d0a240649444d38a8d01aab4cdab08821c326c79bbe9c01d2fe2b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47caf190ef2c4f0d0844e5e484a7501c919ef09fbe7e4aed69ab31948bec47279f798661dedd3625eb29ea42cffd7840438ce941819e8f3c5327fedb8013580c"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 04:20:09.443764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 04:20:09.444070) ========= 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.O73eukBHkE/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.yjFBLmPSOs/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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.005296 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 04:20:09.471985) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 04:20:09.472300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 04:20:09.472631) ========= ========= Total master_lag: 1.34 =========