builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0234 starttime: 1481910641.28 results: success (0) buildid: 20161216081149 builduid: 7906d5c4784e4608bb1f9367646312af revision: e4c249612e0e3b7570942073060315fee5dff07b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:41.275792) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:41.276220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:41.276493) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:41.304216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-16 09:50:41.304534) ========= 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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-16 09:50:41-- 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% 145M=0s 2016-12-16 09:50:41 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129170 ========= master_lag: 1.00 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-16 09:50:42.438022) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:42.438365) ========= 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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.026088 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:42.492273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-16 09:50:42.492619) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev e4c249612e0e3b7570942073060315fee5dff07b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev e4c249612e0e3b7570942073060315fee5dff07b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-16 09:50:42,599 truncating revision to first 12 chars 2016-12-16 09:50:42,599 Setting DEBUG logging. 2016-12-16 09:50:42,599 attempt 1/10 2016-12-16 09:50:42,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/e4c249612e0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 09:50:44,764 unpacking tar archive at: graphics-e4c249612e0e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.448789 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-16 09:50:44.970709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:44.974068) ========= script_repo_revision: e4c249612e0e3b7570942073060315fee5dff07b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:44.974497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:44.974792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 09:50:44.994079) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-16 09:50:44.994378) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:50:45 INFO - MultiFileLogger online at 20161216 09:50:45 in /builds/slave/test 09:50:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 09:50:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:45 INFO - {'append_to_log': False, 09:50:45 INFO - 'base_work_dir': '/builds/slave/test', 09:50:45 INFO - 'blob_upload_branch': 'Graphics', 09:50:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:45 INFO - 'branch': 'Graphics', 09:50:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:45 INFO - 'config_files': ('talos/mac_config.py',), 09:50:45 INFO - 'default_actions': ('clobber', 09:50:45 INFO - 'read-buildbot-config', 09:50:45 INFO - 'download-and-extract', 09:50:45 INFO - 'populate-webroot', 09:50:45 INFO - 'create-virtualenv', 09:50:45 INFO - 'install', 09:50:45 INFO - 'run-tests'), 09:50:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:45 INFO - 'download_minidump_stackwalk': True, 09:50:45 INFO - 'download_symbols': 'ondemand', 09:50:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:45 INFO - 'installer_path': 'installer.exe', 09:50:45 INFO - 'log_level': 'info', 09:50:45 INFO - 'log_name': 'talos', 09:50:45 INFO - 'log_to_console': True, 09:50:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:50:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:50:45 INFO - 'opt_config_files': (), 09:50:45 INFO - 'pip_index': False, 09:50:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:45 INFO - 'cmd': ('bash', 09:50:45 INFO - '-c', 09:50:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:45 INFO - 'enabled': True, 09:50:45 INFO - 'halt_on_failure': False, 09:50:45 INFO - 'name': 'check_screen_resolution'},), 09:50:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:45 INFO - 'cmd': ('bash', 09:50:45 INFO - '-c', 09:50:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:45 INFO - 'enabled': True, 09:50:45 INFO - 'halt_on_failure': False, 09:50:45 INFO - 'name': 'check_screen_resolution'},), 09:50:45 INFO - 'run_cmd_checks_enabled': True, 09:50:45 INFO - 'sps_profile': False, 09:50:45 INFO - 'sps_profile_interval': 0, 09:50:45 INFO - 'suite': 'dromaeojs', 09:50:45 INFO - 'system_bits': '32', 09:50:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:45 INFO - 'title': 't-yosemite-r7-0234', 09:50:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:45 INFO - 'use_talos_json': True, 09:50:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:45 INFO - 'work_dir': 'build'} 09:50:45 INFO - [mozharness: 2016-12-16 17:50:45.205919Z] Running clobber step. 09:50:45 INFO - Running pre-action listener: _resource_record_pre_action 09:50:45 INFO - Running main action method: clobber 09:50:45 INFO - rmtree: /builds/slave/test/build 09:50:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:47 INFO - Running post-action listener: _resource_record_post_action 09:50:47 INFO - [mozharness: 2016-12-16 17:50:47.431683Z] Finished clobber step (success) 09:50:47 INFO - [mozharness: 2016-12-16 17:50:47.431876Z] Running read-buildbot-config step. 09:50:47 INFO - Running pre-action listener: _resource_record_pre_action 09:50:47 INFO - Running main action method: read_buildbot_config 09:50:47 INFO - Using buildbot properties: 09:50:47 INFO - { 09:50:47 INFO - "project": "", 09:50:47 INFO - "product": "firefox", 09:50:47 INFO - "script_repo_revision": "default", 09:50:47 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 09:50:47 INFO - "repository": "", 09:50:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 09:50:47 INFO - "buildid": "20161216081149", 09:50:47 INFO - "pgo_build": "False", 09:50:47 INFO - "basedir": "/builds/slave/test", 09:50:47 INFO - "buildnumber": 3, 09:50:47 INFO - "slavename": "t-yosemite-r7-0234", 09:50:47 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:50:47 INFO - "platform": "yosemite_r7", 09:50:47 INFO - "scheduler": "tests-graphics-macosx64-talos", 09:50:47 INFO - "branch": "graphics", 09:50:47 INFO - "repo_path": "projects/graphics", 09:50:47 INFO - "revision": "e4c249612e0e3b7570942073060315fee5dff07b", 09:50:47 INFO - "stage_platform": "macosx64", 09:50:47 INFO - "builduid": "7906d5c4784e4608bb1f9367646312af", 09:50:47 INFO - "slavebuilddir": "test" 09:50:47 INFO - } 09:50:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:50:47 INFO - Running post-action listener: _resource_record_post_action 09:50:47 INFO - [mozharness: 2016-12-16 17:50:47.435266Z] Finished read-buildbot-config step (success) 09:50:47 INFO - [mozharness: 2016-12-16 17:50:47.435364Z] Running download-and-extract step. 09:50:47 INFO - Running pre-action listener: _resource_record_pre_action 09:50:47 INFO - Running main action method: download_and_extract 09:50:47 INFO - mkdir: /builds/slave/test/build/tests 09:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:47 INFO - trying https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:50:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 09:50:48 INFO - Downloaded 1199 bytes. 09:50:48 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:50:48 INFO - Using the following test package requirements: 09:50:48 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:50:48 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:50:48 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:50:48 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:50:48 INFO - u'jsshell-mac.zip'], 09:50:48 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:50:48 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:50:48 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:50:48 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:50:48 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:50:48 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:50:48 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:50:48 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:50:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:50:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:50:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:50:49 INFO - Expected file size: 16277440 09:50:49 INFO - Obtained file size: 16277440 09:50:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:50:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:50:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:50:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:50:57 INFO - Expected file size: 16277440 09:50:57 INFO - Obtained file size: 16277440 09:51:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:51:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:51:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:51:05 INFO - Expected file size: 14409734 09:51:05 INFO - Obtained file size: 14409734 09:51: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')]} 09:51:05 INFO - trying https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:51:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 09:51:07 INFO - Downloaded 69596532 bytes. 09:51:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:51:07 INFO - mkdir: /builds/slave/test/properties 09:51:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:07 INFO - Contents: 09:51:07 INFO - build_url:https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:51:08 INFO - Running post-action listener: _resource_record_post_action 09:51:08 INFO - Running post-action listener: set_extra_try_arguments 09:51:08 INFO - [mozharness: 2016-12-16 17:51:08.538653Z] Finished download-and-extract step (success) 09:51:08 INFO - [mozharness: 2016-12-16 17:51:08.538787Z] Running populate-webroot step. 09:51:08 INFO - Running pre-action listener: _resource_record_pre_action 09:51:08 INFO - Running main action method: populate_webroot 09:51:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:08 INFO - '--tppagecycles', 09:51:08 INFO - '7'], 09:51:08 INFO - 'tests': ['tsvgm']}}, 09:51:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:51:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:51:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:51:08 INFO - 'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:51:08 INFO - 'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['damp', 'tps']}, 09:51:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:51:08 INFO - 'tests': ['damp', 'tps']}, 09:51:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['dromaeo_dom']}, 09:51:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['basic_compositor_video']}, 09:51:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:51:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['a11yr', 09:51:08 INFO - 'ts_paint', 09:51:08 INFO - 'tpaint', 09:51:08 INFO - 'sessionrestore', 09:51:08 INFO - 'sessionrestore_no_auto_restore', 09:51:08 INFO - 'tabpaint']}, 09:51:08 INFO - 'other-e10s': {'tests': ['a11yr', 09:51:08 INFO - 'ts_paint', 09:51:08 INFO - 'tpaint', 09:51:08 INFO - 'sessionrestore', 09:51:08 INFO - 'sessionrestore_no_auto_restore', 09:51:08 INFO - 'tabpaint']}, 09:51:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:51:08 INFO - 'ts_paint', 09:51:08 INFO - 'tpaint', 09:51:08 INFO - 'sessionrestore', 09:51:08 INFO - 'sessionrestore_no_auto_restore', 09:51:08 INFO - 'tabpaint']}, 09:51:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:51:08 INFO - 'ts_paint', 09:51:08 INFO - 'tpaint', 09:51:08 INFO - 'sessionrestore', 09:51:08 INFO - 'sessionrestore_no_auto_restore', 09:51:08 INFO - 'tabpaint']}, 09:51:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['a11yr', 09:51:08 INFO - 'ts_paint', 09:51:08 INFO - 'tpaint', 09:51:08 INFO - 'sessionrestore', 09:51:08 INFO - 'sessionrestore_no_auto_restore', 09:51:08 INFO - 'tabpaint']}, 09:51:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['a11yr', 09:51:08 INFO - 'ts_paint', 09:51:08 INFO - 'tpaint', 09:51:08 INFO - 'sessionrestore', 09:51:08 INFO - 'sessionrestore_no_auto_restore', 09:51:08 INFO - 'tabpaint']}, 09:51:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['tsvgx', 09:51:08 INFO - 'tsvgr_opacity', 09:51:08 INFO - 'tart', 09:51:08 INFO - 'tscrollx', 09:51:08 INFO - 'cart', 09:51:08 INFO - 'tsvg_static']}, 09:51:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:51:08 INFO - 'tsvgr_opacity', 09:51:08 INFO - 'tart', 09:51:08 INFO - 'tscrollx', 09:51:08 INFO - 'cart', 09:51:08 INFO - 'tsvg_static']}, 09:51:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:51:08 INFO - 'talos_options': ['--disable-e10s'], 09:51:08 INFO - 'tests': ['tp5o']}, 09:51:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:51:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:51:08 INFO - 'talos_options': ['--disable-e10s', 09:51:08 INFO - '--xperf_path', 09:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:08 INFO - 'tests': ['tp5n']}, 09:51:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:51:08 INFO - 'talos_options': ['--xperf_path', 09:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:08 INFO - 'tests': ['tp5n']}}, 09:51:08 INFO - 'talos.zip': {'path': '', 09:51:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:08 INFO - Running post-action listener: _resource_record_post_action 09:51:08 INFO - [mozharness: 2016-12-16 17:51:08.556987Z] Finished populate-webroot step (success) 09:51:08 INFO - [mozharness: 2016-12-16 17:51:08.557124Z] Running create-virtualenv step. 09:51:08 INFO - Running pre-action listener: _resource_record_pre_action 09:51:08 INFO - Running main action method: create_virtualenv 09:51:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:08 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 09:51:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:08 INFO - Using real prefix '/tools/python27' 09:51:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:12 INFO - Installing pip.................done. 09:51:12 INFO - Return code: 0 09:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:51:12 INFO - Reading from file tmpfile_stdout 09:51:12 INFO - Output received: 09:51:12 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) 09:51:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51:12 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')]} 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:12 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')]} 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:12 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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:12 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 09:51:12 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 09:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:12 INFO - 'HOME': '/Users/cltbld', 09:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:12 INFO - 'LOGNAME': 'cltbld', 09:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:12 INFO - 'MOZ_NO_REMOTE': '1', 09:51:12 INFO - 'NO_EM_RESTART': '1', 09:51:12 INFO - 'PAGER': '/bin/cat', 09:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:12 INFO - 'PWD': '/builds/slave/test', 09:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:12 INFO - 'SHELL': '/bin/bash', 09:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:12 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:12 INFO - 'USER': 'cltbld', 09:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:12 INFO - 'XPC_FLAGS': '0x0', 09:51:12 INFO - 'XPC_SERVICE_NAME': '0', 09:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:12 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 09:51:12 INFO - Cleaning up... 09:51:12 INFO - Return code: 0 09:51:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:51:12 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')]} 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:12 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')]} 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:12 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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:12 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 09:51:12 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 09:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:12 INFO - 'HOME': '/Users/cltbld', 09:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:12 INFO - 'LOGNAME': 'cltbld', 09:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:12 INFO - 'MOZ_NO_REMOTE': '1', 09:51:12 INFO - 'NO_EM_RESTART': '1', 09:51:12 INFO - 'PAGER': '/bin/cat', 09:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:12 INFO - 'PWD': '/builds/slave/test', 09:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:12 INFO - 'SHELL': '/bin/bash', 09:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:12 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:12 INFO - 'USER': 'cltbld', 09:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:12 INFO - 'XPC_FLAGS': '0x0', 09:51:12 INFO - 'XPC_SERVICE_NAME': '0', 09:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:13 INFO - Downloading/unpacking psutil>=3.1.1 09:51:13 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 09:51:13 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 09:51:13 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 09:51:13 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 09:51:13 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 09:51:13 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 09:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:16 INFO - Installing collected packages: psutil 09:51:16 INFO - Running setup.py install for psutil 09:51:16 INFO - building 'psutil._psutil_osx' extension 09:51:16 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 09:51:17 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 09:51:17 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 09:51:17 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 09:51:17 INFO - building 'psutil._psutil_posix' extension 09:51:17 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 09:51:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:51:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:51:17 INFO - ^ 09:51:17 INFO - 1 warning generated. 09:51:17 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 09:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:17 INFO - Successfully installed psutil 09:51:17 INFO - Cleaning up... 09:51:17 INFO - Return code: 0 09:51:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:17 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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:17 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 09:51:17 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 09:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:17 INFO - 'HOME': '/Users/cltbld', 09:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:17 INFO - 'LOGNAME': 'cltbld', 09:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:17 INFO - 'MOZ_NO_REMOTE': '1', 09:51:17 INFO - 'NO_EM_RESTART': '1', 09:51:17 INFO - 'PAGER': '/bin/cat', 09:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:17 INFO - 'PWD': '/builds/slave/test', 09:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:17 INFO - 'SHELL': '/bin/bash', 09:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:17 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:17 INFO - 'USER': 'cltbld', 09:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:17 INFO - 'XPC_FLAGS': '0x0', 09:51:17 INFO - 'XPC_SERVICE_NAME': '0', 09:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:51:17 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 09:51:17 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 09:51:17 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 09:51:17 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 09:51:17 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 09:51:17 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 09:51:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:51:20 INFO - Installing collected packages: mozsystemmonitor 09:51:20 INFO - Running setup.py install for mozsystemmonitor 09:51:20 INFO - Successfully installed mozsystemmonitor 09:51:20 INFO - Cleaning up... 09:51:20 INFO - Return code: 0 09:51:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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', '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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:51: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 jsonschema==2.5.1 09:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:20 INFO - 'HOME': '/Users/cltbld', 09:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:20 INFO - 'LOGNAME': 'cltbld', 09:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:20 INFO - 'MOZ_NO_REMOTE': '1', 09:51:20 INFO - 'NO_EM_RESTART': '1', 09:51:20 INFO - 'PAGER': '/bin/cat', 09:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:20 INFO - 'PWD': '/builds/slave/test', 09:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:20 INFO - 'SHELL': '/bin/bash', 09:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:20 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:20 INFO - 'USER': 'cltbld', 09:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:20 INFO - 'XPC_FLAGS': '0x0', 09:51:20 INFO - 'XPC_SERVICE_NAME': '0', 09:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:21 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:21 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 09:51:21 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 09:51:21 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 09:51:21 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 09:51:21 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 09:51:21 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 09:51:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:24 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:24 INFO - warning: no files found matching '*.txt' 09:51:24 INFO - no previously-included directories found matching 'build' 09:51:24 INFO - no previously-included directories found matching 'dist' 09:51:24 INFO - no previously-included directories found matching '.git*' 09:51:24 INFO - Installing collected packages: jsonschema, functools32 09:51:24 INFO - Running setup.py install for functools32 09:51:24 INFO - warning: no files found matching '*.txt' 09:51:24 INFO - no previously-included directories found matching 'build' 09:51:24 INFO - no previously-included directories found matching 'dist' 09:51:24 INFO - no previously-included directories found matching '.git*' 09:51:24 INFO - Successfully installed jsonschema functools32 09:51:24 INFO - Cleaning up... 09:51:24 INFO - Return code: 0 09:51:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:24 INFO - 'HOME': '/Users/cltbld', 09:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:24 INFO - 'LOGNAME': 'cltbld', 09:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:24 INFO - 'MOZ_NO_REMOTE': '1', 09:51:24 INFO - 'NO_EM_RESTART': '1', 09:51:24 INFO - 'PAGER': '/bin/cat', 09:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:24 INFO - 'PWD': '/builds/slave/test', 09:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:24 INFO - 'SHELL': '/bin/bash', 09:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:24 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:24 INFO - 'USER': 'cltbld', 09:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:24 INFO - 'XPC_FLAGS': '0x0', 09:51:24 INFO - 'XPC_SERVICE_NAME': '0', 09:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:51:24 INFO - Cleaning up... 09:51:24 INFO - Return code: 0 09:51:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:24 INFO - 'HOME': '/Users/cltbld', 09:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:24 INFO - 'LOGNAME': 'cltbld', 09:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:24 INFO - 'MOZ_NO_REMOTE': '1', 09:51:24 INFO - 'NO_EM_RESTART': '1', 09:51:24 INFO - 'PAGER': '/bin/cat', 09:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:24 INFO - 'PWD': '/builds/slave/test', 09:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:24 INFO - 'SHELL': '/bin/bash', 09:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:24 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:24 INFO - 'USER': 'cltbld', 09:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:24 INFO - 'XPC_FLAGS': '0x0', 09:51:24 INFO - 'XPC_SERVICE_NAME': '0', 09:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:24 INFO - Downloading/unpacking blobuploader==1.2.4 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:28 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 09:51:28 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 09:51:28 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 09:51:28 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 09:51:28 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 09:51:28 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 09:51:28 INFO - Downloading docopt-0.6.1.tar.gz 09:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:28 INFO - Running setup.py install for blobuploader 09:51:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:28 INFO - Running setup.py install for requests 09:51:29 INFO - Running setup.py install for docopt 09:51:29 INFO - Successfully installed blobuploader requests docopt 09:51:29 INFO - Cleaning up... 09:51:29 INFO - Return code: 0 09:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:29 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')]} 09:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:29 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')]} 09:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:29 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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:29 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 09:51:29 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 09:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:29 INFO - 'HOME': '/Users/cltbld', 09:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:29 INFO - 'LOGNAME': 'cltbld', 09:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:29 INFO - 'MOZ_NO_REMOTE': '1', 09:51:29 INFO - 'NO_EM_RESTART': '1', 09:51:29 INFO - 'PAGER': '/bin/cat', 09:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:29 INFO - 'PWD': '/builds/slave/test', 09:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:29 INFO - 'SHELL': '/bin/bash', 09:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:29 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:29 INFO - 'USER': 'cltbld', 09:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:29 INFO - 'XPC_FLAGS': '0x0', 09:51:29 INFO - 'XPC_SERVICE_NAME': '0', 09:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:29 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-A0KkI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-7ZFHp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-YudOlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-fLtfXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-VcYVZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-YNc7g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-D_uFmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-N5ZCTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-a1dWus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:30 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-CZ5iTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:31 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Glj46j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:31 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-H2j_Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:31 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-zxA41l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:31 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-zYe8J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:31 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-uFj44f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:31 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-XEn9QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:31 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-q25AmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:31 INFO - Running setup.py install for manifestparser 09:51:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:31 INFO - Running setup.py install for mozcrash 09:51:32 INFO - Running setup.py install for mozdebug 09:51:32 INFO - Running setup.py install for mozdevice 09:51:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozfile 09:51:32 INFO - Running setup.py install for mozhttpd 09:51:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozinfo 09:51:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozInstall 09:51:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Running setup.py install for mozleak 09:51:33 INFO - Running setup.py install for mozlog 09:51:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Running setup.py install for moznetwork 09:51:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Running setup.py install for mozprocess 09:51:33 INFO - Running setup.py install for mozprofile 09:51:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Running setup.py install for mozrunner 09:51:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:33 INFO - Running setup.py install for mozscreenshot 09:51:34 INFO - Running setup.py install for moztest 09:51:34 INFO - Running setup.py install for mozversion 09:51:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:34 INFO - Cleaning up... 09:51:34 INFO - Return code: 0 09:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:34 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')]} 09:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:34 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')]} 09:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:35 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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:35 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 09:51:35 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 09:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:35 INFO - 'HOME': '/Users/cltbld', 09:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:35 INFO - 'LOGNAME': 'cltbld', 09:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:35 INFO - 'MOZ_NO_REMOTE': '1', 09:51:35 INFO - 'NO_EM_RESTART': '1', 09:51:35 INFO - 'PAGER': '/bin/cat', 09:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:35 INFO - 'PWD': '/builds/slave/test', 09:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:35 INFO - 'SHELL': '/bin/bash', 09:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:35 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:35 INFO - 'USER': 'cltbld', 09:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:35 INFO - 'XPC_FLAGS': '0x0', 09:51:35 INFO - 'XPC_SERVICE_NAME': '0', 09:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:35 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-qEWnyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:35 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-uZBBOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:35 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-bdma_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:35 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-7CdKqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:35 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-q_YDdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:35 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)) 09:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:35 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-SCWlyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:36 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)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-YkFn9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:36 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)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-397yzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:36 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)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-sF0UY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:36 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)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-8LKnsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:36 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)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Zk8mNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:36 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)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ZgAlRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-eY9N3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:36 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)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-1E4STO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:36 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)) 09:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:36 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-VOn7d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:37 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)) 09:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:37 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-_r39ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:37 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-EY1DKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:37 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)) 09:51:37 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)) 09:51:37 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)) 09:51:37 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)) 09:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:40 INFO - Downloading blessings-1.6.tar.gz 09:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:40 INFO - Installing collected packages: blessings 09:51:40 INFO - Running setup.py install for blessings 09:51:40 INFO - Successfully installed blessings 09:51:40 INFO - Cleaning up... 09:51:40 INFO - Return code: 0 09:51:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:40 INFO - Reading from file tmpfile_stdout 09:51:40 INFO - Current package versions: 09:51:40 INFO - blessings == 1.6 09:51:40 INFO - blobuploader == 1.2.4 09:51:40 INFO - docopt == 0.6.1 09:51:40 INFO - functools32 == 3.2.3-2 09:51:40 INFO - jsonschema == 2.5.1 09:51:40 INFO - manifestparser == 1.1 09:51:40 INFO - mozInstall == 1.12 09:51:40 INFO - mozcrash == 1.0 09:51:40 INFO - mozdebug == 0.1 09:51:40 INFO - mozdevice == 0.49 09:51:40 INFO - mozfile == 1.2 09:51:40 INFO - mozhttpd == 0.7 09:51:40 INFO - mozinfo == 0.9 09:51:40 INFO - mozleak == 0.1 09:51:40 INFO - mozlog == 3.4 09:51:40 INFO - moznetwork == 0.27 09:51:40 INFO - mozprocess == 0.23 09:51:40 INFO - mozprofile == 0.28 09:51:40 INFO - mozrunner == 6.13 09:51:40 INFO - mozscreenshot == 0.1 09:51:40 INFO - mozsystemmonitor == 0.3 09:51:40 INFO - moztest == 0.7 09:51:40 INFO - mozversion == 1.4 09:51:40 INFO - psutil == 3.1.1 09:51:40 INFO - requests == 1.2.3 09:51:40 INFO - wsgiref == 0.1.2 09:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 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 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:40 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 09:51:40 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 09:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:40 INFO - 'HOME': '/Users/cltbld', 09:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:40 INFO - 'LOGNAME': 'cltbld', 09:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:40 INFO - 'MOZ_NO_REMOTE': '1', 09:51:40 INFO - 'NO_EM_RESTART': '1', 09:51:40 INFO - 'PAGER': '/bin/cat', 09:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:40 INFO - 'PWD': '/builds/slave/test', 09:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:40 INFO - 'SHELL': '/bin/bash', 09:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:40 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:40 INFO - 'USER': 'cltbld', 09:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:40 INFO - 'XPC_FLAGS': '0x0', 09:51:40 INFO - 'XPC_SERVICE_NAME': '0', 09:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 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)) 09:51:40 INFO - Cleaning up... 09:51:40 INFO - Return code: 0 09:51:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd523f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7e2ccf320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, '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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:41 INFO - 'HOME': '/Users/cltbld', 09:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:41 INFO - 'LOGNAME': 'cltbld', 09:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:41 INFO - 'MOZ_NO_REMOTE': '1', 09:51:41 INFO - 'NO_EM_RESTART': '1', 09:51:41 INFO - 'PAGER': '/bin/cat', 09:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:41 INFO - 'PWD': '/builds/slave/test', 09:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:41 INFO - 'SHELL': '/bin/bash', 09:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:51:41 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:41 INFO - 'USER': 'cltbld', 09:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:41 INFO - 'XPC_FLAGS': '0x0', 09:51:41 INFO - 'XPC_SERVICE_NAME': '0', 09:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:41 INFO - Cleaning up... 09:51:41 INFO - Return code: 0 09:51:41 INFO - Running post-action listener: _resource_record_post_action 09:51:41 INFO - Running post-action listener: _start_resource_monitoring 09:51:41 INFO - Starting resource monitoring. 09:51:41 INFO - [mozharness: 2016-12-16 17:51:41.288447Z] Finished create-virtualenv step (success) 09:51:41 INFO - [mozharness: 2016-12-16 17:51:41.289438Z] Running install step. 09:51:41 INFO - Running pre-action listener: _resource_record_pre_action 09:51:41 INFO - Running main action method: install 09:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:41 INFO - Reading from file tmpfile_stdout 09:51:41 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:41 INFO - Reading from file tmpfile_stdout 09:51:41 INFO - Output received: 09:51:41 INFO - Usage: mozinstall [options] installer 09:51:41 INFO - Options: 09:51:41 INFO - -h, --help show this help message and exit 09:51:41 INFO - -d DEST, --destination=DEST 09:51:41 INFO - Directory to install application into. [default: 09:51:41 INFO - "/builds/slave/test"] 09:51:41 INFO - --app=APP Application being installed. [default: firefox] 09:51:41 INFO - mkdir: /builds/slave/test/build/application 09:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:52:03 INFO - Reading from file tmpfile_stdout 09:52:03 INFO - Output received: 09:52:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:52:03 INFO - Running post-action listener: _resource_record_post_action 09:52:03 INFO - [mozharness: 2016-12-16 17:52:03.529136Z] Finished install step (success) 09:52:03 INFO - [mozharness: 2016-12-16 17:52:03.529282Z] Running run-tests step. 09:52:03 INFO - Running pre-action listener: _resource_record_pre_action 09:52:03 INFO - Running main action method: run_tests 09:52:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:03 INFO - 2016-12-16 09:52:03.543 screenresolution[1625:7331] starting screenresolution argv=screenresolution get 09:52:03 INFO - 2016-12-16 09:52:03.546 screenresolution[1625:7331] Display 0: 1600x1200x32@60 09:52:03 INFO - 2016-12-16 09:52:03.552 screenresolution[1626:7334] starting screenresolution argv=screenresolution list 09:52:03 INFO - Available Modes on Display 0 09:52:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:03 INFO - Intel Iris: 09:52:03 INFO - Chipset Model: Intel Iris 09:52:03 INFO - Type: GPU 09:52:03 INFO - Bus: Built-In 09:52:03 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:03 INFO - Vendor: Intel (0x8086) 09:52:03 INFO - Device ID: 0x0a2e 09:52:03 INFO - Revision ID: 0x0009 09:52:03 INFO - Displays: 09:52:03 INFO - Display: 09:52:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:03 INFO - Display Serial Number: 1600x1200 60 09:52:03 INFO - Main Display: Yes 09:52:03 INFO - Mirror: Off 09:52:03 INFO - Online: Yes 09:52:03 INFO - Rotation: Supported 09:52:03 INFO - Return code: 0 09:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:03 INFO - Python 2.7.3 09:52:03 INFO - Return code: 0 09:52:03 INFO - grabbing minidump binary from tooltool 09:52:03 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')]} 09:52:03 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 0x10cb67d30>, '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 0x10c9cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb5fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:03 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 09:52:03 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 09:52:03 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 09:52:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:03 INFO - Return code: 0 09:52:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:52:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:52:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 09:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0234 --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 09:52:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hFBf9N0qzs/Render', 09:52:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:03 INFO - 'HOME': '/Users/cltbld', 09:52:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:03 INFO - 'LOGNAME': 'cltbld', 09:52:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:03 INFO - 'MOZ_NO_REMOTE': '1', 09:52:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:03 INFO - 'NO_EM_RESTART': '1', 09:52:03 INFO - 'PAGER': '/bin/cat', 09:52:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:03 INFO - 'PWD': '/builds/slave/test', 09:52:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:03 INFO - 'SHELL': '/bin/bash', 09:52:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uy7Jf2Eqvq/Listeners', 09:52:03 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:52:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:03 INFO - 'USER': 'cltbld', 09:52:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:03 INFO - 'XPC_FLAGS': '0x0', 09:52:03 INFO - 'XPC_SERVICE_NAME': '0', 09:52:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 09:52:04 INFO - mozversion application_buildid: 20161216081149 09:52:04 INFO - mozversion application_changeset: e4c249612e0e3b7570942073060315fee5dff07b 09:52:04 INFO - mozversion application_display_name: Nightly 09:52:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:04 INFO - mozversion application_name: Firefox 09:52:04 INFO - mozversion application_remotingname: firefox 09:52:04 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:52:04 INFO - mozversion application_vendor: Mozilla 09:52:04 INFO - mozversion application_version: 53.0a1 09:52:04 INFO - mozversion platform_buildid: 20161216081149 09:52:04 INFO - mozversion platform_changeset: e4c249612e0e3b7570942073060315fee5dff07b 09:52:04 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:52:04 INFO - mozversion platform_version: 53.0a1 09:52:04 INFO - using testdate: 1481910724 09:52:04 INFO - actual date: 1481910724 09:52:04 INFO - starting webserver on 'localhost:49246' 09:52:04 INFO - SUITE-START | Running 2 tests 09:52:04 INFO - TEST-START | dromaeo_css 09:52:04 INFO - operating with platform_type : mac_ 09:52:04 INFO - Initialising browser for dromaeo_css test... 09:52:04 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpTPT_Wp/profile http://localhost:49246/getInfo.html) 09:52:06 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 09:52:06 INFO - PROCESS | 1636 | colorDepth:24 09:52:06 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 09:52:06 INFO - PROCESS | 1636 | __metrics 09:52:06 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:52:06 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:07 INFO - TEST-INFO | 1636: exit 0 09:52:07 INFO - Browser initialized. 09:52:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:07 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpTPT_Wp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:19 INFO - PROCESS | 1638 | RSS: Main: 236961792 09:52:19 INFO - PROCESS | 1638 | 09:53:10 INFO - PROCESS | 1638 | 1481910790135 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:55:23 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 09:55:25 INFO - PROCESS | 1638 | RSS: Main: 407265280 09:55:25 INFO - PROCESS | 1638 | 09:58:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 09:58:28 INFO - PROCESS | 1638 | RSS: Main: 375308288 09:58:28 INFO - PROCESS | 1638 | 10:01:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 10:01:31 INFO - PROCESS | 1638 | RSS: Main: 370765824 10:01:31 INFO - PROCESS | 1638 | 10:04:34 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 10:04:35 INFO - PROCESS | 1638 | RSS: Main: 347934720 10:04:35 INFO - PROCESS | 1638 | 10:07:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 10:07:39 INFO - PROCESS | 1638 | RSS: Main: 337031168 10:07:39 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 10:10:42 INFO - PROCESS | 1638 | RSS: Main: 430235648 10:10:42 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | __start_tp_report 10:10:42 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:10:42 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:10:42 INFO - PROCESS | 1638 | |i|pagename|runs| 10:10:42 INFO - PROCESS | 1638 | |0;dojo.html;3169.239382548189;3299.422601044817;3314.9005529834108;3350.3969285528624;3375.6961873431387;5514.255575497306;5636.464535869091;5674.5176659983845;5700.885982280357;5744;5629.155626656004;5636.689982050985;5662.631928924628;5663.292088488939;5672.978863804514;4235.788210589473;5145.81989630363;5257.1851363038595;5264.078786212417;5267.947320526803;5162.741862906859;5291.417944026154;5314.5748340132695;5318.9202161967605;5324.281222035033;5274.156135018397;5295.841124766263;5306.893862122755;5316.73416329184;5363.678179309234;5104.438511763703;5125.666831655931;5156.819511317086;5235.73821308933;5261.4475480074425;5160.458151894035;5189.818356357509;5201.193814958649;5204.8178313758835;5230.738463076869;5592.7762889484375;5642.125470552071;5666.943330566683;5693.857653558653;5709.115087161455;6092.908606370908;6231.096491008779;6246.500279977591;6271.560990730651;6271.560990730651;6162.952298109332;6174;6222.533310001768;6249.5625306228585;6260.937390626081;5844.678542680108;5860.501857342174;5861.472467477947;5876.118582212703;5906.763729450817;6185.041318595625;6212.782552610637;6230.314665386803;6259.6870156492;6267.373262673696;5959.582829201914;6029.095635654687;6031.4270144336215;6089.451949324582;6150.231221097363;5112.693238405707;6259.311475737756;6285.748570057238;6290.339514350927;6292.087647291117;6171.691415429301;6175.505959523227;6191.102290167991;6194.969025154845;6200.131981522591;4996.725180115129;6126.925569569787;6202.41077097675;6245;6287.182666253358;4813.614910807127;4868.95131048685;4883.243097319921;4887.682300650446;4889.413270407574;3744.588095309514;4400.361947517592;4424.0709451015;4460.888477788081;4462.977685111554;5761.308642962871;5763.366029736726;5763.769449222068;5763.827085187451;5771.509421699118;5132.692038477703;6136.120845438929;6187.938120618826;6195.907061393992;6212.875742485216;5806.738696758656;5817.214676018683;5821.650700957872;5821.650700957956;5833.416658334133;5368.4631536846;5368.5436737876935;5372.758225879845;5418.647787893774;5418.674879507243;6290.21372328459;6300.94121737401;6310.5898116622275;6327.082573026885;6328.335524769833;6211.378862113753;6234.501239900887;6235.3452887446165;6239;6254.21822272216;6152.800203960363;6160.568760186744;6172.5679202457195;6187.938120618736;6189.659568723763;6173.938260617516;6193.225846769154;6200.689965501617;6202.379762023942;6205.968970155121;6103.990995082673;6232.906506402317;6233.875322493615;6257.655828929453;6268.780592679234;5174.508421699932;5446.618736688394;5999.040153575407;6134.079888016833;6144.78493252734;6018.8194354169445;6024.578279520391;6127.830981140938;6128.264608247039;6140.508759299156;5962.016267316018;5967.492763115184;5978.910316345346;5985.221921150222;5997.910031349446;6035.879282414415;6047.879042419039;6086.513078953584;6107.877842443215;6119.602225855305;5751.194832723339;5807.245058142415;5826.854328641818;5856.502197313276;5914.053751399928 10:10:42 INFO - PROCESS | 1638 | |1;ext.html;447.90146167843073;491.3048037027604;502.8717676992366;506.38727140160404;512.0143723332584;30174.69825301749;39642;41719.582804171914;41799.79100104503;43656.3451548227;42168.15663686724;42614;42675.14649707004;42680.719578412696;42911;8375.246227839492;9275.907240927572;9470.195033422167;9476.857847132298;9477.194438472738;8546.44448110874;11155.27490713101;11438.71403214922;11452.828207576893;11621.070314374872;9598.80802383952;11043.558257669683;11348.262362946381;11388.373639449826;11420.428978551081;11258.831117533202;11329.773404531945;11349.489272982735;11353.772924541463;11378.431078446127;9521.761955951088;11179.161562882817;11250.774984500345;11253;11266.380349080797;39962;40192.39711404331;40238.798806006074;40335;40404.393934091015;3323;3369.1913940654067;3419.1623052352084;3434.4848272759036;3559.056849934769;27668.031618893445;27860.16419507418;28583.571246431322;28916.987905423208;29293;3170.619525656936;3188.3145123798263;3191.340502938482;3193.5369371441243;3266.6080070391467;474661;476243;476722;481099.5945020252;482103.5894820539;54669.72665136649;55137;55141.72429137909;55167;55288.44711552913;56768.43231567714;56994;57019.71490142523;57030;57075.42924570701;15001.474948376754;15561.84438155604;15593.610159745871;15599;15620.984635998624;10761.246712730033;11189;11218.439078046065;12138.27170369763;12212.267263964191;16969.321227151024;17026.829731702524;17341.913290433466;17413.3034678614;17611;6532.346765323525;7556.828691552818;7652.354743730125;7666.8083297918;7669.884951725729;733.5635296998278;967.1923943507251;985.2216748768536;1004.8894621591619;1024.5799222318963;29274.414511710074;29678.703212967594;29692.406151877272;30533.23666908345;30561.847190763903;1027.244974943416;1040.6565833275001;1060.5280650110626;1074.1084899533369;1116.3469370418234;14968.401263949538;15303.387864485296;15503.922480387526;15606.29771660278;15692.450764223426;667146.9351637467;669422.6528867325;670636;670977.6451117811;673021;57140.42859571351;57550.7122464385;57552.71223643855;57582.13626795601;57697.711511442176;1250.831137796404;1300.9349532523524;1361.9591412257648;1394.7001394700187;1419.0279658434006;28660.713392866637;30017.64744112048;30162.84918575393;30552.694473054984;31173.53239701452;48445.7888552789;49051.75474122607;49320.50679493159;49324.75337623289;49380.25929610987;492596;493664.53167733934;497658;497733;498616;24481.510369792148;24802.875985619958;25171;25177.992880285317;25491.617625735256;40896.1820763589;41026.58973410347;41063.38404923988;41150.176996459304;41539;30454.390912182076;31378.843105784326;34333.656663433045;34835.825820870734;35781.28437431289;34116;34449.13877153091;34662.960111196706;35008.474872877436;35707;33778.49332260067;34532.30935381329;34544.654553454144;34634.307313854086;34665.48001779925;29705.81176752992;30367.39265214639;30554.541681875235;30607.08178754641;30616;21314.573708525433;23102.306930792103;23359.649605255596;23486.177983770485;23634.054637814294 10:10:42 INFO - PROCESS | 1638 | |2;jquery.html;350.4707891084462;365.50656613571664;368.6589904338486;379.66399736233427;395.07749405139;14759.188244646553;14942.92528537357;15672.902896797215;19314.034298285063;20500;19429.902850485727;19935.700964485546;20493.795062049412;20776.272830450936;20962.89518552409;5765.308163020433;5772.701142242982;6023.277206735176;6038.849028774272;6102.969485152568;5403.135498320269;5898.026825573776;5951.791687290945;5957.731902064417;5963.880722385549;5629.183768353586;5846.415358464141;5893.263342082239;5902.350741418462;5907.4978626816555;5874.706264686749;6029.638221706711;6031.547633927473;6038.124471951543;6046.8185954421215;5593.272874526327;5615.9157612635845;5784.132380143013;5803.332616749043;5808.448197421239;13107;13318.200907945555;13338.199708017453;14714.264286785725;23877.403064923343;2196.363054714131;2260.1750361118075;2320.3734991552355;2339.415146213447;2368.911762512117;9642.373245739074;9787.265955053399;9827;10298.845517317246;10319.43243121628;1786.4640607817603;1808.2947650416347;1836.6877630802796;1841.4015444980434;1874.2502998800453;113711.43144284308;118376;118547.58104217381;120179;120251;10778.73053173677;10934.4532773361;11003.449827508593;11290;11404.885951140383;14202.786958195635;14211.36048877803;14220;14221;14232.786508202178;6698.7320507179165;8111.95944020288;8287.295579875778;8412.621432035574;8420.53687047206;8123.675052997932;8132.715354962666;8177;8335.208155225244;8343.45767525109;4370.235208838504;4457.286834106528;4491.124230774967;4509.774511274489;4566.725996440225;1459.3432955170215;1703.730720613151;1824.8412258215862;1861.7393564900924;1931.719900614403;851.9701810436605;880.8458519759016;899.6761165980242;908.927285817133;946.5551190940247;19148.712769308473;19892;20557.074931628114;20570.280040198522;20596.27913023037;911.6991392840347;925.9768505787274;927.5686805635412;947.9619816301139;992.7815880506278;10317.380957142595;10652.987966143204;10725.51735171919;10813;10820.621278255223;483935;544895;548059;557636;560213;104019.47990260151;134019;136556;137555;139374.60625393616;955.1499165742495;986.8717066781417;1014.9391036537831;1017.2167431078176;1017.8473229015707;16403.58991025234;17612.559686007953;18082.638347233245;18491.537711557317;18980.620387592448;50591.747041264556;51184.976300474525;51995.48004519907;52589.7370513145;52930.470695292555;71712;73999.04003840001;75279.49441011039;77384.61307693426;78675.60662196652;6309.526785491014;7103.2541583133025;7824;8278.254957053654;8309.335253179852;12077.57728479499;12552.309622970459;12744.362781861055;12835.550755723505;12907.806382904451;10772.030517253485;11157.163212758913;11298.265612735146;11434.656960291204;11555.711107222387;10787.298825576312;10926.50830712604;11243.988041076342;11307.265027773168;11398.487068081791;11123.72190695239;11228.4385780709;11617.48972633586;11668.824967625662;11737.471813768572;7913.9604301978125;8031.799205019921;8093.716719914774;8108.594570271581;8171.264586187272;9481.888583562328;11044.779104418027;11195.832062519232;11231.38227397501;11384.032357249727 10:10:42 INFO - PROCESS | 1638 | |3;mootools.html;1357.8438479574852;1473.6684246044642;1497.827749808772;1703.9574010649733;1888.848892088633;7426.145993210783;7804.219578042193;8044.477108987911;8384.077751447336;8387.370947178955;6914.757983470579;8372.120927302636;8373.49759014458;8376.664933402672;8378.287845533137;2056.0953180600486;2291.63333866581;2339.228054741931;2339.836211465198;2340.1926335414255;2139.454439118023;2288.9885550572226;2359.740428552858;2362.7637236276405;2373.074500944633;2289.5306462175213;2304.078368652544;2318.6637937499054;2322.489052408476;2324.941876453085;2298.321995011467;2320.756320586331;2321.117975169433;2326.906923723049;2329.7320808107115;2277.6128058230142;2293.70181876355;2319.373769082355;2325.1048346386765;2325.197806756666;8255.917440825635;8329.416940814146;8338.791530211733;8340.457870238415;8354.540500272482;5043.62172837035;5193.8961220775755;5198.506141916512;5199.506046925536;5203.453637368059;3329.433996220624;3363.9159021024425;3478.0696713324096;3558.9644103558894;3560.092176495003;1045.796069766396;1062.219268837404;1072.9463526823627;1081.6971248050559;1090.7491277006254;10206.387616742944;10626.362418254852;10628.734281642943;10756.892431075745;10790.73023174419;4268.146370725867;4304.397384366192;4465.665075119314;4476.6194873436125;4482.282834746425;8577.914220857712;8587.785305367415;8589.14108589136;8592.097829727914;8597.957010214908;5031.245313202976;5092.10888094582;5097.108006098918;5101.795928162906;5112.105381558213;4074.388841673713;4440;4795.136875362398;4796.232602783538;4798.688085274446;3585.8565657373415;3616.264193187232;3701.759385639925;3707.1658876753054;3717.2937141942944;1135.233717240859;1158.7624536969902;1169;1173.4191575170346;1173.9413029348498;834.7020383303899;853.9188777066169;883.394874510962;888.760034790603;942.8161508505913;4278.657707383401;5297.841064768063;5382.946170538323;5572;5598.188262701967;798.9320907722793;877.2893955895745;891.6611687558686;928.2991341537231;995.1740055753708;3688.7971161585833;3695.5380577427823;3699.297133544672;3812.161324508659;3830.597787232356;9761.121499065119;9995.000499950092;10063.698089057194;10079.244056695778;10083.949580252052;10056.849147262797;10086.596536138471;10110.39337639744;10130.138938190335;10171.593136274467;6470.805875823733;7369.18938916708;7853.725119620786;7860.449768516149;7914.881276780853;5267.841964740911;5509.173623956439;5535.3634332050715;5559.444055594408;5590.888182236414;8125.187481251827;8646.178613031752;8674.826503470022;8777.122287771172;8837.116288371111;8885.511296878734;8956.417832840845;8957.820843583222;8993.14565116313;9002.414843035443;7089.255628158969;7122.394596459152;7175.533590316612;7277.235890231449;7321.487495875238;7802.765917022499;7870.527768333918;7870.9606451967375;7878.172791857001;7895.01312335958;5791.276090488689;7083.964580177066;7127.322904324288;7182.533135346186;7302.561846289027;6989.895151572832;7022.719091236293;7045.084139061889;7095.184053833876;7133;6367;6600.504962127764;6672.499562532927;6749.898751518829;6767.289434609295;4779.713217206979;4795.472498025145;4806.759662016955;4862.465128835896;4942.382202224722;4490.483594386556;4577.610903073143;4770.189067858403;4874.5856602189215;4941.901161976813 10:10:42 INFO - PROCESS | 1638 | |4;prototype.html;348.86394306220575;352.8835484290183;359.59904706252536;369.21541723836845;370.29274086494786;4860.222364421693;5255;5256.710880901549;5304.522592966632;5379.112446446336;4633.733218081253;4919.687746759027;5106.676462209695;5114.769835357409;5152.814852583908;3757.567879693829;3869.303525365433;4101.5488296287385;4137.551856850108;4148.216267005187;3598.3882739934143;4069.308217603;4083.1017176221185;4086.570910054446;4120.402541631476;3631.019624701329;3934.310366829275;4001.25976694311;4044.9191016179657;4071.531773846016;3681.5582130144285;3968.0278331808604;4031.778252196128;4040.696947728932;4079.77561234132;3063.2188791858157;3114.2370119320685;3568.661751843059;3577.5528058992627;3602.945955810665;4899.902001959977;4923.359963204761;5025.924611130836;5037.748112594356;5074.3657042869645;4484.170428470711;4675.859724208279;4688.484266730657;4691.272852707836;4709.788059537294;5012.774425150877;5295.576353891718;5432.91850622241;5450.601735236483;5462.6449280797015;3470.9934119105683;3762.49206357141;3881.7384350086336;4024.2555127301544;4034.9105741449644;4455.353973673831;5484.588655850827;5678.063119585305;5721.856953576153;5761.444410009274;3280.5571247881708;3606.5672119345845;3608.801515916597;4014.6386825185873;4051.7974101294817;3730.142067324476;3744.6706419221327;3902.083010492532;3965.7507885016125;4151.398047283127;4144.606262405066;4401.801918913657;4629.398178236807;4714.292856071616;4772.976135119372;4887.242477416006;5385.057614917374;5500.80747173847;5506.64206826555;5562.721863906789;1106.2422240765102;1118.5022664914036;1245.339969815999;1253.2042153232762;1265.1270623270098;779.2635959018673;794.7059587952378;801.6152246921511;809.926846927823;810.7446154461326;4245.61789438952;4294.914101717948;4365.995820961197;4839.516048395132;4840.588549973291;4790.257510085942;5036.79852805891;5042.747862606929;5379.821172425174;5395.381385584309;4425.712328698624;4508.233600287959;4737.8104875805275;4764.666473346832;4865.9026819463415;2267.4354695260217;2407.4462873538832;2626.632271481994;2802.985985070062;2810.437912417525;4991.007194244662;5262.052830490548;5277.997180535686;5441.020616289027;5497.642653227527;4651.3720647712125;4696.285855662659;4740.525947405232;5435.782568697208;5790.855228619234;5404.459554044722;5827.679477628772;5852.297724273115;5857.238558987305;5898.557608179318;5110.437851836221;5304;5562.499375056264;5631.746571404378;5684.346300175533;4558.407407037064;4948.975255123702;5288.4182739897815;5584.46947539983;5586.692731899784;5107.770150343169;5690.715464226855;5802.926458605171;5865.627264323117;5908.990943079201;3431.519587257736;3438.914027149341;3502.2470168913806;3770.905727356728;3805.752626079296;4679.649026322972;4774.045190961752;5356.000639641813;5761.024892823938;5761.415610707089;5001.673218022794;5438.673679579238;5590.413006634408;5618.606697531133;5645.645045189043;4650.767716437179;5315.548178404879;5404.675989324628;5447.727613619224;5489.670619762827;4298.76356800379;4781.039773692769;4976.377952755905;5398.433164517669;5426.538744206787;4215.768132752728;4542.454905411372;4563.794629241625;5416.431274716098;5488.4237155098135;4592.471865735483;5355.089634762022;5374.704391258519;5389.973050134724;5394.190871369169 10:10:42 INFO - PROCESS | 1638 | |5;yui.html;604.9455549000589;645.515863102673;713.3615414204287;739.8298391369981;789.218673513222;14438.639034024141;15189.4683686071;15502.379904803794;15551.533453996384;15567.610809729762;13582.993017059965;13888.444462221525;13922.512712055055;13938.651533711662;13940.51208207713;847.6905929335779;884.1335491218609;898.6630013744846;900.9549522523847;903.3541018172006;899.2850683706437;899.6626265150569;900.0954041188596;901.1979338388807;904.6110172625769;940.7977284883749;943.0239701908527;943.085207348874;943.9805010588548;944.6976967370445;944.0936700767272;945.3760518058049;950.6577632052456;950.7242899559085;951.0679534056663;696.8780463418882;697.9825504362432;700.1108592088019;700.7302188657353;701.2461603775911;14193.148411095368;14529.529979903442;14895.851041489555;15101.395944162221;15101.848981510264;12415.379231038412;13788.379522921392;13819.378127984264;14029.579112626638;14389.136651800925;11637.301761894229;11691.649250522498;11707.882921170765;11803.822942655781;11824.408779560987;3683.613220611851;3699.8705045323286;3745.325841348556;3852.383618621035;3863.8068096595057;109500.35749463765;112002;112530;113807;113913.43043284814;10777;10793.78412431747;10911;10921.726956825984;10962.068224201032;22129.004194811274;22147.892605369667;22156.446088847908;22186.55626887453;22191.556168876534;7332.8900066499045;7627.161012288644;7828.765137045898;7864.449488535862;7972.043354797462;4448.7330760153845;4465.441819772528;4467.285234362552;4579.4046773919845;4631;2922.8100173488656;3209.422303985305;3524.806135662563;3554.289142171576;3590.551181102362;548.4707257496456;633.7465013994439;636.2555809702567;643.7199818079057;658.6410406328563;435.6408007018124;492.9507049295042;520.2014907117556;548.2899644959707;587.6620942957817;8104.388755372563;8231.46495477792;8314.833703326021;8470.49417878384;8570.914290857136;524.1875093604973;543.0474076423047;554.7630369313666;562.9408912064256;581.8050952930731;4004.699647526389;4058.5941405859176;4068.349064149722;4079.796010199478;4259.467566554181;101219;101694;101772;103748.48125759474;106239;53020;62804;72814.27185728181;78366.21633783703;98265.50867245618;66508.33491665215;80111.19888801154;80957.59521202356;81113;82988.58505707554;8827.867581986147;9212.03916161889;9224.631014759603;9318.440893546409;9342.159205671522;49196.01607967749;50145.49854501408;50479.49520504748;50557.74721126371;55054.44945550653;68877;72291;73503;74309;77663.61168194123;11171.871875874767;11546.653600392001;11683.349585083006;11725;12007.459664314953;13128.409221584861;13400.396982135633;13428.597142085362;13596.456141754219;13597.252151131783;12206.816897746363;12247.448864801283;12321.137520373488;12351.135420520837;12815.231086134861;11729.655942049025;11881.584144555245;12000.759984800081;12220.87779122233;12303.261804291771;11946.820797687868;11949.283043017447;11952.820707689218;11963.222390544586;11997.220180688228;10064.446455444728;10079.652281404971;10259.897401025893;10311;10331.276810623183;10143;10145.833229178445;10570.735731606772;10581.206409519164;10653 10:10:42 INFO - PROCESS | 1638 | __end_tp_report 10:10:42 INFO - PROCESS | 1638 | __start_cc_report 10:10:42 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1695 10:10:42 INFO - PROCESS | 1638 | __end_cc_report 10:10:42 INFO - PROCESS | 1638 | __startTimestamp1481911842550__endTimestamp 10:10:42 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:10:42 INFO - PROCESS | 1638 | Number of tests: 6 10:10:42 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5699.19 Median:5876.12 stddev:657.35 (11.2%) stddev-sans-first:628.69 10:10:42 INFO - PROCESS | 1638 | Values: 3169.2 3299.4 3314.9 3350.4 3375.7 5514.3 5636.5 5674.5 5700.9 5744.0 5629.2 5636.7 5662.6 5663.3 5673.0 4235.8 5145.8 5257.2 5264.1 5267.9 5162.7 5291.4 5314.6 5318.9 5324.3 5274.2 5295.8 5306.9 5316.7 5363.7 5104.4 5125.7 5156.8 5235.7 5261.4 5160.5 5189.8 5201.2 5204.8 5230.7 5592.8 5642.1 5666.9 5693.9 5709.1 6092.9 6231.1 6246.5 6271.6 6271.6 6163.0 6174.0 6222.5 6249.6 6260.9 5844.7 5860.5 5861.5 5876.1 5906.8 6185.0 6212.8 6230.3 6259.7 6267.4 5959.6 6029.1 6031.4 6089.5 6150.2 5112.7 6259.3 6285.7 6290.3 6292.1 6171.7 6175.5 6191.1 6195.0 6200.1 4996.7 6126.9 6202.4 6245.0 6287.2 4813.6 4869.0 4883.2 4887.7 4889.4 3744.6 4400.4 4424.1 4460.9 4463.0 5761.3 5763.4 5763.8 5763.8 5771.5 5132.7 6136.1 6187.9 6195.9 6212.9 5806.7 5817.2 5821.7 5821.7 5833.4 5368.5 5368.5 5372.8 5418.6 5418.7 6290.2 6300.9 6310.6 6327.1 6328.3 6211.4 6234.5 6235.3 6239.0 6254.2 6152.8 6160.6 6172.6 6187.9 6189.7 6173.9 6193.2 6200.7 6202.4 6206.0 6104.0 6232.9 6233.9 6257.7 6268.8 5174.5 5446.6 5999.0 6134.1 6144.8 6018.8 6024.6 6127.8 6128.3 6140.5 5962.0 5967.5 5978.9 5985.2 5997.9 6035.9 6047.9 6086.5 6107.9 6119.6 5751.2 5807.2 5826.9 5856.5 5914.1 10:10:42 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:67410.29 Median:18767.58 stddev:148439.81 (790.9%) stddev-sans-first:148771.08 10:10:42 INFO - PROCESS | 1638 | Values: 447.9 491.3 502.9 506.4 512.0 30174.7 39642.0 41719.6 41799.8 43656.3 42168.2 42614.0 42675.1 42680.7 42911.0 8375.2 9275.9 9470.2 9476.9 9477.2 8546.4 11155.3 11438.7 11452.8 11621.1 9598.8 11043.6 11348.3 11388.4 11420.4 11258.8 11329.8 11349.5 11353.8 11378.4 9521.8 11179.2 11250.8 11253.0 11266.4 39962.0 40192.4 40238.8 40335.0 40404.4 3323.0 3369.2 3419.2 3434.5 3559.1 27668.0 27860.2 28583.6 28917.0 29293.0 3170.6 3188.3 3191.3 3193.5 3266.6 474661.0 476243.0 476722.0 481099.6 482103.6 54669.7 55137.0 55141.7 55167.0 55288.4 56768.4 56994.0 57019.7 57030.0 57075.4 15001.5 15561.8 15593.6 15599.0 15621.0 10761.2 11189.0 11218.4 12138.3 12212.3 16969.3 17026.8 17341.9 17413.3 17611.0 6532.3 7556.8 7652.4 7666.8 7669.9 733.6 967.2 985.2 1004.9 1024.6 29274.4 29678.7 29692.4 30533.2 30561.8 1027.2 1040.7 1060.5 1074.1 1116.3 14968.4 15303.4 15503.9 15606.3 15692.5 667146.9 669422.7 670636.0 670977.6 673021.0 57140.4 57550.7 57552.7 57582.1 57697.7 1250.8 1300.9 1362.0 1394.7 1419.0 28660.7 30017.6 30162.8 30552.7 31173.5 48445.8 49051.8 49320.5 49324.8 49380.3 492596.0 493664.5 497658.0 497733.0 498616.0 24481.5 24802.9 25171.0 25178.0 25491.6 40896.2 41026.6 41063.4 41150.2 41539.0 30454.4 31378.8 34333.7 34835.8 35781.3 34116.0 34449.1 34663.0 35008.5 35707.0 33778.5 34532.3 34544.7 34634.3 34665.5 29705.8 30367.4 30554.5 30607.1 30616.0 21314.6 23102.3 23359.6 23486.2 23634.1 10:10:42 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:32884.94 Median:2329.89 stddev:90806.58 (3897.5%) stddev-sans-first:91028.45 10:10:42 INFO - PROCESS | 1638 | Values: 350.5 365.5 368.7 379.7 395.1 14759.2 14942.9 15672.9 19314.0 20500.0 19429.9 19935.7 20493.8 20776.3 20962.9 5765.3 5772.7 6023.3 6038.8 6103.0 5403.1 5898.0 5951.8 5957.7 5963.9 5629.2 5846.4 5893.3 5902.4 5907.5 5874.7 6029.6 6031.5 6038.1 6046.8 5593.3 5615.9 5784.1 5803.3 5808.4 13107.0 13318.2 13338.2 14714.3 23877.4 2196.4 2260.2 2320.4 2339.4 2368.9 9642.4 9787.3 9827.0 10298.8 10319.4 1786.5 1808.3 1836.7 1841.4 1874.3 113711.4 118376.0 118547.6 120179.0 120251.0 10778.7 10934.5 11003.4 11290.0 11404.9 14202.8 14211.4 14220.0 14221.0 14232.8 6698.7 8112.0 8287.3 8412.6 8420.5 8123.7 8132.7 8177.0 8335.2 8343.5 4370.2 4457.3 4491.1 4509.8 4566.7 1459.3 1703.7 1824.8 1861.7 1931.7 852.0 880.8 899.7 908.9 946.6 19148.7 19892.0 20557.1 20570.3 20596.3 911.7 926.0 927.6 948.0 992.8 10317.4 10653.0 10725.5 10813.0 10820.6 483935.0 544895.0 548059.0 557636.0 560213.0 104019.5 134019.0 136556.0 137555.0 139374.6 955.1 986.9 1014.9 1017.2 1017.8 16403.6 17612.6 18082.6 18491.5 18980.6 50591.7 51185.0 51995.5 52589.7 52930.5 71712.0 73999.0 75279.5 77384.6 78675.6 6309.5 7103.3 7824.0 8278.3 8309.3 12077.6 12552.3 12744.4 12835.6 12907.8 10772.0 11157.2 11298.3 11434.7 11555.7 10787.3 10926.5 11244.0 11307.3 11398.5 11123.7 11228.4 11617.5 11668.8 11737.5 7914.0 8031.8 8093.7 8108.6 8171.3 9481.9 11044.8 11195.8 11231.4 11384.0 10:10:42 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5331.42 Median:5067.87 stddev:2894.09 (57.1%) stddev-sans-first:2886.80 10:10:42 INFO - PROCESS | 1638 | Values: 1357.8 1473.7 1497.8 1704.0 1888.8 7426.1 7804.2 8044.5 8384.1 8387.4 6914.8 8372.1 8373.5 8376.7 8378.3 2056.1 2291.6 2339.2 2339.8 2340.2 2139.5 2289.0 2359.7 2362.8 2373.1 2289.5 2304.1 2318.7 2322.5 2324.9 2298.3 2320.8 2321.1 2326.9 2329.7 2277.6 2293.7 2319.4 2325.1 2325.2 8255.9 8329.4 8338.8 8340.5 8354.5 5043.6 5193.9 5198.5 5199.5 5203.5 3329.4 3363.9 3478.1 3559.0 3560.1 1045.8 1062.2 1072.9 1081.7 1090.7 10206.4 10626.4 10628.7 10756.9 10790.7 4268.1 4304.4 4465.7 4476.6 4482.3 8577.9 8587.8 8589.1 8592.1 8598.0 5031.2 5092.1 5097.1 5101.8 5112.1 4074.4 4440.0 4795.1 4796.2 4798.7 3585.9 3616.3 3701.8 3707.2 3717.3 1135.2 1158.8 1169.0 1173.4 1173.9 834.7 853.9 883.4 888.8 942.8 4278.7 5297.8 5382.9 5572.0 5598.2 798.9 877.3 891.7 928.3 995.2 3688.8 3695.5 3699.3 3812.2 3830.6 9761.1 9995.0 10063.7 10079.2 10083.9 10056.8 10086.6 10110.4 10130.1 10171.6 6470.8 7369.2 7853.7 7860.4 7914.9 5267.8 5509.2 5535.4 5559.4 5590.9 8125.2 8646.2 8674.8 8777.1 8837.1 8885.5 8956.4 8957.8 8993.1 9002.4 7089.3 7122.4 7175.5 7277.2 7321.5 7802.8 7870.5 7871.0 7878.2 7895.0 5791.3 7084.0 7127.3 7182.5 7302.6 6989.9 7022.7 7045.1 7095.2 7133.0 6367.0 6600.5 6672.5 6749.9 6767.3 4779.7 4795.5 4806.8 4862.5 4942.4 4490.5 4577.6 4770.2 4874.6 4941.9 10:10:42 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4375.91 Median:4777.54 stddev:1336.76 (28.0%) stddev-sans-first:1305.90 10:10:42 INFO - PROCESS | 1638 | Values: 348.9 352.9 359.6 369.2 370.3 4860.2 5255.0 5256.7 5304.5 5379.1 4633.7 4919.7 5106.7 5114.8 5152.8 3757.6 3869.3 4101.5 4137.6 4148.2 3598.4 4069.3 4083.1 4086.6 4120.4 3631.0 3934.3 4001.3 4044.9 4071.5 3681.6 3968.0 4031.8 4040.7 4079.8 3063.2 3114.2 3568.7 3577.6 3602.9 4899.9 4923.4 5025.9 5037.7 5074.4 4484.2 4675.9 4688.5 4691.3 4709.8 5012.8 5295.6 5432.9 5450.6 5462.6 3471.0 3762.5 3881.7 4024.3 4034.9 4455.4 5484.6 5678.1 5721.9 5761.4 3280.6 3606.6 3608.8 4014.6 4051.8 3730.1 3744.7 3902.1 3965.8 4151.4 4144.6 4401.8 4629.4 4714.3 4773.0 4887.2 5385.1 5500.8 5506.6 5562.7 1106.2 1118.5 1245.3 1253.2 1265.1 779.3 794.7 801.6 809.9 810.7 4245.6 4294.9 4366.0 4839.5 4840.6 4790.3 5036.8 5042.7 5379.8 5395.4 4425.7 4508.2 4737.8 4764.7 4865.9 2267.4 2407.4 2626.6 2803.0 2810.4 4991.0 5262.1 5278.0 5441.0 5497.6 4651.4 4696.3 4740.5 5435.8 5790.9 5404.5 5827.7 5852.3 5857.2 5898.6 5110.4 5304.0 5562.5 5631.7 5684.3 4558.4 4949.0 5288.4 5584.5 5586.7 5107.8 5690.7 5802.9 5865.6 5909.0 3431.5 3438.9 3502.2 3770.9 3805.8 4679.6 4774.0 5356.0 5761.0 5761.4 5001.7 5438.7 5590.4 5618.6 5645.6 4650.8 5315.5 5404.7 5447.7 5489.7 4298.8 4781.0 4976.4 5398.4 5426.5 4215.8 4542.5 4563.8 5416.4 5488.4 4592.5 5355.1 5374.7 5390.0 5394.2 10:10:42 INFO - PROCESS | 1638 | 10:10:42 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20090.02 Median:4031.65 stddev:29552.59 (733.0%) stddev-sans-first:29599.28 10:10:42 INFO - PROCESS | 1638 | Values: 604.9 645.5 713.4 739.8 789.2 14438.6 15189.5 15502.4 15551.5 15567.6 13583.0 13888.4 13922.5 13938.7 13940.5 847.7 884.1 898.7 901.0 903.4 899.3 899.7 900.1 901.2 904.6 940.8 943.0 943.1 944.0 944.7 944.1 945.4 950.7 950.7 951.1 696.9 698.0 700.1 700.7 701.2 14193.1 14529.5 14895.9 15101.4 15101.8 12415.4 13788.4 13819.4 14029.6 14389.1 11637.3 11691.6 11707.9 11803.8 11824.4 3683.6 3699.9 3745.3 3852.4 3863.8 109500.4 112002.0 112530.0 113807.0 113913.4 10777.0 10793.8 10911.0 10921.7 10962.1 22129.0 22147.9 22156.4 22186.6 22191.6 7332.9 7627.2 7828.8 7864.4 7972.0 4448.7 4465.4 4467.3 4579.4 4631.0 2922.8 3209.4 3524.8 3554.3 3590.6 548.5 633.7 636.3 643.7 658.6 435.6 493.0 520.2 548.3 587.7 8104.4 8231.5 8314.8 8470.5 8570.9 524.2 543.0 554.8 562.9 581.8 4004.7 4058.6 4068.3 4079.8 4259.5 101219.0 101694.0 101772.0 103748.5 106239.0 53020.0 62804.0 72814.3 78366.2 98265.5 66508.3 80111.2 80957.6 81113.0 82988.6 8827.9 9212.0 9224.6 9318.4 9342.2 49196.0 50145.5 50479.5 50557.7 55054.4 68877.0 72291.0 73503.0 74309.0 77663.6 11171.9 11546.7 11683.3 11725.0 12007.5 13128.4 13400.4 13428.6 13596.5 13597.3 12206.8 12247.4 12321.1 12351.1 12815.2 11729.7 11881.6 12000.8 12220.9 12303.3 11946.8 11949.3 11952.8 11963.2 11997.2 10064.4 10079.7 10259.9 10311.0 10331.3 10143.0 10145.8 10570.7 10581.2 10653.0 10:10:42 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:10:42 INFO - PROCESS | 1638 | 10:10:43 INFO - TEST-INFO | 1638: exit 0 10:10:43 INFO - TEST-OK | dromaeo_css | took 1119089ms 10:10:43 INFO - TEST-START | kraken 10:10:43 INFO - operating with platform_type : mac_ 10:10:43 INFO - Initialising browser for kraken test... 10:10:43 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmphEijp4/profile http://localhost:49246/getInfo.html) 10:10:45 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 10:10:45 INFO - PROCESS | 1648 | colorDepth:24 10:10:45 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 10:10:45 INFO - PROCESS | 1648 | __metrics 10:10:45 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:10:45 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:46 INFO - TEST-INFO | 1648: exit 0 10:10:46 INFO - Browser initialized. 10:10:46 INFO - Running cycle 1/1 for kraken test... 10:10:46 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmphEijp4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:58 INFO - PROCESS | 1649 | RSS: Main: 229949440 10:10:58 INFO - PROCESS | 1649 | 10:11:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:02 INFO - PROCESS | 1649 | RSS: Main: 289083392 10:11:02 INFO - PROCESS | 1649 | 10:11:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 10:11:05 INFO - PROCESS | 1649 | RSS: Main: 291381248 10:11:05 INFO - PROCESS | 1649 | 10:11:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 10:11:09 INFO - PROCESS | 1649 | RSS: Main: 384622592 10:11:09 INFO - PROCESS | 1649 | 10:11:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 10:11:12 INFO - PROCESS | 1649 | RSS: Main: 285478912 10:11:12 INFO - PROCESS | 1649 | 10:11:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:14 INFO - PROCESS | 1649 | RSS: Main: 289480704 10:11:14 INFO - PROCESS | 1649 | 10:11:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:18 INFO - PROCESS | 1649 | RSS: Main: 331522048 10:11:18 INFO - PROCESS | 1649 | 10:11:21 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:22 INFO - PROCESS | 1649 | RSS: Main: 333758464 10:11:22 INFO - PROCESS | 1649 | 10:11:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 10:11:25 INFO - PROCESS | 1649 | RSS: Main: 329973760 10:11:25 INFO - PROCESS | 1649 | 10:11:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:27 INFO - PROCESS | 1649 | RSS: Main: 304619520 10:11:27 INFO - PROCESS | 1649 | 10:11:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:30 INFO - PROCESS | 1649 | RSS: Main: 309710848 10:11:30 INFO - PROCESS | 1649 | 10:11:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:33 INFO - PROCESS | 1649 | RSS: Main: 311021568 10:11:33 INFO - PROCESS | 1649 | 10:11:36 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:36 INFO - PROCESS | 1649 | RSS: Main: 329084928 10:11:36 INFO - PROCESS | 1649 | 10:11:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:40 INFO - PROCESS | 1649 | RSS: Main: 323104768 10:11:40 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 10:11:42 INFO - PROCESS | 1649 | RSS: Main: 367210496 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | __start_tp_report 10:11:42 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 10:11:42 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 10:11:42 INFO - PROCESS | 1649 | |i|pagename|runs| 10:11:42 INFO - PROCESS | 1649 | |0;ai-astar;103;115;114;113;113;113;113;113;114;113 10:11:42 INFO - PROCESS | 1649 | |1;audio-beat-detection;142;111;108;146;110;109;109;108;127;117 10:11:42 INFO - PROCESS | 1649 | |2;audio-dft;186;183;182;185;185;186;180;183;183;184 10:11:42 INFO - PROCESS | 1649 | |3;audio-fft;79;63;77;113;85;59;58;60;73;70 10:11:42 INFO - PROCESS | 1649 | |4;audio-oscillator;87;70;85;68;69;68;82;68;70;84 10:11:42 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;110;112;110;112;110;112;108;112;109;112 10:11:42 INFO - PROCESS | 1649 | |6;imaging-darkroom;95;93;96;95;109;150;149;95;95;94 10:11:42 INFO - PROCESS | 1649 | |7;imaging-desaturate;100;131;141;88;86;86;87;87;85;85 10:11:42 INFO - PROCESS | 1649 | |8;json-parse-financial;53;54;54;54;54;55;55;56;55;55 10:11:42 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;73;66;71;77;73;71;71;71;72;71 10:11:42 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;87;88;86;87;90;86;86;84;86;87 10:11:42 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;138;140;136;137;143;126;146;141;209;152 10:11:42 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;173;170;172;172;169;230;218;170;167;172 10:11:42 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;67;66;67;68;67;67;66;66;66;66 10:11:42 INFO - PROCESS | 1649 | __end_tp_report 10:11:42 INFO - PROCESS | 1649 | __start_cc_report 10:11:42 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2010 10:11:42 INFO - PROCESS | 1649 | __end_cc_report 10:11:42 INFO - PROCESS | 1649 | __startTimestamp1481911902467__endTimestamp 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | ------- Summary: start ------- 10:11:42 INFO - PROCESS | 1649 | Number of tests: 14 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.37 (3.0%) stddev-sans-first:0.73 10:11:42 INFO - PROCESS | 1649 | Values: 103.0 115.0 114.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:114.00 stddev:14.58 (12.8%) stddev-sans-first:12.79 10:11:42 INFO - PROCESS | 1649 | Values: 142.0 111.0 108.0 146.0 110.0 109.0 109.0 108.0 127.0 117.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:1.89 (1.0%) stddev-sans-first:1.81 10:11:42 INFO - PROCESS | 1649 | Values: 186.0 183.0 182.0 185.0 185.0 186.0 180.0 183.0 183.0 184.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:73.70 Median:71.50 stddev:16.63 (23.3%) stddev-sans-first:17.53 10:11:42 INFO - PROCESS | 1649 | Values: 79.0 63.0 77.0 113.0 85.0 59.0 58.0 60.0 73.0 70.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:8.21 (10.8%) stddev-sans-first:7.50 10:11:42 INFO - PROCESS | 1649 | Values: 87.0 70.0 85.0 68.0 69.0 68.0 82.0 68.0 70.0 84.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:112.00 stddev:1.49 (1.3%) stddev-sans-first:1.56 10:11:42 INFO - PROCESS | 1649 | Values: 110.0 112.0 110.0 112.0 110.0 112.0 108.0 112.0 109.0 112.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:107.10 Median:95.00 stddev:22.80 (24.0%) stddev-sans-first:23.76 10:11:42 INFO - PROCESS | 1649 | Values: 95.0 93.0 96.0 95.0 109.0 150.0 149.0 95.0 95.0 94.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:86.00 stddev:20.84 (24.2%) stddev-sans-first:22.09 10:11:42 INFO - PROCESS | 1649 | Values: 100.0 131.0 141.0 88.0 86.0 86.0 87.0 87.0 85.0 85.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:0.85 (1.5%) stddev-sans-first:0.71 10:11:42 INFO - PROCESS | 1649 | Values: 53.0 54.0 54.0 54.0 54.0 55.0 55.0 56.0 55.0 55.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:2.72 (3.8%) stddev-sans-first:2.83 10:11:42 INFO - PROCESS | 1649 | Values: 73.0 66.0 71.0 77.0 73.0 71.0 71.0 71.0 72.0 71.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:1.57 (1.8%) stddev-sans-first:1.66 10:11:42 INFO - PROCESS | 1649 | Values: 87.0 88.0 86.0 87.0 90.0 86.0 86.0 84.0 86.0 87.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:142.00 stddev:22.89 (16.1%) stddev-sans-first:24.05 10:11:42 INFO - PROCESS | 1649 | Values: 138.0 140.0 136.0 137.0 143.0 126.0 146.0 141.0 209.0 152.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.30 Median:172.00 stddev:22.75 (13.2%) stddev-sans-first:23.93 10:11:42 INFO - PROCESS | 1649 | Values: 173.0 170.0 172.0 172.0 169.0 230.0 218.0 170.0 167.0 172.0 10:11:42 INFO - PROCESS | 1649 | 10:11:42 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 10:11:42 INFO - PROCESS | 1649 | Values: 67.0 66.0 67.0 68.0 67.0 67.0 66.0 66.0 66.0 66.0 10:11:42 INFO - PROCESS | 1649 | -------- Summary: end -------- 10:11:42 INFO - PROCESS | 1649 | 10:11:43 INFO - TEST-INFO | 1649: exit 0 10:11:43 INFO - TEST-OK | kraken | took 60128ms 10:11:43 INFO - SUITE-END | took 1179s 10:11:43 INFO - Completed test suite (00:19:39) 10:11:43 INFO - javascript benchmark 10:11:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3169.239382548189, 3299.422601044817, 3314.9005529834108, 3350.3969285528624, 3375.6961873431387, 5514.255575497306, 5636.464535869091, 5674.5176659983845, 5700.885982280357, 5744.0, 5629.155626656004, 5636.689982050985, 5662.631928924628, 5663.292088488939, 5672.978863804514, 4235.788210589473, 5145.81989630363, 5257.1851363038595, 5264.078786212417, 5267.947320526803, 5162.741862906859, 5291.417944026154, 5314.5748340132695, 5318.9202161967605, 5324.281222035033, 5274.156135018397, 5295.841124766263, 5306.893862122755, 5316.73416329184, 5363.678179309234, 5104.438511763703, 5125.666831655931, 5156.819511317086, 5235.73821308933, 5261.4475480074425, 5160.458151894035, 5189.818356357509, 5201.193814958649, 5204.8178313758835, 5230.738463076869, 5592.7762889484375, 5642.125470552071, 5666.943330566683, 5693.857653558653, 5709.115087161455, 6092.908606370908, 6231.096491008779, 6246.500279977591, 6271.560990730651, 6271.560990730651, 6162.952298109332, 6174.0, 6222.533310001768, 6249.5625306228585, 6260.937390626081, 5844.678542680108, 5860.501857342174, 5861.472467477947, 5876.118582212703, 5906.763729450817, 6185.041318595625, 6212.782552610637, 6230.314665386803, 6259.6870156492, 6267.373262673696, 5959.582829201914, 6029.095635654687, 6031.4270144336215, 6089.451949324582, 6150.231221097363, 5112.693238405707, 6259.311475737756, 6285.748570057238, 6290.339514350927, 6292.087647291117, 6171.691415429301, 6175.505959523227, 6191.102290167991, 6194.969025154845, 6200.131981522591, 4996.725180115129, 6126.925569569787, 6202.41077097675, 6245.0, 6287.182666253358, 4813.614910807127, 4868.95131048685, 4883.243097319921, 4887.682300650446, 4889.413270407574, 3744.588095309514, 4400.361947517592, 4424.0709451015, 4460.888477788081, 4462.977685111554, 5761.308642962871, 5763.366029736726, 5763.769449222068, 5763.827085187451, 5771.509421699118, 5132.692038477703, 6136.120845438929, 6187.938120618826, 6195.907061393992, 6212.875742485216, 5806.738696758656, 5817.214676018683, 5821.650700957872, 5821.650700957956, 5833.416658334133, 5368.4631536846, 5368.5436737876935, 5372.758225879845, 5418.647787893774, 5418.674879507243, 6290.21372328459, 6300.94121737401, 6310.5898116622275, 6327.082573026885, 6328.335524769833, 6211.378862113753, 6234.501239900887, 6235.3452887446165, 6239.0, 6254.21822272216, 6152.800203960363, 6160.568760186744, 6172.5679202457195, 6187.938120618736, 6189.659568723763, 6173.938260617516, 6193.225846769154, 6200.689965501617, 6202.379762023942, 6205.968970155121, 6103.990995082673, 6232.906506402317, 6233.875322493615, 6257.655828929453, 6268.780592679234, 5174.508421699932, 5446.618736688394, 5999.040153575407, 6134.079888016833, 6144.78493252734, 6018.8194354169445, 6024.578279520391, 6127.830981140938, 6128.264608247039, 6140.508759299156, 5962.016267316018, 5967.492763115184, 5978.910316345346, 5985.221921150222, 5997.910031349446, 6035.879282414415, 6047.879042419039, 6086.513078953584, 6107.877842443215, 6119.602225855305, 5751.194832723339, 5807.245058142415, 5826.854328641818, 5856.502197313276, 5914.053751399928], "value": 5657.164327806192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.90146167843073, 491.3048037027604, 502.8717676992366, 506.38727140160404, 512.0143723332584, 30174.69825301749, 39642.0, 41719.582804171914, 41799.79100104503, 43656.3451548227, 42168.15663686724, 42614.0, 42675.14649707004, 42680.719578412696, 42911.0, 8375.246227839492, 9275.907240927572, 9470.195033422167, 9476.857847132298, 9477.194438472738, 8546.44448110874, 11155.27490713101, 11438.71403214922, 11452.828207576893, 11621.070314374872, 9598.80802383952, 11043.558257669683, 11348.262362946381, 11388.373639449826, 11420.428978551081, 11258.831117533202, 11329.773404531945, 11349.489272982735, 11353.772924541463, 11378.431078446127, 9521.761955951088, 11179.161562882817, 11250.774984500345, 11253.0, 11266.380349080797, 39962.0, 40192.39711404331, 40238.798806006074, 40335.0, 40404.393934091015, 3323.0, 3369.1913940654067, 3419.1623052352084, 3434.4848272759036, 3559.056849934769, 27668.031618893445, 27860.16419507418, 28583.571246431322, 28916.987905423208, 29293.0, 3170.619525656936, 3188.3145123798263, 3191.340502938482, 3193.5369371441243, 3266.6080070391467, 474661.0, 476243.0, 476722.0, 481099.5945020252, 482103.5894820539, 54669.72665136649, 55137.0, 55141.72429137909, 55167.0, 55288.44711552913, 56768.43231567714, 56994.0, 57019.71490142523, 57030.0, 57075.42924570701, 15001.474948376754, 15561.84438155604, 15593.610159745871, 15599.0, 15620.984635998624, 10761.246712730033, 11189.0, 11218.439078046065, 12138.27170369763, 12212.267263964191, 16969.321227151024, 17026.829731702524, 17341.913290433466, 17413.3034678614, 17611.0, 6532.346765323525, 7556.828691552818, 7652.354743730125, 7666.8083297918, 7669.884951725729, 733.5635296998278, 967.1923943507251, 985.2216748768536, 1004.8894621591619, 1024.5799222318963, 29274.414511710074, 29678.703212967594, 29692.406151877272, 30533.23666908345, 30561.847190763903, 1027.244974943416, 1040.6565833275001, 1060.5280650110626, 1074.1084899533369, 1116.3469370418234, 14968.401263949538, 15303.387864485296, 15503.922480387526, 15606.29771660278, 15692.450764223426, 667146.9351637467, 669422.6528867325, 670636.0, 670977.6451117811, 673021.0, 57140.42859571351, 57550.7122464385, 57552.71223643855, 57582.13626795601, 57697.711511442176, 1250.831137796404, 1300.9349532523524, 1361.9591412257648, 1394.7001394700187, 1419.0279658434006, 28660.713392866637, 30017.64744112048, 30162.84918575393, 30552.694473054984, 31173.53239701452, 48445.7888552789, 49051.75474122607, 49320.50679493159, 49324.75337623289, 49380.25929610987, 492596.0, 493664.53167733934, 497658.0, 497733.0, 498616.0, 24481.510369792148, 24802.875985619958, 25171.0, 25177.992880285317, 25491.617625735256, 40896.1820763589, 41026.58973410347, 41063.38404923988, 41150.176996459304, 41539.0, 30454.390912182076, 31378.843105784326, 34333.656663433045, 34835.825820870734, 35781.28437431289, 34116.0, 34449.13877153091, 34662.960111196706, 35008.474872877436, 35707.0, 33778.49332260067, 34532.30935381329, 34544.654553454144, 34634.307313854086, 34665.48001779925, 29705.81176752992, 30367.39265214639, 30554.541681875235, 30607.08178754641, 30616.0, 21314.573708525433, 23102.306930792103, 23359.649605255596, 23486.177983770485, 23634.054637814294], "value": 19432.142010338484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.4707891084462, 365.50656613571664, 368.6589904338486, 379.66399736233427, 395.07749405139, 14759.188244646553, 14942.92528537357, 15672.902896797215, 19314.034298285063, 20500.0, 19429.902850485727, 19935.700964485546, 20493.795062049412, 20776.272830450936, 20962.89518552409, 5765.308163020433, 5772.701142242982, 6023.277206735176, 6038.849028774272, 6102.969485152568, 5403.135498320269, 5898.026825573776, 5951.791687290945, 5957.731902064417, 5963.880722385549, 5629.183768353586, 5846.415358464141, 5893.263342082239, 5902.350741418462, 5907.4978626816555, 5874.706264686749, 6029.638221706711, 6031.547633927473, 6038.124471951543, 6046.8185954421215, 5593.272874526327, 5615.9157612635845, 5784.132380143013, 5803.332616749043, 5808.448197421239, 13107.0, 13318.200907945555, 13338.199708017453, 14714.264286785725, 23877.403064923343, 2196.363054714131, 2260.1750361118075, 2320.3734991552355, 2339.415146213447, 2368.911762512117, 9642.373245739074, 9787.265955053399, 9827.0, 10298.845517317246, 10319.43243121628, 1786.4640607817603, 1808.2947650416347, 1836.6877630802796, 1841.4015444980434, 1874.2502998800453, 113711.43144284308, 118376.0, 118547.58104217381, 120179.0, 120251.0, 10778.73053173677, 10934.4532773361, 11003.449827508593, 11290.0, 11404.885951140383, 14202.786958195635, 14211.36048877803, 14220.0, 14221.0, 14232.786508202178, 6698.7320507179165, 8111.95944020288, 8287.295579875778, 8412.621432035574, 8420.53687047206, 8123.675052997932, 8132.715354962666, 8177.0, 8335.208155225244, 8343.45767525109, 4370.235208838504, 4457.286834106528, 4491.124230774967, 4509.774511274489, 4566.725996440225, 1459.3432955170215, 1703.730720613151, 1824.8412258215862, 1861.7393564900924, 1931.719900614403, 851.9701810436605, 880.8458519759016, 899.6761165980242, 908.927285817133, 946.5551190940247, 19148.712769308473, 19892.0, 20557.074931628114, 20570.280040198522, 20596.27913023037, 911.6991392840347, 925.9768505787274, 927.5686805635412, 947.9619816301139, 992.7815880506278, 10317.380957142595, 10652.987966143204, 10725.51735171919, 10813.0, 10820.621278255223, 483935.0, 544895.0, 548059.0, 557636.0, 560213.0, 104019.47990260151, 134019.0, 136556.0, 137555.0, 139374.60625393616, 955.1499165742495, 986.8717066781417, 1014.9391036537831, 1017.2167431078176, 1017.8473229015707, 16403.58991025234, 17612.559686007953, 18082.638347233245, 18491.537711557317, 18980.620387592448, 50591.747041264556, 51184.976300474525, 51995.48004519907, 52589.7370513145, 52930.470695292555, 71712.0, 73999.04003840001, 75279.49441011039, 77384.61307693426, 78675.60662196652, 6309.526785491014, 7103.2541583133025, 7824.0, 8278.254957053654, 8309.335253179852, 12077.57728479499, 12552.309622970459, 12744.362781861055, 12835.550755723505, 12907.806382904451, 10772.030517253485, 11157.163212758913, 11298.265612735146, 11434.656960291204, 11555.711107222387, 10787.298825576312, 10926.50830712604, 11243.988041076342, 11307.265027773168, 11398.487068081791, 11123.72190695239, 11228.4385780709, 11617.48972633586, 11668.824967625662, 11737.471813768572, 7913.9604301978125, 8031.799205019921, 8093.716719914774, 8108.594570271581, 8171.264586187272, 9481.888583562328, 11044.779104418027, 11195.832062519232, 11231.38227397501, 11384.032357249727], "value": 9252.501393760303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.8438479574852, 1473.6684246044642, 1497.827749808772, 1703.9574010649733, 1888.848892088633, 7426.145993210783, 7804.219578042193, 8044.477108987911, 8384.077751447336, 8387.370947178955, 6914.757983470579, 8372.120927302636, 8373.49759014458, 8376.664933402672, 8378.287845533137, 2056.0953180600486, 2291.63333866581, 2339.228054741931, 2339.836211465198, 2340.1926335414255, 2139.454439118023, 2288.9885550572226, 2359.740428552858, 2362.7637236276405, 2373.074500944633, 2289.5306462175213, 2304.078368652544, 2318.6637937499054, 2322.489052408476, 2324.941876453085, 2298.321995011467, 2320.756320586331, 2321.117975169433, 2326.906923723049, 2329.7320808107115, 2277.6128058230142, 2293.70181876355, 2319.373769082355, 2325.1048346386765, 2325.197806756666, 8255.917440825635, 8329.416940814146, 8338.791530211733, 8340.457870238415, 8354.540500272482, 5043.62172837035, 5193.8961220775755, 5198.506141916512, 5199.506046925536, 5203.453637368059, 3329.433996220624, 3363.9159021024425, 3478.0696713324096, 3558.9644103558894, 3560.092176495003, 1045.796069766396, 1062.219268837404, 1072.9463526823627, 1081.6971248050559, 1090.7491277006254, 10206.387616742944, 10626.362418254852, 10628.734281642943, 10756.892431075745, 10790.73023174419, 4268.146370725867, 4304.397384366192, 4465.665075119314, 4476.6194873436125, 4482.282834746425, 8577.914220857712, 8587.785305367415, 8589.14108589136, 8592.097829727914, 8597.957010214908, 5031.245313202976, 5092.10888094582, 5097.108006098918, 5101.795928162906, 5112.105381558213, 4074.388841673713, 4440.0, 4795.136875362398, 4796.232602783538, 4798.688085274446, 3585.8565657373415, 3616.264193187232, 3701.759385639925, 3707.1658876753054, 3717.2937141942944, 1135.233717240859, 1158.7624536969902, 1169.0, 1173.4191575170346, 1173.9413029348498, 834.7020383303899, 853.9188777066169, 883.394874510962, 888.760034790603, 942.8161508505913, 4278.657707383401, 5297.841064768063, 5382.946170538323, 5572.0, 5598.188262701967, 798.9320907722793, 877.2893955895745, 891.6611687558686, 928.2991341537231, 995.1740055753708, 3688.7971161585833, 3695.5380577427823, 3699.297133544672, 3812.161324508659, 3830.597787232356, 9761.121499065119, 9995.000499950092, 10063.698089057194, 10079.244056695778, 10083.949580252052, 10056.849147262797, 10086.596536138471, 10110.39337639744, 10130.138938190335, 10171.593136274467, 6470.805875823733, 7369.18938916708, 7853.725119620786, 7860.449768516149, 7914.881276780853, 5267.841964740911, 5509.173623956439, 5535.3634332050715, 5559.444055594408, 5590.888182236414, 8125.187481251827, 8646.178613031752, 8674.826503470022, 8777.122287771172, 8837.116288371111, 8885.511296878734, 8956.417832840845, 8957.820843583222, 8993.14565116313, 9002.414843035443, 7089.255628158969, 7122.394596459152, 7175.533590316612, 7277.235890231449, 7321.487495875238, 7802.765917022499, 7870.527768333918, 7870.9606451967375, 7878.172791857001, 7895.01312335958, 5791.276090488689, 7083.964580177066, 7127.322904324288, 7182.533135346186, 7302.561846289027, 6989.895151572832, 7022.719091236293, 7045.084139061889, 7095.184053833876, 7133.0, 6367.0, 6600.504962127764, 6672.499562532927, 6749.898751518829, 6767.289434609295, 4779.713217206979, 4795.472498025145, 4806.759662016955, 4862.465128835896, 4942.382202224722, 4490.483594386556, 4577.610903073143, 4770.189067858403, 4874.5856602189215, 4941.901161976813], "value": 4338.296545358398, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.86394306220575, 352.8835484290183, 359.59904706252536, 369.21541723836845, 370.29274086494786, 4860.222364421693, 5255.0, 5256.710880901549, 5304.522592966632, 5379.112446446336, 4633.733218081253, 4919.687746759027, 5106.676462209695, 5114.769835357409, 5152.814852583908, 3757.567879693829, 3869.303525365433, 4101.5488296287385, 4137.551856850108, 4148.216267005187, 3598.3882739934143, 4069.308217603, 4083.1017176221185, 4086.570910054446, 4120.402541631476, 3631.019624701329, 3934.310366829275, 4001.25976694311, 4044.9191016179657, 4071.531773846016, 3681.5582130144285, 3968.0278331808604, 4031.778252196128, 4040.696947728932, 4079.77561234132, 3063.2188791858157, 3114.2370119320685, 3568.661751843059, 3577.5528058992627, 3602.945955810665, 4899.902001959977, 4923.359963204761, 5025.924611130836, 5037.748112594356, 5074.3657042869645, 4484.170428470711, 4675.859724208279, 4688.484266730657, 4691.272852707836, 4709.788059537294, 5012.774425150877, 5295.576353891718, 5432.91850622241, 5450.601735236483, 5462.6449280797015, 3470.9934119105683, 3762.49206357141, 3881.7384350086336, 4024.2555127301544, 4034.9105741449644, 4455.353973673831, 5484.588655850827, 5678.063119585305, 5721.856953576153, 5761.444410009274, 3280.5571247881708, 3606.5672119345845, 3608.801515916597, 4014.6386825185873, 4051.7974101294817, 3730.142067324476, 3744.6706419221327, 3902.083010492532, 3965.7507885016125, 4151.398047283127, 4144.606262405066, 4401.801918913657, 4629.398178236807, 4714.292856071616, 4772.976135119372, 4887.242477416006, 5385.057614917374, 5500.80747173847, 5506.64206826555, 5562.721863906789, 1106.2422240765102, 1118.5022664914036, 1245.339969815999, 1253.2042153232762, 1265.1270623270098, 779.2635959018673, 794.7059587952378, 801.6152246921511, 809.926846927823, 810.7446154461326, 4245.61789438952, 4294.914101717948, 4365.995820961197, 4839.516048395132, 4840.588549973291, 4790.257510085942, 5036.79852805891, 5042.747862606929, 5379.821172425174, 5395.381385584309, 4425.712328698624, 4508.233600287959, 4737.8104875805275, 4764.666473346832, 4865.9026819463415, 2267.4354695260217, 2407.4462873538832, 2626.632271481994, 2802.985985070062, 2810.437912417525, 4991.007194244662, 5262.052830490548, 5277.997180535686, 5441.020616289027, 5497.642653227527, 4651.3720647712125, 4696.285855662659, 4740.525947405232, 5435.782568697208, 5790.855228619234, 5404.459554044722, 5827.679477628772, 5852.297724273115, 5857.238558987305, 5898.557608179318, 5110.437851836221, 5304.0, 5562.499375056264, 5631.746571404378, 5684.346300175533, 4558.407407037064, 4948.975255123702, 5288.4182739897815, 5584.46947539983, 5586.692731899784, 5107.770150343169, 5690.715464226855, 5802.926458605171, 5865.627264323117, 5908.990943079201, 3431.519587257736, 3438.914027149341, 3502.2470168913806, 3770.905727356728, 3805.752626079296, 4679.649026322972, 4774.045190961752, 5356.000639641813, 5761.024892823938, 5761.415610707089, 5001.673218022794, 5438.673679579238, 5590.413006634408, 5618.606697531133, 5645.645045189043, 4650.767716437179, 5315.548178404879, 5404.675989324628, 5447.727613619224, 5489.670619762827, 4298.76356800379, 4781.039773692769, 4976.377952755905, 5398.433164517669, 5426.538744206787, 4215.768132752728, 4542.454905411372, 4563.794629241625, 5416.431274716098, 5488.4237155098135, 4592.471865735483, 5355.089634762022, 5374.704391258519, 5389.973050134724, 5394.190871369169], "value": 3958.877364000051, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.9455549000589, 645.515863102673, 713.3615414204287, 739.8298391369981, 789.218673513222, 14438.639034024141, 15189.4683686071, 15502.379904803794, 15551.533453996384, 15567.610809729762, 13582.993017059965, 13888.444462221525, 13922.512712055055, 13938.651533711662, 13940.51208207713, 847.6905929335779, 884.1335491218609, 898.6630013744846, 900.9549522523847, 903.3541018172006, 899.2850683706437, 899.6626265150569, 900.0954041188596, 901.1979338388807, 904.6110172625769, 940.7977284883749, 943.0239701908527, 943.085207348874, 943.9805010588548, 944.6976967370445, 944.0936700767272, 945.3760518058049, 950.6577632052456, 950.7242899559085, 951.0679534056663, 696.8780463418882, 697.9825504362432, 700.1108592088019, 700.7302188657353, 701.2461603775911, 14193.148411095368, 14529.529979903442, 14895.851041489555, 15101.395944162221, 15101.848981510264, 12415.379231038412, 13788.379522921392, 13819.378127984264, 14029.579112626638, 14389.136651800925, 11637.301761894229, 11691.649250522498, 11707.882921170765, 11803.822942655781, 11824.408779560987, 3683.613220611851, 3699.8705045323286, 3745.325841348556, 3852.383618621035, 3863.8068096595057, 109500.35749463765, 112002.0, 112530.0, 113807.0, 113913.43043284814, 10777.0, 10793.78412431747, 10911.0, 10921.726956825984, 10962.068224201032, 22129.004194811274, 22147.892605369667, 22156.446088847908, 22186.55626887453, 22191.556168876534, 7332.8900066499045, 7627.161012288644, 7828.765137045898, 7864.449488535862, 7972.043354797462, 4448.7330760153845, 4465.441819772528, 4467.285234362552, 4579.4046773919845, 4631.0, 2922.8100173488656, 3209.422303985305, 3524.806135662563, 3554.289142171576, 3590.551181102362, 548.4707257496456, 633.7465013994439, 636.2555809702567, 643.7199818079057, 658.6410406328563, 435.6408007018124, 492.9507049295042, 520.2014907117556, 548.2899644959707, 587.6620942957817, 8104.388755372563, 8231.46495477792, 8314.833703326021, 8470.49417878384, 8570.914290857136, 524.1875093604973, 543.0474076423047, 554.7630369313666, 562.9408912064256, 581.8050952930731, 4004.699647526389, 4058.5941405859176, 4068.349064149722, 4079.796010199478, 4259.467566554181, 101219.0, 101694.0, 101772.0, 103748.48125759474, 106239.0, 53020.0, 62804.0, 72814.27185728181, 78366.21633783703, 98265.50867245618, 66508.33491665215, 80111.19888801154, 80957.59521202356, 81113.0, 82988.58505707554, 8827.867581986147, 9212.03916161889, 9224.631014759603, 9318.440893546409, 9342.159205671522, 49196.01607967749, 50145.49854501408, 50479.49520504748, 50557.74721126371, 55054.44945550653, 68877.0, 72291.0, 73503.0, 74309.0, 77663.61168194123, 11171.871875874767, 11546.653600392001, 11683.349585083006, 11725.0, 12007.459664314953, 13128.409221584861, 13400.396982135633, 13428.597142085362, 13596.456141754219, 13597.252151131783, 12206.816897746363, 12247.448864801283, 12321.137520373488, 12351.135420520837, 12815.231086134861, 11729.655942049025, 11881.584144555245, 12000.759984800081, 12220.87779122233, 12303.261804291771, 11946.820797687868, 11949.283043017447, 11952.820707689218, 11963.222390544586, 11997.220180688228, 10064.446455444728, 10079.652281404971, 10259.897401025893, 10311.0, 10331.276810623183, 10143.0, 10145.833229178445, 10570.735731606772, 10581.206409519164, 10653.0], "value": 7211.319978718254, "unit": "score"}], "name": "dromaeo_css", "value": 7080.361868452216, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 108.0, 146.0, 110.0, 109.0, 109.0, 108.0, 127.0, 117.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 182.0, 185.0, 185.0, 186.0, 180.0, 183.0, 183.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 63.0, 77.0, 113.0, 85.0, 59.0, 58.0, 60.0, 73.0, 70.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 85.0, 68.0, 69.0, 68.0, 82.0, 68.0, 70.0, 84.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 110.0, 112.0, 110.0, 112.0, 108.0, 112.0, 109.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 96.0, 95.0, 109.0, 150.0, 149.0, 95.0, 95.0, 94.0], "value": 107.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 131.0, 141.0, 88.0, 86.0, 86.0, 87.0, 87.0, 85.0, 85.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 56.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 66.0, 71.0, 77.0, 73.0, 71.0, 71.0, 71.0, 72.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 87.0, 90.0, 86.0, 86.0, 84.0, 86.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 136.0, 137.0, 143.0, 126.0, 146.0, 141.0, 209.0, 152.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 172.0, 172.0, 169.0, 230.0, 218.0, 170.0, 167.0, 172.0], "value": 181.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1486.5, "alertThreshold": 2.0}]} 10:11:43 INFO - Return code: 0 10:11:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:43 INFO - # TBPL SUCCESS # 10:11:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:43 INFO - 2016-12-16 10:11:43.811 screenresolution[1653:9691] starting screenresolution argv=screenresolution get 10:11:43 INFO - 2016-12-16 10:11:43.814 screenresolution[1653:9691] Display 0: 1600x1200x32@60 10:11:43 INFO - 2016-12-16 10:11:43.820 screenresolution[1654:9694] starting screenresolution argv=screenresolution list 10:11:43 INFO - Available Modes on Display 0 10:11:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:44 INFO - Intel Iris: 10:11:44 INFO - Chipset Model: Intel Iris 10:11:44 INFO - Type: GPU 10:11:44 INFO - Bus: Built-In 10:11:44 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:44 INFO - Vendor: Intel (0x8086) 10:11:44 INFO - Device ID: 0x0a2e 10:11:44 INFO - Revision ID: 0x0009 10:11:44 INFO - Displays: 10:11:44 INFO - Display: 10:11:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:44 INFO - Display Serial Number: 1600x1200 60 10:11:44 INFO - Main Display: Yes 10:11:44 INFO - Mirror: Off 10:11:44 INFO - Online: Yes 10:11:44 INFO - Rotation: Supported 10:11:44 INFO - Return code: 0 10:11:44 INFO - Running post-action listener: _resource_record_post_action 10:11:44 INFO - [mozharness: 2016-12-16 18:11:44.054603Z] Finished run-tests step (success) 10:11:44 INFO - Running post-run listener: _resource_record_post_run 10:11:44 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37655552; Write bytes: 552653312; Read time: 239; Write time: 1674 10:11:44 INFO - TinderboxPrint: CPU usage
53.9% 10:11:44 INFO - TinderboxPrint: I/O read bytes / time
37,655,552 / 239 10:11:44 INFO - TinderboxPrint: I/O write bytes / time
552,653,312 / 1,674 10:11:44 INFO - TinderboxPrint: CPU idle
2,216.6 (46.1%) 10:11:44 INFO - TinderboxPrint: CPU system
968.9 (20.1%) 10:11:44 INFO - TinderboxPrint: CPU user
1,624.2 (33.8%) 10:11:44 INFO - TinderboxPrint: Swap in / out
287,375,360 / 0 10:11:44 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247927296; Write bytes: 242845696; Read time: 17998; Write time: 520 10:11:44 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34358272; Write bytes: 298191360; Read time: 214; Write time: 1120 10:11:44 INFO - Running post-run listener: _upload_blobber_files 10:11:44 INFO - Blob upload gear active. 10:11:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:44 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 10:11:44 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:11:44 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:11:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:46 INFO - (blobuploader) - INFO - Done attempting. 10:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:47 INFO - (blobuploader) - INFO - Done attempting. 10:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:49 INFO - (blobuploader) - INFO - Done attempting. 10:11:49 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:49 INFO - Return code: 0 10:11:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7e5aeb4151b380d9ba1163fbc5a80782307d5fe71889bfa9c73461423ef8ebd9b83ee93e40b4e142ed85e10cc4b5f62e107d224e779e703a14fe784e594500f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4f6d47c4488f4267b6f235cbcf7b55bf5eb3d243875758272512c0c7f5daaa1e9d1cd89a2880e979ac2921116bbbc753f397143cab815ef663de452c595cd146", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1c76bc7f05f2959f97f52760afcfd42472a2643c2acccda6010b8c8d821ab1383f83cbc9ef607b40071b299e507abf904f82794990690768c7f465254093f34e"} 10:11:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:49 INFO - Contents: 10:11:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7e5aeb4151b380d9ba1163fbc5a80782307d5fe71889bfa9c73461423ef8ebd9b83ee93e40b4e142ed85e10cc4b5f62e107d224e779e703a14fe784e594500f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4f6d47c4488f4267b6f235cbcf7b55bf5eb3d243875758272512c0c7f5daaa1e9d1cd89a2880e979ac2921116bbbc753f397143cab815ef663de452c595cd146", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1c76bc7f05f2959f97f52760afcfd42472a2643c2acccda6010b8c8d821ab1383f83cbc9ef607b40071b299e507abf904f82794990690768c7f465254093f34e"} 10:11:49 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:49 INFO - Copying logs to upload dir... 10:11:49 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.648557 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-16 10:11:49.700358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 10:11:49.705274) ========= 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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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/Graphics/sha512/7e5aeb4151b380d9ba1163fbc5a80782307d5fe71889bfa9c73461423ef8ebd9b83ee93e40b4e142ed85e10cc4b5f62e107d224e779e703a14fe784e594500f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4f6d47c4488f4267b6f235cbcf7b55bf5eb3d243875758272512c0c7f5daaa1e9d1cd89a2880e979ac2921116bbbc753f397143cab815ef663de452c595cd146", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1c76bc7f05f2959f97f52760afcfd42472a2643c2acccda6010b8c8d821ab1383f83cbc9ef607b40071b299e507abf904f82794990690768c7f465254093f34e"} build_url:https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/ex-SHF2dTHiuK1upVXPP-w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7e5aeb4151b380d9ba1163fbc5a80782307d5fe71889bfa9c73461423ef8ebd9b83ee93e40b4e142ed85e10cc4b5f62e107d224e779e703a14fe784e594500f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4f6d47c4488f4267b6f235cbcf7b55bf5eb3d243875758272512c0c7f5daaa1e9d1cd89a2880e979ac2921116bbbc753f397143cab815ef663de452c595cd146", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1c76bc7f05f2959f97f52760afcfd42472a2643c2acccda6010b8c8d821ab1383f83cbc9ef607b40071b299e507abf904f82794990690768c7f465254093f34e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 10:11:49.742194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 10:11:49.742545) ========= 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.hFBf9N0qzs/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.Uy7Jf2Eqvq/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.005149 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 10:11:49.792006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 10:11:49.792321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 10:11:49.792635) ========= ========= Total master_lag: 1.19 =========