builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0222 starttime: 1484641500.13 results: success (0) buildid: 20170116235132 builduid: ce431d2625734ed19ed098e5a2e67d4d revision: 87aa6ecc99aa5cb7c7f8c1f38d610093b8a2845c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:00.131687) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:00.132114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:00.132403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:00.249910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:00.250166) ========= 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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-17 00:25:00-- 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% 7.93M=0.001s 2017-01-17 00:25:00 (7.93 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:00.407825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:00.408245) ========= 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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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.022928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:00.459903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-17 00:25:00.460248) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 87aa6ecc99aa5cb7c7f8c1f38d610093b8a2845c --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 87aa6ecc99aa5cb7c7f8c1f38d610093b8a2845c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-17 00:25:00,543 truncating revision to first 12 chars 2017-01-17 00:25:00,543 Setting DEBUG logging. 2017-01-17 00:25:00,543 attempt 1/10 2017-01-17 00:25:00,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/87aa6ecc99aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 00:25:02,424 unpacking tar archive at: graphics-87aa6ecc99aa/testing/mozharness/ program finished with exit code 0 elapsedTime=2.143099 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-17 00:25:02.627209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:02.627534) ========= script_repo_revision: 87aa6ecc99aa5cb7c7f8c1f38d610093b8a2845c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:02.627917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:02.628186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 00:25:02.647856) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-17 00:25:02.648288) ========= /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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:02 INFO - MultiFileLogger online at 20170117 00:25:02 in /builds/slave/test 00:25:02 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 00:25:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:25:02 INFO - {'append_to_log': False, 00:25:02 INFO - 'base_work_dir': '/builds/slave/test', 00:25:02 INFO - 'blob_upload_branch': 'Graphics', 00:25:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:25:02 INFO - 'branch': 'Graphics', 00:25:02 INFO - 'buildbot_json_path': 'buildprops.json', 00:25:02 INFO - 'config_files': ('talos/mac_config.py',), 00:25:02 INFO - 'default_actions': ('clobber', 00:25:02 INFO - 'read-buildbot-config', 00:25:02 INFO - 'download-and-extract', 00:25:02 INFO - 'populate-webroot', 00:25:02 INFO - 'create-virtualenv', 00:25:02 INFO - 'install', 00:25:02 INFO - 'run-tests'), 00:25:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:25:02 INFO - 'download_minidump_stackwalk': True, 00:25:02 INFO - 'download_symbols': 'ondemand', 00:25:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:25:02 INFO - 'tooltool.py': '/tools/tooltool.py', 00:25:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:25:02 INFO - '/tools/misc-python/virtualenv.py')}, 00:25:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:25:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:25:02 INFO - 'installer_path': 'installer.exe', 00:25:02 INFO - 'log_level': 'info', 00:25:02 INFO - 'log_name': 'talos', 00:25:02 INFO - 'log_to_console': True, 00:25:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:25:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:25:02 INFO - 'opt_config_files': (), 00:25:02 INFO - 'pip_index': False, 00:25:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:25:02 INFO - 'cmd': ('bash', 00:25:02 INFO - '-c', 00:25:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:25:02 INFO - 'enabled': True, 00:25:02 INFO - 'halt_on_failure': False, 00:25:02 INFO - 'name': 'check_screen_resolution'},), 00:25:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:25:02 INFO - 'cmd': ('bash', 00:25:02 INFO - '-c', 00:25:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:25:02 INFO - 'enabled': True, 00:25:02 INFO - 'halt_on_failure': False, 00:25:02 INFO - 'name': 'check_screen_resolution'},), 00:25:02 INFO - 'run_cmd_checks_enabled': True, 00:25:02 INFO - 'sps_profile': False, 00:25:02 INFO - 'sps_profile_interval': 0, 00:25:02 INFO - 'suite': 'dromaeojs', 00:25:02 INFO - 'system_bits': '32', 00:25:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:25:02 INFO - 'title': 't-yosemite-r7-0222', 00:25:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:25:02 INFO - 'use_talos_json': True, 00:25:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:25:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:25:02 INFO - 'work_dir': 'build'} 00:25:02 INFO - [mozharness: 2017-01-17 08:25:02.847047Z] Running clobber step. 00:25:02 INFO - Running pre-action listener: _resource_record_pre_action 00:25:02 INFO - Running main action method: clobber 00:25:02 INFO - rmtree: /builds/slave/test/build 00:25:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:25:04 INFO - Running post-action listener: _resource_record_post_action 00:25:04 INFO - [mozharness: 2017-01-17 08:25:04.439954Z] Finished clobber step (success) 00:25:04 INFO - [mozharness: 2017-01-17 08:25:04.440446Z] Running read-buildbot-config step. 00:25:04 INFO - Running pre-action listener: _resource_record_pre_action 00:25:04 INFO - Running main action method: read_buildbot_config 00:25:04 INFO - Using buildbot properties: 00:25:04 INFO - { 00:25:04 INFO - "project": "", 00:25:04 INFO - "product": "firefox", 00:25:04 INFO - "script_repo_revision": "default", 00:25:04 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 00:25:04 INFO - "repository": "", 00:25:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 00:25:04 INFO - "buildid": "20170116235132", 00:25:04 INFO - "pgo_build": "False", 00:25:04 INFO - "basedir": "/builds/slave/test", 00:25:04 INFO - "buildnumber": 8, 00:25:04 INFO - "slavename": "t-yosemite-r7-0222", 00:25:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 00:25:04 INFO - "platform": "yosemite_r7", 00:25:04 INFO - "scheduler": "tests-graphics-macosx64-talos", 00:25:04 INFO - "branch": "graphics", 00:25:04 INFO - "repo_path": "projects/graphics", 00:25:04 INFO - "revision": "87aa6ecc99aa5cb7c7f8c1f38d610093b8a2845c", 00:25:04 INFO - "stage_platform": "macosx64", 00:25:04 INFO - "builduid": "ce431d2625734ed19ed098e5a2e67d4d", 00:25:04 INFO - "slavebuilddir": "test" 00:25:04 INFO - } 00:25:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 00:25:04 INFO - Running post-action listener: _resource_record_post_action 00:25:04 INFO - [mozharness: 2017-01-17 08:25:04.446729Z] Finished read-buildbot-config step (success) 00:25:04 INFO - [mozharness: 2017-01-17 08:25:04.446815Z] Running download-and-extract step. 00:25:04 INFO - Running pre-action listener: _resource_record_pre_action 00:25:04 INFO - Running main action method: download_and_extract 00:25:04 INFO - mkdir: /builds/slave/test/build/tests 00:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:04 INFO - trying https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 00:25:04 INFO - Downloading https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/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 00:25:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/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 00:25:05 INFO - Downloaded 1199 bytes. 00:25:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 00:25:05 INFO - Using the following test package requirements: 00:25:05 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 00:25:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:25:05 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 00:25:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:25:05 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 00:25:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:25:05 INFO - u'jsshell-mac.zip'], 00:25:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:25:05 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 00:25:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 00:25:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:25:05 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 00:25:05 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:25:05 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 00:25:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:25:05 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 00:25:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:25:05 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 00:25:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:25:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 00:25:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:25:05 INFO - Fetch https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 00:25:06 INFO - Expected file size: 16324235 00:25:06 INFO - Obtained file size: 16324235 00:25:13 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 00:25:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 00:25:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:25:13 INFO - Fetch https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 00:25:14 INFO - Expected file size: 16324235 00:25:14 INFO - Obtained file size: 16324235 00:25:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 00:25:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:25:20 INFO - Fetch https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 00:25:22 INFO - Expected file size: 14403463 00:25:22 INFO - Obtained file size: 14403463 00:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:23 INFO - trying https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:25:23 INFO - Downloading https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 00:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/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 00:25:24 INFO - Downloaded 70228719 bytes. 00:25:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:25:24 INFO - mkdir: /builds/slave/test/properties 00:25:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:25:25 INFO - Writing to file /builds/slave/test/properties/build_url 00:25:25 INFO - Contents: 00:25:25 INFO - build_url:https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:25:25 INFO - Running post-action listener: _resource_record_post_action 00:25:25 INFO - Running post-action listener: set_extra_try_arguments 00:25:25 INFO - [mozharness: 2017-01-17 08:25:25.672813Z] Finished download-and-extract step (success) 00:25:25 INFO - [mozharness: 2017-01-17 08:25:25.672939Z] Running populate-webroot step. 00:25:25 INFO - Running pre-action listener: _resource_record_pre_action 00:25:25 INFO - Running main action method: populate_webroot 00:25:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:25:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:25:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:25:25 INFO - '--tppagecycles', 00:25:25 INFO - '7'], 00:25:25 INFO - 'tests': ['tsvgm']}}, 00:25:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:25:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:25:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:25:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:25:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:25:25 INFO - 'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:25:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:25:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:25:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:25:25 INFO - 'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['damp', 'tps']}, 00:25:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:25:25 INFO - 'tests': ['damp', 'tps']}, 00:25:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['dromaeo_dom']}, 00:25:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:25:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['basic_compositor_video']}, 00:25:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:25:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['a11yr', 00:25:25 INFO - 'ts_paint', 00:25:25 INFO - 'tpaint', 00:25:25 INFO - 'sessionrestore', 00:25:25 INFO - 'sessionrestore_no_auto_restore', 00:25:25 INFO - 'tabpaint']}, 00:25:25 INFO - 'other-e10s': {'tests': ['a11yr', 00:25:25 INFO - 'ts_paint', 00:25:25 INFO - 'tpaint', 00:25:25 INFO - 'sessionrestore', 00:25:25 INFO - 'sessionrestore_no_auto_restore', 00:25:25 INFO - 'tabpaint']}, 00:25:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:25:25 INFO - 'ts_paint', 00:25:25 INFO - 'tpaint', 00:25:25 INFO - 'sessionrestore', 00:25:25 INFO - 'sessionrestore_no_auto_restore', 00:25:25 INFO - 'tabpaint']}, 00:25:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:25:25 INFO - 'ts_paint', 00:25:25 INFO - 'tpaint', 00:25:25 INFO - 'sessionrestore', 00:25:25 INFO - 'sessionrestore_no_auto_restore', 00:25:25 INFO - 'tabpaint']}, 00:25:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['a11yr', 00:25:25 INFO - 'ts_paint', 00:25:25 INFO - 'tpaint', 00:25:25 INFO - 'sessionrestore', 00:25:25 INFO - 'sessionrestore_no_auto_restore', 00:25:25 INFO - 'tabpaint']}, 00:25:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['a11yr', 00:25:25 INFO - 'ts_paint', 00:25:25 INFO - 'tpaint', 00:25:25 INFO - 'sessionrestore', 00:25:25 INFO - 'sessionrestore_no_auto_restore', 00:25:25 INFO - 'tabpaint']}, 00:25:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['tsvgx', 00:25:25 INFO - 'tsvgr_opacity', 00:25:25 INFO - 'tart', 00:25:25 INFO - 'tscrollx', 00:25:25 INFO - 'cart', 00:25:25 INFO - 'tsvg_static']}, 00:25:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:25:25 INFO - 'tsvgr_opacity', 00:25:25 INFO - 'tart', 00:25:25 INFO - 'tscrollx', 00:25:25 INFO - 'cart', 00:25:25 INFO - 'tsvg_static']}, 00:25:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:25:25 INFO - 'talos_options': ['--disable-e10s'], 00:25:25 INFO - 'tests': ['tp5o']}, 00:25:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:25:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:25:25 INFO - 'talos_options': ['--disable-e10s', 00:25:25 INFO - '--xperf_path', 00:25:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:25:25 INFO - 'tests': ['tp5n']}, 00:25:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:25:25 INFO - 'talos_options': ['--xperf_path', 00:25:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:25:25 INFO - 'tests': ['tp5n']}}, 00:25:25 INFO - 'talos.zip': {'path': '', 00:25:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:25:25 INFO - Running post-action listener: _resource_record_post_action 00:25:25 INFO - [mozharness: 2017-01-17 08:25:25.691336Z] Finished populate-webroot step (success) 00:25:25 INFO - [mozharness: 2017-01-17 08:25:25.691451Z] Running create-virtualenv step. 00:25:25 INFO - Running pre-action listener: _resource_record_pre_action 00:25:25 INFO - Running main action method: create_virtualenv 00:25:25 INFO - Creating virtualenv /builds/slave/test/build/venv 00:25:25 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 00:25:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:25:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:25:25 INFO - Using real prefix '/tools/python27' 00:25:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:25:26 INFO - Installing distribute.............................................................................................................................................................................................done. 00:25:29 INFO - Installing pip.................done. 00:25:29 INFO - Return code: 0 00:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:25:29 INFO - Reading from file tmpfile_stdout 00:25:29 INFO - Output received: 00:25:29 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) 00:25:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:25: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')]} 00:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25: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')]} 00:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:25:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:30 INFO - 'HOME': '/Users/cltbld', 00:25:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:30 INFO - 'LOGNAME': 'cltbld', 00:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:30 INFO - 'MOZ_NO_REMOTE': '1', 00:25:30 INFO - 'NO_EM_RESTART': '1', 00:25:30 INFO - 'PAGER': '/bin/cat', 00:25:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:30 INFO - 'PWD': '/builds/slave/test', 00:25:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:30 INFO - 'SHELL': '/bin/bash', 00:25:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:30 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:30 INFO - 'USER': 'cltbld', 00:25:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:30 INFO - 'XPC_FLAGS': '0x0', 00:25:30 INFO - 'XPC_SERVICE_NAME': '0', 00:25:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:30 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 00:25:30 INFO - Cleaning up... 00:25:30 INFO - Return code: 0 00:25:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:31 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 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:31 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 00:25:31 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 00:25:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:31 INFO - 'HOME': '/Users/cltbld', 00:25:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:31 INFO - 'LOGNAME': 'cltbld', 00:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:31 INFO - 'MOZ_NO_REMOTE': '1', 00:25:31 INFO - 'NO_EM_RESTART': '1', 00:25:31 INFO - 'PAGER': '/bin/cat', 00:25:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:31 INFO - 'PWD': '/builds/slave/test', 00:25:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:31 INFO - 'SHELL': '/bin/bash', 00:25:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:31 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:31 INFO - 'USER': 'cltbld', 00:25:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:31 INFO - 'XPC_FLAGS': '0x0', 00:25:31 INFO - 'XPC_SERVICE_NAME': '0', 00:25:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:31 INFO - Downloading/unpacking psutil>=3.1.1 00:25:31 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 00:25:31 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 00:25:31 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 00:25:31 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 00:25:31 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 00:25:31 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 00:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:25:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:25:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:25:35 INFO - Installing collected packages: psutil 00:25:35 INFO - Running setup.py install for psutil 00:25:35 INFO - building 'psutil._psutil_osx' extension 00:25:35 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 00:25:36 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 00:25:36 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 00:25:36 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 00:25:36 INFO - building 'psutil._psutil_posix' extension 00:25:36 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 00:25:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:25:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:25:36 INFO - ^ 00:25:36 INFO - 1 warning generated. 00:25:36 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 00:25:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:25:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:25:36 INFO - Successfully installed psutil 00:25:36 INFO - Cleaning up... 00:25:36 INFO - Return code: 0 00:25:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:25:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:36 INFO - 'HOME': '/Users/cltbld', 00:25:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:36 INFO - 'LOGNAME': 'cltbld', 00:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:36 INFO - 'MOZ_NO_REMOTE': '1', 00:25:36 INFO - 'NO_EM_RESTART': '1', 00:25:36 INFO - 'PAGER': '/bin/cat', 00:25:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:36 INFO - 'PWD': '/builds/slave/test', 00:25:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:36 INFO - 'SHELL': '/bin/bash', 00:25:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:36 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:36 INFO - 'USER': 'cltbld', 00:25:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:36 INFO - 'XPC_FLAGS': '0x0', 00:25:36 INFO - 'XPC_SERVICE_NAME': '0', 00:25:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:25:39 INFO - Installing collected packages: mozsystemmonitor 00:25:39 INFO - Running setup.py install for mozsystemmonitor 00:25:39 INFO - Successfully installed mozsystemmonitor 00:25:39 INFO - Cleaning up... 00:25:39 INFO - Return code: 0 00:25:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:25:39 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')]} 00:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:39 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')]} 00:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:39 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 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:39 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 00:25:39 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 00:25:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:39 INFO - 'HOME': '/Users/cltbld', 00:25:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:39 INFO - 'LOGNAME': 'cltbld', 00:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:39 INFO - 'MOZ_NO_REMOTE': '1', 00:25:39 INFO - 'NO_EM_RESTART': '1', 00:25:39 INFO - 'PAGER': '/bin/cat', 00:25:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:39 INFO - 'PWD': '/builds/slave/test', 00:25:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:39 INFO - 'SHELL': '/bin/bash', 00:25:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:39 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:39 INFO - 'USER': 'cltbld', 00:25:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:39 INFO - 'XPC_FLAGS': '0x0', 00:25:39 INFO - 'XPC_SERVICE_NAME': '0', 00:25:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:40 INFO - Downloading/unpacking jsonschema==2.5.1 00:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:25:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:25:42 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 00:25:42 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 00:25:42 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 00:25:42 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 00:25:42 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 00:25:42 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 00:25:43 INFO - Downloading functools32-3.2.3-2.tar.gz 00:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:25:43 INFO - warning: no files found matching '*.txt' 00:25:43 INFO - no previously-included directories found matching 'build' 00:25:43 INFO - no previously-included directories found matching 'dist' 00:25:43 INFO - no previously-included directories found matching '.git*' 00:25:43 INFO - Installing collected packages: jsonschema, functools32 00:25:43 INFO - Running setup.py install for functools32 00:25:43 INFO - warning: no files found matching '*.txt' 00:25:43 INFO - no previously-included directories found matching 'build' 00:25:43 INFO - no previously-included directories found matching 'dist' 00:25:43 INFO - no previously-included directories found matching '.git*' 00:25:43 INFO - Successfully installed jsonschema functools32 00:25:43 INFO - Cleaning up... 00:25:43 INFO - Return code: 0 00:25:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:25:43 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')]} 00:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:43 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')]} 00:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:43 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 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:43 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 00:25:43 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 00:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:43 INFO - 'HOME': '/Users/cltbld', 00:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:43 INFO - 'LOGNAME': 'cltbld', 00:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:43 INFO - 'MOZ_NO_REMOTE': '1', 00:25:43 INFO - 'NO_EM_RESTART': '1', 00:25:43 INFO - 'PAGER': '/bin/cat', 00:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:43 INFO - 'PWD': '/builds/slave/test', 00:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:43 INFO - 'SHELL': '/bin/bash', 00:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:43 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:43 INFO - 'USER': 'cltbld', 00:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:43 INFO - 'XPC_FLAGS': '0x0', 00:25:43 INFO - 'XPC_SERVICE_NAME': '0', 00:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:25:43 INFO - Cleaning up... 00:25:43 INFO - Return code: 0 00:25:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:25:43 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')]} 00:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:43 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')]} 00:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:43 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 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:43 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 00:25:43 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 00:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:43 INFO - 'HOME': '/Users/cltbld', 00:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:43 INFO - 'LOGNAME': 'cltbld', 00:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:43 INFO - 'MOZ_NO_REMOTE': '1', 00:25:43 INFO - 'NO_EM_RESTART': '1', 00:25:43 INFO - 'PAGER': '/bin/cat', 00:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:43 INFO - 'PWD': '/builds/slave/test', 00:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:43 INFO - 'SHELL': '/bin/bash', 00:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:43 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:43 INFO - 'USER': 'cltbld', 00:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:43 INFO - 'XPC_FLAGS': '0x0', 00:25:43 INFO - 'XPC_SERVICE_NAME': '0', 00:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:43 INFO - Downloading/unpacking blobuploader==1.2.4 00:25:43 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 00:25:43 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 00:25:43 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 00:25:43 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 00:25:43 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 00:25:43 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 00:25:46 INFO - Downloading blobuploader-1.2.4.tar.gz 00:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:25:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:25:46 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 00:25:46 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 00:25:46 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 00:25:46 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 00:25:46 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 00:25:46 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 00:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:25:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:47 INFO - Downloading docopt-0.6.1.tar.gz 00:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:25:47 INFO - Installing collected packages: blobuploader, requests, docopt 00:25:47 INFO - Running setup.py install for blobuploader 00:25:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:25:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:25:48 INFO - Running setup.py install for requests 00:25:48 INFO - Running setup.py install for docopt 00:25:48 INFO - Successfully installed blobuploader requests docopt 00:25:48 INFO - Cleaning up... 00:25:48 INFO - Return code: 0 00:25:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:48 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 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:48 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 00:25:48 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 00:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:48 INFO - 'HOME': '/Users/cltbld', 00:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:48 INFO - 'LOGNAME': 'cltbld', 00:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:48 INFO - 'MOZ_NO_REMOTE': '1', 00:25:48 INFO - 'NO_EM_RESTART': '1', 00:25:48 INFO - 'PAGER': '/bin/cat', 00:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:48 INFO - 'PWD': '/builds/slave/test', 00:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:48 INFO - 'SHELL': '/bin/bash', 00:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:48 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:48 INFO - 'USER': 'cltbld', 00:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:48 INFO - 'XPC_FLAGS': '0x0', 00:25:48 INFO - 'XPC_SERVICE_NAME': '0', 00:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-1r3CqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-0TO5xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-p0dCsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-a1jY0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-qsLzwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-zk2N9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-ViInzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-9Wp_Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:25:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-Xt_nRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:25:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-v360bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:25:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-lYZZma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:25:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-EBVm55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:25:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-HWTAvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:25:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-R7Oid8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-_BuiYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:25:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-bk_saT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:25:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-pOcpTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:25:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:25:50 INFO - Running setup.py install for manifestparser 00:25:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:25:51 INFO - Running setup.py install for mozcrash 00:25:51 INFO - Running setup.py install for mozdebug 00:25:51 INFO - Running setup.py install for mozdevice 00:25:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:25:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:25:51 INFO - Running setup.py install for mozfile 00:25:51 INFO - Running setup.py install for mozhttpd 00:25:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:25:51 INFO - Running setup.py install for mozinfo 00:25:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:25:51 INFO - Running setup.py install for mozInstall 00:25:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Running setup.py install for mozleak 00:25:52 INFO - Running setup.py install for mozlog 00:25:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Running setup.py install for moznetwork 00:25:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Running setup.py install for mozprocess 00:25:52 INFO - Running setup.py install for mozprofile 00:25:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Running setup.py install for mozrunner 00:25:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Running setup.py install for mozscreenshot 00:25:53 INFO - Running setup.py install for moztest 00:25:53 INFO - Running setup.py install for mozversion 00:25:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:25:53 INFO - Cleaning up... 00:25:53 INFO - Return code: 0 00:25:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:25:53 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')]} 00:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:53 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')]} 00:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:53 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 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:53 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 00:25:53 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 00:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:53 INFO - 'HOME': '/Users/cltbld', 00:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:53 INFO - 'LOGNAME': 'cltbld', 00:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:53 INFO - 'MOZ_NO_REMOTE': '1', 00:25:53 INFO - 'NO_EM_RESTART': '1', 00:25:53 INFO - 'PAGER': '/bin/cat', 00:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:53 INFO - 'PWD': '/builds/slave/test', 00:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:53 INFO - 'SHELL': '/bin/bash', 00:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:53 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:53 INFO - 'USER': 'cltbld', 00:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:53 INFO - 'XPC_FLAGS': '0x0', 00:25:53 INFO - 'XPC_SERVICE_NAME': '0', 00:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:25:53 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-hZSY3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:25:53 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)) 00:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:25:53 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-GI8RUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-Bo0oyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-qzLT5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-G9PzeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-cOo0Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-rSpHRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-ZUONHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-DgdmfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-W0wfBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-Km3aV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:25:54 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-JfkwBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:25:55 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-_cRHlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:25:55 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-KsFHeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:55 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-D_p9Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:25:55 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-qZlWZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:25:55 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-XxxLzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:25:55 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)) 00:25:55 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)) 00:25:55 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)) 00:25:55 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)) 00:25:55 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)) 00:25:55 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)) 00:25:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:58 INFO - Downloading blessings-1.6.tar.gz 00:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:25:58 INFO - Installing collected packages: blessings 00:25:58 INFO - Running setup.py install for blessings 00:25:58 INFO - Successfully installed blessings 00:25:58 INFO - Cleaning up... 00:25:58 INFO - Return code: 0 00:25:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:25:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:25:58 INFO - Reading from file tmpfile_stdout 00:25:58 INFO - Current package versions: 00:25:58 INFO - blessings == 1.6 00:25:58 INFO - blobuploader == 1.2.4 00:25:58 INFO - docopt == 0.6.1 00:25:58 INFO - functools32 == 3.2.3-2 00:25:58 INFO - jsonschema == 2.5.1 00:25:58 INFO - manifestparser == 1.1 00:25:58 INFO - mozInstall == 1.12 00:25:58 INFO - mozcrash == 1.0 00:25:58 INFO - mozdebug == 0.1 00:25:58 INFO - mozdevice == 0.49 00:25:58 INFO - mozfile == 1.2 00:25:58 INFO - mozhttpd == 0.7 00:25:58 INFO - mozinfo == 0.9 00:25:58 INFO - mozleak == 0.1 00:25:58 INFO - mozlog == 3.4 00:25:58 INFO - moznetwork == 0.27 00:25:58 INFO - mozprocess == 0.24 00:25:58 INFO - mozprofile == 0.28 00:25:58 INFO - mozrunner == 6.13 00:25:58 INFO - mozscreenshot == 0.1 00:25:58 INFO - mozsystemmonitor == 0.3 00:25:58 INFO - moztest == 0.8 00:25:58 INFO - mozversion == 1.4 00:25:58 INFO - psutil == 3.1.1 00:25:58 INFO - requests == 1.2.3 00:25:58 INFO - wsgiref == 0.1.2 00:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:58 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 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:58 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 00:25:58 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 00:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:58 INFO - 'HOME': '/Users/cltbld', 00:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:58 INFO - 'LOGNAME': 'cltbld', 00:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:58 INFO - 'MOZ_NO_REMOTE': '1', 00:25:58 INFO - 'NO_EM_RESTART': '1', 00:25:58 INFO - 'PAGER': '/bin/cat', 00:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:58 INFO - 'PWD': '/builds/slave/test', 00:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:58 INFO - 'SHELL': '/bin/bash', 00:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:58 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:58 INFO - 'USER': 'cltbld', 00:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:58 INFO - 'XPC_FLAGS': '0x0', 00:25:58 INFO - 'XPC_SERVICE_NAME': '0', 00:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 INFO - Cleaning up... 00:25:59 INFO - Return code: 0 00:25:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb08462db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, '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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:59 INFO - 'HOME': '/Users/cltbld', 00:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:59 INFO - 'LOGNAME': 'cltbld', 00:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:59 INFO - 'MOZ_NO_REMOTE': '1', 00:25:59 INFO - 'NO_EM_RESTART': '1', 00:25:59 INFO - 'PAGER': '/bin/cat', 00:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:59 INFO - 'PWD': '/builds/slave/test', 00:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:59 INFO - 'SHELL': '/bin/bash', 00:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:25:59 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:59 INFO - 'USER': 'cltbld', 00:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:59 INFO - 'XPC_FLAGS': '0x0', 00:25:59 INFO - 'XPC_SERVICE_NAME': '0', 00:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:25:59 INFO - Cleaning up... 00:25:59 INFO - Return code: 0 00:25:59 INFO - Running post-action listener: _resource_record_post_action 00:25:59 INFO - Running post-action listener: _start_resource_monitoring 00:25:59 INFO - Starting resource monitoring. 00:25:59 INFO - [mozharness: 2017-01-17 08:25:59.407660Z] Finished create-virtualenv step (success) 00:25:59 INFO - [mozharness: 2017-01-17 08:25:59.408713Z] Running install step. 00:25:59 INFO - Running pre-action listener: _resource_record_pre_action 00:25:59 INFO - Running main action method: install 00:25:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:25:59 INFO - Reading from file tmpfile_stdout 00:25:59 INFO - Detecting whether we're running mozinstall >=1.0... 00:25:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:25:59 INFO - Reading from file tmpfile_stdout 00:25:59 INFO - Output received: 00:25:59 INFO - Usage: mozinstall [options] installer 00:25:59 INFO - Options: 00:25:59 INFO - -h, --help show this help message and exit 00:25:59 INFO - -d DEST, --destination=DEST 00:25:59 INFO - Directory to install application into. [default: 00:25:59 INFO - "/builds/slave/test"] 00:25:59 INFO - --app=APP Application being installed. [default: firefox] 00:25:59 INFO - mkdir: /builds/slave/test/build/application 00:25:59 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'] 00:25:59 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 00:26:21 INFO - Reading from file tmpfile_stdout 00:26:21 INFO - Output received: 00:26:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:26:21 INFO - Running post-action listener: _resource_record_post_action 00:26:21 INFO - [mozharness: 2017-01-17 08:26:21.677771Z] Finished install step (success) 00:26:21 INFO - [mozharness: 2017-01-17 08:26:21.677943Z] Running run-tests step. 00:26:21 INFO - Running pre-action listener: _resource_record_pre_action 00:26:21 INFO - Running main action method: run_tests 00:26:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:26:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:26:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:26:21 INFO - 2017-01-17 00:26:21.693 screenresolution[7160:135123] starting screenresolution argv=screenresolution get 00:26:21 INFO - 2017-01-17 00:26:21.696 screenresolution[7160:135123] Display 0: 1600x1200x32@60 00:26:21 INFO - 2017-01-17 00:26:21.701 screenresolution[7161:135125] starting screenresolution argv=screenresolution list 00:26:21 INFO - Available Modes on Display 0 00:26:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:26:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:26:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:26:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:26:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:26:21 INFO - Intel Iris: 00:26:21 INFO - Chipset Model: Intel Iris 00:26:21 INFO - Type: GPU 00:26:21 INFO - Bus: Built-In 00:26:21 INFO - VRAM (Dynamic, Max): 1536 MB 00:26:21 INFO - Vendor: Intel (0x8086) 00:26:21 INFO - Device ID: 0x0a2e 00:26:21 INFO - Revision ID: 0x0009 00:26:21 INFO - Displays: 00:26:21 INFO - Display: 00:26:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:26:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:26:21 INFO - Display Serial Number: 1600x1200 60 00:26:21 INFO - Main Display: Yes 00:26:21 INFO - Mirror: Off 00:26:21 INFO - Online: Yes 00:26:21 INFO - Rotation: Supported 00:26:21 INFO - Return code: 0 00:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:26:21 INFO - Python 2.7.3 00:26:21 INFO - Return code: 0 00:26:21 INFO - grabbing minidump binary from tooltool 00:26:21 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')]} 00:26:21 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 0x10a979d30>, '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 0x10a8a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a96ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:26:21 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 00:26:21 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 00:26:21 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 00:26:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:26:22 INFO - Return code: 0 00:26:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:26:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:26:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:26:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:26:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:26:22 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/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0222', '--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 00:26:22 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/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0222 --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 00:26:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mf3yCBNUl3/Render', 00:26:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:26:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:26:22 INFO - 'HOME': '/Users/cltbld', 00:26:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:26:22 INFO - 'LOGNAME': 'cltbld', 00:26:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:26:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:22 INFO - 'MOZ_NO_REMOTE': '1', 00:26:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:26:22 INFO - 'NO_EM_RESTART': '1', 00:26:22 INFO - 'PAGER': '/bin/cat', 00:26:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:22 INFO - 'PWD': '/builds/slave/test', 00:26:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:26:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:26:22 INFO - 'SHELL': '/bin/bash', 00:26:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nd9JxU2sI7/Listeners', 00:26:22 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:26:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:26:22 INFO - 'USER': 'cltbld', 00:26:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:26:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:22 INFO - 'XPC_FLAGS': '0x0', 00:26:22 INFO - 'XPC_SERVICE_NAME': '0', 00:26:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:26:22 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/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0222', '--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 00:26:22 INFO - mozversion application_buildid: 20170116235132 00:26:22 INFO - mozversion application_changeset: 87aa6ecc99aa5cb7c7f8c1f38d610093b8a2845c 00:26:22 INFO - mozversion application_display_name: Nightly 00:26:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:26:22 INFO - mozversion application_name: Firefox 00:26:22 INFO - mozversion application_remotingname: firefox 00:26:22 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 00:26:22 INFO - mozversion application_vendor: Mozilla 00:26:22 INFO - mozversion application_version: 53.0a1 00:26:22 INFO - mozversion platform_buildid: 20170116235132 00:26:22 INFO - mozversion platform_changeset: 87aa6ecc99aa5cb7c7f8c1f38d610093b8a2845c 00:26:22 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 00:26:22 INFO - mozversion platform_version: 53.0a1 00:26:22 INFO - using testdate: 1484641582 00:26:22 INFO - actual date: 1484641582 00:26:22 INFO - starting webserver on 'localhost:51675' 00:26:22 INFO - SUITE-START | Running 2 tests 00:26:22 INFO - TEST-START | dromaeo_css 00:26:22 INFO - operating with platform_type : mac_ 00:26:22 INFO - Initialising browser for dromaeo_css test... 00:26:22 INFO - TEST-INFO | started process 7171 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmphPxlJz/profile http://localhost:51675/getInfo.html) 00:26:24 INFO - PROCESS | 7171 | __metrics Screen width/height:1600/1200 00:26:24 INFO - PROCESS | 7171 | colorDepth:24 00:26:24 INFO - PROCESS | 7171 | Browser inner width/height: 1024/689 00:26:24 INFO - PROCESS | 7171 | __metrics 00:26:24 INFO - PROCESS | 7171 | 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" 00:26:24 INFO - PROCESS | 7171 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:26:25 INFO - TEST-INFO | 7171: exit 0 00:26:25 INFO - Browser initialized. 00:26:25 INFO - Running cycle 1/1 for dromaeo_css test... 00:26:25 INFO - TEST-INFO | started process 7173 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmphPxlJz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:26:37 INFO - PROCESS | 7173 | RSS: Main: 227221504 00:26:37 INFO - PROCESS | 7173 | 00:29:41 INFO - PROCESS | 7173 | Cycle 1(1): loaded http://localhost:51675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51675/tests/dromaeo/cssquery-ext.html) 00:29:42 INFO - PROCESS | 7173 | RSS: Main: 361164800 00:29:42 INFO - PROCESS | 7173 | 00:31:27 INFO - PROCESS | 7173 | ************************* 00:31:27 INFO - PROCESS | 7173 | A coding exception was thrown and uncaught in a Task. 00:31:27 INFO - PROCESS | 7173 | 00:31:27 ERROR - PROCESS | 7173 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:31:27 INFO - PROCESS | 7173 | Full stack: 00:31:27 INFO - PROCESS | 7173 | ************************* 00:32:45 INFO - PROCESS | 7173 | Cycle 1(1): loaded http://localhost:51675/tests/dromaeo/cssquery-ext.html (next: http://localhost:51675/tests/dromaeo/cssquery-jquery.html) 00:32:46 INFO - PROCESS | 7173 | RSS: Main: 365760512 00:32:46 INFO - PROCESS | 7173 | 00:35:48 INFO - PROCESS | 7173 | Cycle 1(1): loaded http://localhost:51675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51675/tests/dromaeo/cssquery-mootools.html) 00:35:49 INFO - PROCESS | 7173 | RSS: Main: 337604608 00:35:49 INFO - PROCESS | 7173 | 00:38:51 INFO - PROCESS | 7173 | Cycle 1(1): loaded http://localhost:51675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51675/tests/dromaeo/cssquery-prototype.html) 00:38:52 INFO - PROCESS | 7173 | RSS: Main: 353234944 00:38:52 INFO - PROCESS | 7173 | 00:41:55 INFO - PROCESS | 7173 | Cycle 1(1): loaded http://localhost:51675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51675/tests/dromaeo/cssquery-yui.html) 00:41:56 INFO - PROCESS | 7173 | RSS: Main: 323510272 00:41:56 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | Cycle 1(1): loaded http://localhost:51675/tests/dromaeo/cssquery-yui.html (next: http://localhost:51675/tests/dromaeo/cssquery-dojo.html) 00:44:59 INFO - PROCESS | 7173 | RSS: Main: 408416256 00:44:59 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | __start_tp_report 00:44:59 INFO - PROCESS | 7173 | _x_x_mozilla_page_load 00:44:59 INFO - PROCESS | 7173 | _x_x_mozilla_page_load_details 00:44:59 INFO - PROCESS | 7173 | |i|pagename|runs| 00:44:59 INFO - PROCESS | 7173 | |0;dojo.html;3185.1400121967067;3251.642319344873;3257.2671148991494;3267.8366081695917;3315.568976033115;5460.781568737256;5520.420355862631;5592.972035139829;5625.6905870177125;5630.40880707526;5364.222187782769;5400.702961337125;5417.864553386167;5461.317335333083;5570.777168913239;4256.787160641971;5067.923981140286;5086.262491938666;5111.152103140384;5173.741312934357;5144.948550514503;5228.764705588239;5233.21501774733;5282.31329927109;5299.019681358942;5070;5210.635255532115;5216.869578260555;5217.217417387385;5224;5076.82231121909;5091.567216786578;5147.433782283946;5149.021685879671;5153.252778347119;5082.949170508285;5159.174532074888;5165.560927321182;5171.974140129275;5194.740262986836;5615.466530679579;5629.127485239795;5629.4652008059165;5650.971745141289;5691.231683722686;6011.729472173763;6059.969805133138;6063.969680151571;6156.26124865019;6156.938430615726;5085.23721441783;6146.815595532141;6196.845078873064;6211.47202487789;6233.252009758858;5747.109198074221;5752.568557358131;5754.395788442195;5774.307083150049;5794.188813566104;6141.700809433414;6208.50331973441;6209.937900620936;6250.062490626442;6263.31103578606;5956.612820166675;6020.969895150583;6045.879082418327;6054.727537260834;6118.20463339763;6042.577019608673;6151.784687535915;6158.451406904827;6183.628982260989;6192.504599632019;5989.251343582052;6058.909116363258;6063.242094738158;6064;6080.635161890301;6023.819285421444;6140.17107690456;6148.661823599656;6150.292716337678;6159.630422174684;4879.39007624047;4911.533404326583;4916.5575098240615;4916.606671466274;4934.432540257844;3487.849009826751;4343.739375637409;4377.233984052778;4380.737155770664;4398.362237475612;5792.1311803229855;5794.536437085023;5798.797042103506;5801.680907550125;5806.187133801272;6100.755969761249;6110.072772100023;6112.564273424362;6216.191895053614;6217.4715149212825;5713.200151978726;5778.7688492460675;5804.738786754606;5814.069748840166;5847.853803654943;5404.83785486436;5407.540359069444;5407.729613519387;5410.404855465896;5423.891522169534;6154.01535754295;6210.596311239755;6287.497000239879;6314;6338.01760727088;6106.005662908024;6123.984276525883;6130.734471166674;6193.071039343954;6250.874982500415;6309.873802524015;6310;6326.588771729823;6331.715072821642;6332.588381755171;6004.789832356021;6074.635521868702;6117.143599896107;6123.7550497981365;6185.659788711664;6053.485453736482;6108.554560543837;6117.174181485442;6127.8615298716295;6136.29432615255;5876.823695289148;5878.470937615635;6064.787732429344;6075.027995520695;6114.388561144028;5821.388754180919;5870.970645146747;5925.140854576149;5940.702964851826;5967.31375891778;5805.187273781758;5876.1773351731645;5880;5960.284765828128;5969.940300596939;4614.238650622609;5390.760125171154;5892.175095486721;5953.613015154001;5961.791337303173;5859.912101318569;5870.882582348244;5878.118282257525;5891.823245302648;5910.674912879661 00:44:59 INFO - PROCESS | 7173 | |1;ext.html;486.99192671170647;494.17719497037433;496.34730329616553;504.3418339067518;506.2229477751652;31310.21724456887;34834.303313933706;35895;36048.27903441936;36095;35392.646073539254;44393;44399.112017759624;44426.55573444265;44472.99999999992;9103.135202155785;9319.813603727955;9322.953385233064;9323.580438880266;9342.205912497411;8316.251537361637;8558.315334773204;11095.72260693481;11350.60272890449;11370.488328025218;11061.838506956774;11312.943435282812;11380.374079425628;11391.772164556704;11395.430228488583;8354.8329033419;9689.51552422383;9777.608895644165;11383.601573944956;11386.373749443777;8432.747017589481;10884.836727449094;11244.020334611252;11245.100391968705;11358.659240222807;42062.36906446406;42386.576134238574;42409.78795106005;42461;42497.57502424967;4028.47629808126;4032.6169013943627;4038.757674539537;4050.858219962287;4067.7559346439307;30094;30531.9502527546;30598.082057538308;31253.062408127793;31531.84234078838;3134.8275844828527;3172.936541269185;3177.9841100794347;3198.648148703641;3299.8185099819502;471899;476351;478869;479300;479445;64216.67891660512;64505.67747161328;64720.67639661772;64852.02721959174;64899.67550162219;68492.3150768486;68514.65742671255;68518;68576;68625;15771.29029193666;16206.75689864653;16285.348586056425;16324;16326.75509867353;11330.37682927447;11527.481263343001;12500.812487812509;12583.056270779545;12613.810792838114;16490.34038638465;18419.26322947067;18790.95994361219;18920.824105228075;19209;6098.939010609837;6239.656818874914;7321.71679567459;7336.963315183497;7360.926390736131;832.4381042796089;866.4194989357146;869.5087275689342;897.6588896219395;914.2777206007313;23423.648645269994;28343.71656283452;29563;29605.85197074001;30433;1064.1593141418348;1071.2501249125644;1072.9946350268199;1116.1573012375604;1125.0999200639455;15366.923165384325;15575.065496070272;15757;15858.89083108208;16008;612202;615492.9225353844;616676;616721;617842;60426;60667.39332606617;60688.089678654855;60728.392716072274;60753.39246607477;1420.786881967713;1441.1929319581068;1469.258024697521;1474.4176050459794;1475.1001888847795;24634.753652463245;28723.856380717963;29490.11529654114;29721.405571888874;30132.69867301299;49346.753266234875;53111.73444132755;53121;53145.202821958475;53204;568737;573599;573953;574962;575383;22577.322680319616;23023.424414389774;24312.635310470003;24797.25608231756;24980.875095624404;40530.39204411877;42088.36867447052;42857.35713964231;43173;43489.78255108704;34347.656523434445;35226.47160292546;35235.47146792749;36101.277974439836;36183;34955.60177592868;35008.12479688028;35571.82214088913;35854.82072589621;36281.548738051235;34097.659023410444;34478.13787284789;35242.942711718686;35379.82310088433;35539.28921421505;30379.848100759355;31437.842810785798;31584.472192507434;31720.682793172695;32217.838910805294;19315.51711207231;20739.368957655144;22729.77845319499;23307.53384932258;23450 00:44:59 INFO - PROCESS | 7173 | |2;jquery.html;310.9968900310996;337.308517539045;390.4923599320884;397.21153510282096;426.413681188366;19900.800991990094;20024.799752002476;20693.586128277424;20881.477963050933;21061.052252648627;12261.693457663563;12290.877091229086;17452.1273936303;20734.688979665316;21466.463338416546;5372.2210279509445;5594.888102237953;5596.048671725816;5597.6641401515835;5614.27014488118;5696.202531645573;5991.101334799793;6054.666993315366;6072.6356418614805;6077.058056001327;5854.238948936632;6024.638521688691;6071.332153463116;6071.696415179245;6072.544559158058;6065.059915713072;6065.423784740465;6094.969525152368;6096.603720758181;6106.2977757558;5749.281339832521;5788.04497257952;5934.465898069151;5941.3761555036535;5948.167256584082;13544.255065971367;13578.388972496261;13641.045126841125;13766.518171864036;13769.03616746828;2560.129555950986;2598.628170679017;2650.2446802661343;2713.9185824425103;2725.3731641722316;9748.073932976356;10347.482625868677;10581.206409519316;10587.78824423515;10695.732606684818;1799.8200179981898;1811.4022372617005;1836.7255513909752;1864.5618279704258;1890.5179179309325;131736;135393.64606353908;136251.31874340665;138161.9275710865;138970.3051484746;8686.348523860735;9123.406978546373;9702.611895524242;11626.651200463999;11651.53393864253;15106.39574417033;15328.23358832054;15338.616534586725;15354.769678454832;15387.61530961735;8329.6668133274;8614;8642.956785216034;8774.078721734253;8810.339224558056;8447.915520844714;8465.619047142893;8468.915310846813;8644.22202001823;8671.783205419788;4563.520830312836;4635.930461043087;4649.837255696102;4691.812327506861;4728.361671174416;1523.6724104317625;1665.7251553493538;1993.6212119697211;2003.1586733571935;2010.115549158395;835.4444294544181;971.4705485510273;974.5760594141572;1009.6920439265947;1036.7304500829687;19152.61694766097;20272.49318767013;20824;21808.781912180675;21902.561948760937;875.7898104455012;974.9860145448796;1022.0648106982177;1050.1808589300358;1056.5773690523852;11055.447227638586;11286.887131128748;11347.943260283646;11350.14873884462;11368.602098926498;701890;705620;710916.7904086321;725020;732299;149278;150803;151182;151445.48554514314;151927;978.2272005116021;1021.3361315145066;1048.8217003109337;1052.6736711619421;1053.1364281289423;18786.436406907815;18872.622547549247;19059.809401905804;19064;19226.51933701613;58925.41074589199;59391.406085938586;59692;60670;61540;86451.13548864432;88061.55969220113;88788;89699.55150224207;90219.54890225508;8150.551719655476;8190.672373105247;8460.377283042277;8657.82684346297;8727.781805454915;11506.539738410369;12070.879291206975;12391.442385092872;12597.93701031489;13410.32948352559;11068.667939961813;11274.549018039515;11520.193586449202;11745.412729363326;11791.410429478663;10789.460526973777;11226.158038147334;11420.942895285803;11441.656750297505;11569.074474041889;11485.253458525169;11598;12023.338716370334;12050.156489045683;12079.39603019863;8645.438046526955;12384.690382740144;12437.564685235973;12589.559365422167;12966.546170883974;11434.771304573696;11714.121440892137;11781.646550603497;12059.879401205875;12201.572944946884 00:44:59 INFO - PROCESS | 7173 | |3;mootools.html;1328.9269090200048;1443.2855736410477;1449.7390469715451;1452.2738630684657;1469.8456662050492;7380.372668323193;7615.276548727876;7747.1090824555195;7924.762257132295;7939.206079392058;7863.80340491488;7879.290863822255;7944.96027519863;7950.36397088233;7952.721654742085;2040.5102775333962;2268.727752669682;2308.9422764430856;2309.6650985607075;2311.3297143828268;2126.3302059851176;2272.6704627828954;2343.2267351773876;2356.6229403295474;2363.1374548289923;2305.9538809223804;2323.3494621506006;2325.6860323856317;2328.7321957974796;2331.591971405006;2025.463252238158;2107.3677896630948;2253.3915842722454;2309.145616122029;2311.445253139243;2118.8834614096218;2255.729312482513;2323.674685544025;2340.6957095577636;2344.2381226101584;8232.464889782144;8307.46001509906;8309.875351869727;8310.70912518065;8347.833043339098;4966.056449274626;5128.1282182029145;5132.871678208037;5138.486151384869;5140.126178549655;3315.4032274190636;3466.9653303466894;3474.6004209515977;3516.841742121585;3528.6118526962014;1146.4611632532697;1207.4626791077974;1224.5729649674784;1252.2173641474078;1255.8995280377549;10454.738631534197;10466.895331046744;10625.362478251329;10633.361998280128;10644.361338319726;4405.383246345515;4548.272276435754;4626.7223966562115;4648.047150334173;4653.115907977473;9140.954295228481;9192.402493837879;9233;9275.953620231856;9385.483798391155;5151.716655583904;5153.484651534816;5154.278401023859;5159.509846564571;5177.3269474968765;4500.9099818004115;4600.6549508786975;4639.559241872017;4705.623550115983;4705.64707646921;3723.795191264452;3762.6049264826797;3786.1670432504807;3833.8274777635074;3846.7114966377635;1124.3141683573015;1248.4631608408472;1253.4735411127167;1271.586734311334;1271.7011502296953;758.211460081509;759.1573353577525;782.9352081169604;785.7485604606585;805.7059173401666;5091.974540127276;5337.519623233928;5482.890342193134;5487.122060470306;5603.439656034364;493.5410068636131;562.1483452569361;576.9423057694197;590.1943846649293;592.3277080513648;3651.7626354286886;3654.8538058477893;3728.925421491555;3803.391457366808;3813.580506144322;9369.437833729999;9713.174380177623;9781.266405019653;9784.608615655436;9804.607815687436;9690.51547422626;9730.17293530058;9738.805223895482;9757.12185903272;9813.362131461432;7283.3809126223805;7553.924460755322;7626.961865190749;7632.694692212361;7713;5571.470710282517;5677.403872593483;5685.8862822742485;5738.99567575681;5753.539716822728;8490.533020683923;8875.73372798817;8894.822103558023;9007.639694412412;9030.864537031819;8805.339599529932;9098.772530686521;9221.400608960395;9327.067293270618;9375.531223438937;6992.16094068715;7106.182788979127;7170.928290717026;7175.354218120394;7179.497435179487;7448.217937116741;7787.766367008999;7803.7268695595385;7873.724419645285;7884.093329267208;6984.895226571504;7028.226895041644;7056.223815380406;7065.929340706527;7185;6900.723971041102;6906.482013848881;6907.516473846783;6946.235914049552;6964.4080253179045;6262.655553944577;6295.811125666238;6300.905486417616;6352.809415717536;6396;4552.044070745181;4591.724496530219;4932.2601609757385;4973.179425394769;4992.326035985096;3935.6654684351006;4850.659127159594;4945.925811112764;5062.1141300271565;5152.252923326172 00:44:59 INFO - PROCESS | 7173 | |4;prototype.html;354.08998872896655;358.3334996905755;365.5595008015341;373.6599694278207;374.8425661222288;4815.9277610835825;4969.47820478849;5141.948580514194;5274.789008439662;5309.840704778858;4887.462379138292;5089.720065396402;5096.184610462317;5199.452268388491;5216.452272511388;3599.6580324869096;3659.451082337651;4119.402686610455;4133.6693064554765;4138.461999940018;3134.4484480182227;4102.466679331683;4103.917921641565;4107.137501124767;4141.109661422794;3454.533637958881;3540.6459354064646;3919.568847426781;3989.9027767364064;3991.4611527443712;3910.452536644872;3913.6086391360923;3921.2353591049755;3930.8034598269974;3972.086420123359;3172.74618030557;3435.553378060836;3443.741719371057;3454.3746752468055;3455.3434847378917;4837.467878533358;5094.847154585332;5108;5110.795568177268;5111.821086261963;3705.980855264797;4167.9577007266225;4479.992001799602;4480.395146655225;4539.750313732743;5449.711121329051;5463.453654634544;5479.863003424906;5494.80768173112;5499.680076781584;3114.7073964304786;3735.2529494101286;3758.32350176968;3804.2581696568905;3848.2111167210933;4715.811367545294;5740.339860916007;5839.0949402842625;5843.357230704619;5875.265591801025;3842.884713458601;3856.016715737525;3857.864974725871;3894.9610503894596;3897.3569361055106;3039.498482750366;3919.6864250859862;3923.372260438316;3924.920646822147;3944.7435916665327;4428.889277768081;4693.859184224479;4772.76136193189;4781.928271075936;4784.105616102208;4712.670113092119;5567.693776842231;5628.875973834479;5641.617803638135;5657.490825825613;1162.91859569831;1221.84116064911;1309.43039777697;1328.4420543371807;1356.7693492106366;848.7326492154951;956.9186619137452;987.4963768478128;987.918229538654;993.8310487217191;4658.114958157939;4691.179043667345;4751.786169622375;4947.381577302837;5006.249062640633;5038.193888977746;5115.462876397924;5140.511651393112;5182.890265840466;5368.91946620801;4337.652987761035;4963.950360496348;4981.726005069683;4995.000999800054;4995.151793836304;2545.0074470956342;2758.634475934425;2758.7103354147926;2847.8860845565946;2863.096041132665;4872.634552408513;5134.922976155361;5165.236598419828;5361.498780341511;5550.333959924835;4498.662600304925;4681.6020638245445;4735.697683137165;5028.823991160365;5574.832755017356;4632.351470794024;5284.9471505284455;5620.97189514058;5628.789810190747;5666.744996475169;4868.225111686304;5386.703731294817;5403.891922161456;5436.646617969977;5438.190131986207;4885.413750349839;4942.8764280893265;4975.452700203047;5232.450592687713;5406.998820872447;5225.399079105951;5333.320014184881;5607.607467477237;5608.7195640217005;5618.134751276796;3321.355928815252;3725.850965961331;3872.6514613684903;3913.1977944520736;3950.9209815804097;4500.909981800281;5120.692758434506;5221.120396657277;5277.604179686462;5416.079266524779;4099.774512401727;4196.412502249626;4573.656975726767;5203.777112378512;5344.812931547377;4795.808167673254;5349.732513374393;5427.1045277528765;5437.3747019091725;5514.476124768141;5336.706481143575;5439.972800135974;5468.371137319259;5468.781248750005;5489.945100549103;4344.301995710009;5526.253955715927;5575.470330318613;5594;5632.718364081861;5136.178211486144;5321.574274057989;5357.303550538405;5454.699991500505;5472.562195024469 00:44:59 INFO - PROCESS | 7173 | |5;yui.html;704.3731079339385;711.0152438872167;775.9679626097292;812.1188510466144;819.1849110135416;12303.585087714904;14084.29578521075;14609.780853287182;14864.851351486483;14941.252937353129;14605.977581569294;15320.846791532082;15914;16060.759088613651;16418.26117824698;832.6169961817541;846.1749793950895;847.0682249525535;867.1805144138791;871.376965469689;679.7926632377123;689.035350509286;736.466062104975;864.5288317866778;866.4801119328384;913.5067063785548;921.8110287391103;932.6502561539422;932.7994481186544;934.5700977550335;887.0154128916929;887.0375642427973;887.0419946457843;903.814717982812;923.8614207868807;532.3425569421761;547.1491830204031;549.950504454597;693.7571849852511;695.0339028750042;12411.255324680547;12477.50089996399;13459.855912247373;14297.78553321701;14317.642058948506;13980.860191398058;14141.434342626282;14187.88551320116;14211.147331160164;14235.430582776677;11823.763524729544;11947.701307467296;12076.577319793852;12175.45210465531;12209.511619535208;3083.8766449342;3625.2024554597947;3709.332320182366;3863.806809659534;3870.438786375988;104533;106108;107234;108038.91961080367;108176;10086.697399078039;10752.516136773864;10901.073408760185;10945.671629850958;11320.886791132149;22125.557488850456;22194.334169974925;22263.666045009337;22412.775872241396;22581.548369032527;7737.806554836062;7740.729074482366;7746.612669366509;7760.844783104306;7974.52152870818;4032.737872038308;4295.763732994716;4344.478662560513;4380.452443444569;4457.2199865023495;3477.826108694555;3582.749207555446;3584.193556449778;3753.2681127180485;3955.406688996616;702.220535205921;703.4513079797766;705.8023753349071;725.1986554856912;726.5241266970143;639.2989618860278;677.695037233247;688.9655517224119;702.6732569355274;745.1015549512401;7608.391328693802;10304.381737095799;10541.156707463384;10586.947065264778;10662;694.7151667816272;707.8053535277737;722.458156382713;728.6720975561019;736.1681300130817;4682.906341873144;5078.695278283315;5090.541851233407;5101;5111.591072714174;83473.58263208646;97789.51105244429;102965.48517257365;106132;112355;51816.74091629518;77467;83478;85639;89658;58492.12261816076;67894;69165.27086822769;77699.61150194213;79248.603756982;10204;10336.741581460223;10862.565497380016;11047.337159770439;11163.720906977065;45423;45940;49449;51566.74216629043;51666.483335166165;65286.673566631864;66195;67174.64126793543;67878.66060669665;68034;13211.66970825737;13241.106719367528;13494.865051349754;13680;14039.298035098;14771.409143634135;14931.552053438414;15045.548633541011;15162.620934476285;15513.34599620087;13704.725905481635;14019.439222430989;14115.2942352884;14138.858611413754;14303.856961430252;13388;13489.662758430724;13569;13836.239006854317;13894.23581703016;13241.867581324064;13486.86513134856;13638.113522620997;13656.726865462437;14228;10844.566217351217;11367.772644547229;11398.886011139783;11508.194426390073;11695.532178712756;10861;10951.54919513282;11080.833787493355;11120.332780033224;11167.218294719616 00:44:59 INFO - PROCESS | 7173 | __end_tp_report 00:44:59 INFO - PROCESS | 7173 | __start_cc_report 00:44:59 INFO - PROCESS | 7173 | _x_x_mozilla_cycle_collect,1328 00:44:59 INFO - PROCESS | 7173 | __end_cc_report 00:44:59 INFO - PROCESS | 7173 | __startTimestamp1484642699925__endTimestamp 00:44:59 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | ------- Summary: start ------- 00:44:59 INFO - PROCESS | 7173 | Number of tests: 6 00:44:59 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | [#0] dojo.html Cycles:165 Average:5649.13 Median:5870.97 stddev:658.18 (11.2%) stddev-sans-first:631.18 00:44:59 INFO - PROCESS | 7173 | Values: 3185.1 3251.6 3257.3 3267.8 3315.6 5460.8 5520.4 5593.0 5625.7 5630.4 5364.2 5400.7 5417.9 5461.3 5570.8 4256.8 5067.9 5086.3 5111.2 5173.7 5144.9 5228.8 5233.2 5282.3 5299.0 5070.0 5210.6 5216.9 5217.2 5224.0 5076.8 5091.6 5147.4 5149.0 5153.3 5082.9 5159.2 5165.6 5172.0 5194.7 5615.5 5629.1 5629.5 5651.0 5691.2 6011.7 6060.0 6064.0 6156.3 6156.9 5085.2 6146.8 6196.8 6211.5 6233.3 5747.1 5752.6 5754.4 5774.3 5794.2 6141.7 6208.5 6209.9 6250.1 6263.3 5956.6 6021.0 6045.9 6054.7 6118.2 6042.6 6151.8 6158.5 6183.6 6192.5 5989.3 6058.9 6063.2 6064.0 6080.6 6023.8 6140.2 6148.7 6150.3 6159.6 4879.4 4911.5 4916.6 4916.6 4934.4 3487.8 4343.7 4377.2 4380.7 4398.4 5792.1 5794.5 5798.8 5801.7 5806.2 6100.8 6110.1 6112.6 6216.2 6217.5 5713.2 5778.8 5804.7 5814.1 5847.9 5404.8 5407.5 5407.7 5410.4 5423.9 6154.0 6210.6 6287.5 6314.0 6338.0 6106.0 6124.0 6130.7 6193.1 6250.9 6309.9 6310.0 6326.6 6331.7 6332.6 6004.8 6074.6 6117.1 6123.8 6185.7 6053.5 6108.6 6117.2 6127.9 6136.3 5876.8 5878.5 6064.8 6075.0 6114.4 5821.4 5871.0 5925.1 5940.7 5967.3 5805.2 5876.2 5880.0 5960.3 5969.9 4614.2 5390.8 5892.2 5953.6 5961.8 5859.9 5870.9 5878.1 5891.8 5910.7 00:44:59 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | [#1] ext.html Cycles:180 Average:68818.64 Median:35465.97 stddev:149208.89 (420.7%) stddev-sans-first:149539.26 00:44:59 INFO - PROCESS | 7173 | Values: 487.0 494.2 496.3 504.3 506.2 31310.2 34834.3 35895.0 36048.3 36095.0 35392.6 44393.0 44399.1 44426.6 44473.0 9103.1 9319.8 9323.0 9323.6 9342.2 8316.3 8558.3 11095.7 11350.6 11370.5 11061.8 11312.9 11380.4 11391.8 11395.4 8354.8 9689.5 9777.6 11383.6 11386.4 8432.7 10884.8 11244.0 11245.1 11358.7 42062.4 42386.6 42409.8 42461.0 42497.6 4028.5 4032.6 4038.8 4050.9 4067.8 30094.0 30532.0 30598.1 31253.1 31531.8 3134.8 3172.9 3178.0 3198.6 3299.8 471899.0 476351.0 478869.0 479300.0 479445.0 64216.7 64505.7 64720.7 64852.0 64899.7 68492.3 68514.7 68518.0 68576.0 68625.0 15771.3 16206.8 16285.3 16324.0 16326.8 11330.4 11527.5 12500.8 12583.1 12613.8 16490.3 18419.3 18791.0 18920.8 19209.0 6098.9 6239.7 7321.7 7337.0 7360.9 832.4 866.4 869.5 897.7 914.3 23423.6 28343.7 29563.0 29605.9 30433.0 1064.2 1071.3 1073.0 1116.2 1125.1 15366.9 15575.1 15757.0 15858.9 16008.0 612202.0 615492.9 616676.0 616721.0 617842.0 60426.0 60667.4 60688.1 60728.4 60753.4 1420.8 1441.2 1469.3 1474.4 1475.1 24634.8 28723.9 29490.1 29721.4 30132.7 49346.8 53111.7 53121.0 53145.2 53204.0 568737.0 573599.0 573953.0 574962.0 575383.0 22577.3 23023.4 24312.6 24797.3 24980.9 40530.4 42088.4 42857.4 43173.0 43489.8 34347.7 35226.5 35235.5 36101.3 36183.0 34955.6 35008.1 35571.8 35854.8 36281.5 34097.7 34478.1 35242.9 35379.8 35539.3 30379.8 31437.8 31584.5 31720.7 32217.8 19315.5 20739.4 22729.8 23307.5 23450.0 00:44:59 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | [#2] jquery.html Cycles:180 Average:39692.61 Median:20483.04 stddev:119493.19 (583.4%) stddev-sans-first:119791.81 00:44:59 INFO - PROCESS | 7173 | Values: 311.0 337.3 390.5 397.2 426.4 19900.8 20024.8 20693.6 20881.5 21061.1 12261.7 12290.9 17452.1 20734.7 21466.5 5372.2 5594.9 5596.0 5597.7 5614.3 5696.2 5991.1 6054.7 6072.6 6077.1 5854.2 6024.6 6071.3 6071.7 6072.5 6065.1 6065.4 6095.0 6096.6 6106.3 5749.3 5788.0 5934.5 5941.4 5948.2 13544.3 13578.4 13641.0 13766.5 13769.0 2560.1 2598.6 2650.2 2713.9 2725.4 9748.1 10347.5 10581.2 10587.8 10695.7 1799.8 1811.4 1836.7 1864.6 1890.5 131736.0 135393.6 136251.3 138161.9 138970.3 8686.3 9123.4 9702.6 11626.7 11651.5 15106.4 15328.2 15338.6 15354.8 15387.6 8329.7 8614.0 8643.0 8774.1 8810.3 8447.9 8465.6 8468.9 8644.2 8671.8 4563.5 4635.9 4649.8 4691.8 4728.4 1523.7 1665.7 1993.6 2003.2 2010.1 835.4 971.5 974.6 1009.7 1036.7 19152.6 20272.5 20824.0 21808.8 21902.6 875.8 975.0 1022.1 1050.2 1056.6 11055.4 11286.9 11347.9 11350.1 11368.6 701890.0 705620.0 710916.8 725020.0 732299.0 149278.0 150803.0 151182.0 151445.5 151927.0 978.2 1021.3 1048.8 1052.7 1053.1 18786.4 18872.6 19059.8 19064.0 19226.5 58925.4 59391.4 59692.0 60670.0 61540.0 86451.1 88061.6 88788.0 89699.6 90219.5 8150.6 8190.7 8460.4 8657.8 8727.8 11506.5 12070.9 12391.4 12597.9 13410.3 11068.7 11274.5 11520.2 11745.4 11791.4 10789.5 11226.2 11420.9 11441.7 11569.1 11485.3 11598.0 12023.3 12050.2 12079.4 8645.4 12384.7 12437.6 12589.6 12966.5 11434.8 11714.1 11781.6 12059.9 12201.6 00:44:59 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | [#3] mootools.html Cycles:180 Average:5324.06 Median:5168.42 stddev:2896.62 (56.0%) stddev-sans-first:2889.18 00:44:59 INFO - PROCESS | 7173 | Values: 1328.9 1443.3 1449.7 1452.3 1469.8 7380.4 7615.3 7747.1 7924.8 7939.2 7863.8 7879.3 7945.0 7950.4 7952.7 2040.5 2268.7 2308.9 2309.7 2311.3 2126.3 2272.7 2343.2 2356.6 2363.1 2306.0 2323.3 2325.7 2328.7 2331.6 2025.5 2107.4 2253.4 2309.1 2311.4 2118.9 2255.7 2323.7 2340.7 2344.2 8232.5 8307.5 8309.9 8310.7 8347.8 4966.1 5128.1 5132.9 5138.5 5140.1 3315.4 3467.0 3474.6 3516.8 3528.6 1146.5 1207.5 1224.6 1252.2 1255.9 10454.7 10466.9 10625.4 10633.4 10644.4 4405.4 4548.3 4626.7 4648.0 4653.1 9141.0 9192.4 9233.0 9276.0 9385.5 5151.7 5153.5 5154.3 5159.5 5177.3 4500.9 4600.7 4639.6 4705.6 4705.6 3723.8 3762.6 3786.2 3833.8 3846.7 1124.3 1248.5 1253.5 1271.6 1271.7 758.2 759.2 782.9 785.7 805.7 5092.0 5337.5 5482.9 5487.1 5603.4 493.5 562.1 576.9 590.2 592.3 3651.8 3654.9 3728.9 3803.4 3813.6 9369.4 9713.2 9781.3 9784.6 9804.6 9690.5 9730.2 9738.8 9757.1 9813.4 7283.4 7553.9 7627.0 7632.7 7713.0 5571.5 5677.4 5685.9 5739.0 5753.5 8490.5 8875.7 8894.8 9007.6 9030.9 8805.3 9098.8 9221.4 9327.1 9375.5 6992.2 7106.2 7170.9 7175.4 7179.5 7448.2 7787.8 7803.7 7873.7 7884.1 6984.9 7028.2 7056.2 7065.9 7185.0 6900.7 6906.5 6907.5 6946.2 6964.4 6262.7 6295.8 6300.9 6352.8 6396.0 4552.0 4591.7 4932.3 4973.2 4992.3 3935.7 4850.7 4945.9 5062.1 5152.3 00:44:59 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | [#4] prototype.html Cycles:180 Average:4374.64 Median:4886.44 stddev:1309.62 (26.8%) stddev-sans-first:1278.05 00:44:59 INFO - PROCESS | 7173 | Values: 354.1 358.3 365.6 373.7 374.8 4815.9 4969.5 5141.9 5274.8 5309.8 4887.5 5089.7 5096.2 5199.5 5216.5 3599.7 3659.5 4119.4 4133.7 4138.5 3134.4 4102.5 4103.9 4107.1 4141.1 3454.5 3540.6 3919.6 3989.9 3991.5 3910.5 3913.6 3921.2 3930.8 3972.1 3172.7 3435.6 3443.7 3454.4 3455.3 4837.5 5094.8 5108.0 5110.8 5111.8 3706.0 4168.0 4480.0 4480.4 4539.8 5449.7 5463.5 5479.9 5494.8 5499.7 3114.7 3735.3 3758.3 3804.3 3848.2 4715.8 5740.3 5839.1 5843.4 5875.3 3842.9 3856.0 3857.9 3895.0 3897.4 3039.5 3919.7 3923.4 3924.9 3944.7 4428.9 4693.9 4772.8 4781.9 4784.1 4712.7 5567.7 5628.9 5641.6 5657.5 1162.9 1221.8 1309.4 1328.4 1356.8 848.7 956.9 987.5 987.9 993.8 4658.1 4691.2 4751.8 4947.4 5006.2 5038.2 5115.5 5140.5 5182.9 5368.9 4337.7 4964.0 4981.7 4995.0 4995.2 2545.0 2758.6 2758.7 2847.9 2863.1 4872.6 5134.9 5165.2 5361.5 5550.3 4498.7 4681.6 4735.7 5028.8 5574.8 4632.4 5284.9 5621.0 5628.8 5666.7 4868.2 5386.7 5403.9 5436.6 5438.2 4885.4 4942.9 4975.5 5232.5 5407.0 5225.4 5333.3 5607.6 5608.7 5618.1 3321.4 3725.9 3872.7 3913.2 3950.9 4500.9 5120.7 5221.1 5277.6 5416.1 4099.8 4196.4 4573.7 5203.8 5344.8 4795.8 5349.7 5427.1 5437.4 5514.5 5336.7 5440.0 5468.4 5468.8 5489.9 4344.3 5526.3 5575.5 5594.0 5632.7 5136.2 5321.6 5357.3 5454.7 5472.6 00:44:59 INFO - PROCESS | 7173 | 00:44:59 INFO - PROCESS | 7173 | [#5] yui.html Cycles:180 Average:19947.06 Median:3604.70 stddev:28246.45 (783.6%) stddev-sans-first:28288.73 00:44:59 INFO - PROCESS | 7173 | Values: 704.4 711.0 776.0 812.1 819.2 12303.6 14084.3 14609.8 14864.9 14941.3 14606.0 15320.8 15914.0 16060.8 16418.3 832.6 846.2 847.1 867.2 871.4 679.8 689.0 736.5 864.5 866.5 913.5 921.8 932.7 932.8 934.6 887.0 887.0 887.0 903.8 923.9 532.3 547.1 550.0 693.8 695.0 12411.3 12477.5 13459.9 14297.8 14317.6 13980.9 14141.4 14187.9 14211.1 14235.4 11823.8 11947.7 12076.6 12175.5 12209.5 3083.9 3625.2 3709.3 3863.8 3870.4 104533.0 106108.0 107234.0 108038.9 108176.0 10086.7 10752.5 10901.1 10945.7 11320.9 22125.6 22194.3 22263.7 22412.8 22581.5 7737.8 7740.7 7746.6 7760.8 7974.5 4032.7 4295.8 4344.5 4380.5 4457.2 3477.8 3582.7 3584.2 3753.3 3955.4 702.2 703.5 705.8 725.2 726.5 639.3 677.7 689.0 702.7 745.1 7608.4 10304.4 10541.2 10586.9 10662.0 694.7 707.8 722.5 728.7 736.2 4682.9 5078.7 5090.5 5101.0 5111.6 83473.6 97789.5 102965.5 106132.0 112355.0 51816.7 77467.0 83478.0 85639.0 89658.0 58492.1 67894.0 69165.3 77699.6 79248.6 10204.0 10336.7 10862.6 11047.3 11163.7 45423.0 45940.0 49449.0 51566.7 51666.5 65286.7 66195.0 67174.6 67878.7 68034.0 13211.7 13241.1 13494.9 13680.0 14039.3 14771.4 14931.6 15045.5 15162.6 15513.3 13704.7 14019.4 14115.3 14138.9 14303.9 13388.0 13489.7 13569.0 13836.2 13894.2 13241.9 13486.9 13638.1 13656.7 14228.0 10844.6 11367.8 11398.9 11508.2 11695.5 10861.0 10951.5 11080.8 11120.3 11167.2 00:44:59 INFO - PROCESS | 7173 | -------- Summary: end -------- 00:44:59 INFO - PROCESS | 7173 | 00:45:00 INFO - TEST-INFO | 7173: exit 0 00:45:00 INFO - TEST-OK | dromaeo_css | took 1118330ms 00:45:00 INFO - TEST-START | kraken 00:45:00 INFO - operating with platform_type : mac_ 00:45:00 INFO - Initialising browser for kraken test... 00:45:00 INFO - TEST-INFO | started process 7176 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmponQXDW/profile http://localhost:51675/getInfo.html) 00:45:02 INFO - PROCESS | 7176 | __metrics Screen width/height:1600/1200 00:45:02 INFO - PROCESS | 7176 | colorDepth:24 00:45:02 INFO - PROCESS | 7176 | Browser inner width/height: 1024/689 00:45:02 INFO - PROCESS | 7176 | __metrics 00:45:03 INFO - PROCESS | 7176 | 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" 00:45:03 INFO - PROCESS | 7176 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:45:03 INFO - TEST-INFO | 7176: exit 0 00:45:03 INFO - Browser initialized. 00:45:03 INFO - Running cycle 1/1 for kraken test... 00:45:03 INFO - TEST-INFO | started process 7177 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmponQXDW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:45:15 INFO - PROCESS | 7177 | RSS: Main: 235700224 00:45:15 INFO - PROCESS | 7177 | 00:45:18 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51675/tests/kraken/driver.html?testName=audio-beat-detection) 00:45:19 INFO - PROCESS | 7177 | RSS: Main: 287899648 00:45:19 INFO - PROCESS | 7177 | 00:45:22 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51675/tests/kraken/driver.html?testName=audio-dft) 00:45:22 INFO - PROCESS | 7177 | RSS: Main: 288075776 00:45:22 INFO - PROCESS | 7177 | 00:45:26 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51675/tests/kraken/driver.html?testName=audio-fft) 00:45:26 INFO - PROCESS | 7177 | RSS: Main: 378867712 00:45:26 INFO - PROCESS | 7177 | 00:45:28 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51675/tests/kraken/driver.html?testName=audio-oscillator) 00:45:29 INFO - PROCESS | 7177 | RSS: Main: 284000256 00:45:29 INFO - PROCESS | 7177 | 00:45:31 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:45:31 INFO - PROCESS | 7177 | RSS: Main: 287383552 00:45:31 INFO - PROCESS | 7177 | 00:45:34 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51675/tests/kraken/driver.html?testName=imaging-darkroom) 00:45:35 INFO - PROCESS | 7177 | RSS: Main: 329875456 00:45:35 INFO - PROCESS | 7177 | 00:45:38 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51675/tests/kraken/driver.html?testName=imaging-desaturate) 00:45:38 INFO - PROCESS | 7177 | RSS: Main: 331542528 00:45:38 INFO - PROCESS | 7177 | 00:45:41 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51675/tests/kraken/driver.html?testName=json-parse-financial) 00:45:42 INFO - PROCESS | 7177 | RSS: Main: 330530816 00:45:42 INFO - PROCESS | 7177 | 00:45:44 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:45:44 INFO - PROCESS | 7177 | RSS: Main: 304656384 00:45:44 INFO - PROCESS | 7177 | 00:45:46 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51675/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:45:47 INFO - PROCESS | 7177 | RSS: Main: 309436416 00:45:47 INFO - PROCESS | 7177 | 00:45:49 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:45:50 INFO - PROCESS | 7177 | RSS: Main: 311771136 00:45:50 INFO - PROCESS | 7177 | 00:45:53 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:45:54 INFO - PROCESS | 7177 | RSS: Main: 321228800 00:45:54 INFO - PROCESS | 7177 | 00:45:56 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:45:57 INFO - PROCESS | 7177 | RSS: Main: 319537152 00:45:57 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | Cycle 1(1): loaded http://localhost:51675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51675/tests/kraken/driver.html?testName=ai-astar) 00:45:59 INFO - PROCESS | 7177 | RSS: Main: 363823104 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | __start_tp_report 00:45:59 INFO - PROCESS | 7177 | _x_x_mozilla_page_load 00:45:59 INFO - PROCESS | 7177 | _x_x_mozilla_page_load_details 00:45:59 INFO - PROCESS | 7177 | |i|pagename|runs| 00:45:59 INFO - PROCESS | 7177 | |0;ai-astar;114;114;115;114;114;115;114;115;115;114 00:45:59 INFO - PROCESS | 7177 | |1;audio-beat-detection;137;109;118;146;111;109;109;107;151;109 00:45:59 INFO - PROCESS | 7177 | |2;audio-dft;186;184;183;182;183;180;184;183;184;185 00:45:59 INFO - PROCESS | 7177 | |3;audio-fft;80;58;59;90;61;61;60;58;73;58 00:45:59 INFO - PROCESS | 7177 | |4;audio-oscillator;88;70;86;70;69;93;115;99;68;83 00:45:59 INFO - PROCESS | 7177 | |5;imaging-gaussian-blur;87;85;86;84;86;84;86;84;86;83 00:45:59 INFO - PROCESS | 7177 | |6;imaging-darkroom;140;106;94;93;102;93;93;92;93;94 00:45:59 INFO - PROCESS | 7177 | |7;imaging-desaturate;134;130;123;86;95;86;87;88;85;87 00:45:59 INFO - PROCESS | 7177 | |8;json-parse-financial;57;57;54;55;54;55;55;57;56;54 00:45:59 INFO - PROCESS | 7177 | |9;json-stringify-tinderbox;65;73;67;68;79;72;72;71;72;74 00:45:59 INFO - PROCESS | 7177 | |10;stanford-crypto-aes;88;87;89;88;98;107;106;89;100;110 00:45:59 INFO - PROCESS | 7177 | |11;stanford-crypto-ccm;146;151;155;140;139;151;150;151;228;131 00:45:59 INFO - PROCESS | 7177 | |12;stanford-crypto-pbkdf2;172;172;173;173;173;172;173;173;175;176 00:45:59 INFO - PROCESS | 7177 | |13;stanford-crypto-sha256-iterative;67;67;68;67;68;66;68;68;68;66 00:45:59 INFO - PROCESS | 7177 | __end_tp_report 00:45:59 INFO - PROCESS | 7177 | __start_cc_report 00:45:59 INFO - PROCESS | 7177 | _x_x_mozilla_cycle_collect,1979 00:45:59 INFO - PROCESS | 7177 | __end_cc_report 00:45:59 INFO - PROCESS | 7177 | __startTimestamp1484642759583__endTimestamp 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | ------- Summary: start ------- 00:45:59 INFO - PROCESS | 7177 | Number of tests: 14 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 00:45:59 INFO - PROCESS | 7177 | Values: 114.0 114.0 115.0 114.0 114.0 115.0 114.0 115.0 115.0 114.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:114.50 stddev:17.19 (15.0%) stddev-sans-first:17.18 00:45:59 INFO - PROCESS | 7177 | Values: 137.0 109.0 118.0 146.0 111.0 109.0 109.0 107.0 151.0 109.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.65 (0.9%) stddev-sans-first:1.45 00:45:59 INFO - PROCESS | 7177 | Values: 186.0 184.0 183.0 182.0 183.0 180.0 184.0 183.0 184.0 185.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#3] audio-fft Cycles:10 Average:65.80 Median:61.00 stddev:11.29 (18.5%) stddev-sans-first:10.74 00:45:59 INFO - PROCESS | 7177 | Values: 80.0 58.0 59.0 90.0 61.0 61.0 60.0 58.0 73.0 58.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:84.50 stddev:15.50 (18.3%) stddev-sans-first:16.37 00:45:59 INFO - PROCESS | 7177 | Values: 88.0 70.0 86.0 70.0 69.0 93.0 115.0 99.0 68.0 83.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.29 (1.5%) stddev-sans-first:1.17 00:45:59 INFO - PROCESS | 7177 | Values: 87.0 85.0 86.0 84.0 86.0 84.0 86.0 84.0 86.0 83.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:93.00 stddev:14.80 (15.9%) stddev-sans-first:4.93 00:45:59 INFO - PROCESS | 7177 | Values: 140.0 106.0 94.0 93.0 102.0 93.0 93.0 92.0 93.0 94.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#7] imaging-desaturate Cycles:10 Average:100.10 Median:86.50 stddev:20.30 (23.5%) stddev-sans-first:17.44 00:45:59 INFO - PROCESS | 7177 | Values: 134.0 130.0 123.0 86.0 95.0 86.0 87.0 88.0 85.0 87.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.26 (2.3%) stddev-sans-first:1.20 00:45:59 INFO - PROCESS | 7177 | Values: 57.0 57.0 54.0 55.0 54.0 55.0 55.0 57.0 56.0 54.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:3.95 (5.5%) stddev-sans-first:3.46 00:45:59 INFO - PROCESS | 7177 | Values: 65.0 73.0 67.0 68.0 79.0 72.0 72.0 71.0 72.0 74.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:88.00 stddev:9.09 (10.3%) stddev-sans-first:9.14 00:45:59 INFO - PROCESS | 7177 | Values: 88.0 87.0 89.0 88.0 98.0 107.0 106.0 89.0 100.0 110.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:151.00 stddev:26.94 (17.8%) stddev-sans-first:28.41 00:45:59 INFO - PROCESS | 7177 | Values: 146.0 151.0 155.0 140.0 139.0 151.0 150.0 151.0 228.0 131.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.00 stddev:1.32 (0.8%) stddev-sans-first:1.32 00:45:59 INFO - PROCESS | 7177 | Values: 172.0 172.0 173.0 173.0 173.0 172.0 173.0 173.0 175.0 176.0 00:45:59 INFO - PROCESS | 7177 | 00:45:59 INFO - PROCESS | 7177 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 00:45:59 INFO - PROCESS | 7177 | Values: 67.0 67.0 68.0 67.0 68.0 66.0 68.0 68.0 68.0 66.0 00:45:59 INFO - PROCESS | 7177 | -------- Summary: end -------- 00:45:59 INFO - PROCESS | 7177 | 00:46:00 INFO - TEST-INFO | 7177: exit 0 00:46:00 INFO - TEST-OK | kraken | took 59888ms 00:46:00 INFO - SUITE-END | took 1178s 00:46:00 INFO - Completed test suite (00:19:38) 00:46:00 INFO - javascript benchmark 00:46:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.1400121967067, 3251.642319344873, 3257.2671148991494, 3267.8366081695917, 3315.568976033115, 5460.781568737256, 5520.420355862631, 5592.972035139829, 5625.6905870177125, 5630.40880707526, 5364.222187782769, 5400.702961337125, 5417.864553386167, 5461.317335333083, 5570.777168913239, 4256.787160641971, 5067.923981140286, 5086.262491938666, 5111.152103140384, 5173.741312934357, 5144.948550514503, 5228.764705588239, 5233.21501774733, 5282.31329927109, 5299.019681358942, 5070.0, 5210.635255532115, 5216.869578260555, 5217.217417387385, 5224.0, 5076.82231121909, 5091.567216786578, 5147.433782283946, 5149.021685879671, 5153.252778347119, 5082.949170508285, 5159.174532074888, 5165.560927321182, 5171.974140129275, 5194.740262986836, 5615.466530679579, 5629.127485239795, 5629.4652008059165, 5650.971745141289, 5691.231683722686, 6011.729472173763, 6059.969805133138, 6063.969680151571, 6156.26124865019, 6156.938430615726, 5085.23721441783, 6146.815595532141, 6196.845078873064, 6211.47202487789, 6233.252009758858, 5747.109198074221, 5752.568557358131, 5754.395788442195, 5774.307083150049, 5794.188813566104, 6141.700809433414, 6208.50331973441, 6209.937900620936, 6250.062490626442, 6263.31103578606, 5956.612820166675, 6020.969895150583, 6045.879082418327, 6054.727537260834, 6118.20463339763, 6042.577019608673, 6151.784687535915, 6158.451406904827, 6183.628982260989, 6192.504599632019, 5989.251343582052, 6058.909116363258, 6063.242094738158, 6064.0, 6080.635161890301, 6023.819285421444, 6140.17107690456, 6148.661823599656, 6150.292716337678, 6159.630422174684, 4879.39007624047, 4911.533404326583, 4916.5575098240615, 4916.606671466274, 4934.432540257844, 3487.849009826751, 4343.739375637409, 4377.233984052778, 4380.737155770664, 4398.362237475612, 5792.1311803229855, 5794.536437085023, 5798.797042103506, 5801.680907550125, 5806.187133801272, 6100.755969761249, 6110.072772100023, 6112.564273424362, 6216.191895053614, 6217.4715149212825, 5713.200151978726, 5778.7688492460675, 5804.738786754606, 5814.069748840166, 5847.853803654943, 5404.83785486436, 5407.540359069444, 5407.729613519387, 5410.404855465896, 5423.891522169534, 6154.01535754295, 6210.596311239755, 6287.497000239879, 6314.0, 6338.01760727088, 6106.005662908024, 6123.984276525883, 6130.734471166674, 6193.071039343954, 6250.874982500415, 6309.873802524015, 6310.0, 6326.588771729823, 6331.715072821642, 6332.588381755171, 6004.789832356021, 6074.635521868702, 6117.143599896107, 6123.7550497981365, 6185.659788711664, 6053.485453736482, 6108.554560543837, 6117.174181485442, 6127.8615298716295, 6136.29432615255, 5876.823695289148, 5878.470937615635, 6064.787732429344, 6075.027995520695, 6114.388561144028, 5821.388754180919, 5870.970645146747, 5925.140854576149, 5940.702964851826, 5967.31375891778, 5805.187273781758, 5876.1773351731645, 5880.0, 5960.284765828128, 5969.940300596939, 4614.238650622609, 5390.760125171154, 5892.175095486721, 5953.613015154001, 5961.791337303173, 5859.912101318569, 5870.882582348244, 5878.118282257525, 5891.823245302648, 5910.674912879661], "value": 5605.735226134836, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.99192671170647, 494.17719497037433, 496.34730329616553, 504.3418339067518, 506.2229477751652, 31310.21724456887, 34834.303313933706, 35895.0, 36048.27903441936, 36095.0, 35392.646073539254, 44393.0, 44399.112017759624, 44426.55573444265, 44472.99999999992, 9103.135202155785, 9319.813603727955, 9322.953385233064, 9323.580438880266, 9342.205912497411, 8316.251537361637, 8558.315334773204, 11095.72260693481, 11350.60272890449, 11370.488328025218, 11061.838506956774, 11312.943435282812, 11380.374079425628, 11391.772164556704, 11395.430228488583, 8354.8329033419, 9689.51552422383, 9777.608895644165, 11383.601573944956, 11386.373749443777, 8432.747017589481, 10884.836727449094, 11244.020334611252, 11245.100391968705, 11358.659240222807, 42062.36906446406, 42386.576134238574, 42409.78795106005, 42461.0, 42497.57502424967, 4028.47629808126, 4032.6169013943627, 4038.757674539537, 4050.858219962287, 4067.7559346439307, 30094.0, 30531.9502527546, 30598.082057538308, 31253.062408127793, 31531.84234078838, 3134.8275844828527, 3172.936541269185, 3177.9841100794347, 3198.648148703641, 3299.8185099819502, 471899.0, 476351.0, 478869.0, 479300.0, 479445.0, 64216.67891660512, 64505.67747161328, 64720.67639661772, 64852.02721959174, 64899.67550162219, 68492.3150768486, 68514.65742671255, 68518.0, 68576.0, 68625.0, 15771.29029193666, 16206.75689864653, 16285.348586056425, 16324.0, 16326.75509867353, 11330.37682927447, 11527.481263343001, 12500.812487812509, 12583.056270779545, 12613.810792838114, 16490.34038638465, 18419.26322947067, 18790.95994361219, 18920.824105228075, 19209.0, 6098.939010609837, 6239.656818874914, 7321.71679567459, 7336.963315183497, 7360.926390736131, 832.4381042796089, 866.4194989357146, 869.5087275689342, 897.6588896219395, 914.2777206007313, 23423.648645269994, 28343.71656283452, 29563.0, 29605.85197074001, 30433.0, 1064.1593141418348, 1071.2501249125644, 1072.9946350268199, 1116.1573012375604, 1125.0999200639455, 15366.923165384325, 15575.065496070272, 15757.0, 15858.89083108208, 16008.0, 612202.0, 615492.9225353844, 616676.0, 616721.0, 617842.0, 60426.0, 60667.39332606617, 60688.089678654855, 60728.392716072274, 60753.39246607477, 1420.786881967713, 1441.1929319581068, 1469.258024697521, 1474.4176050459794, 1475.1001888847795, 24634.753652463245, 28723.856380717963, 29490.11529654114, 29721.405571888874, 30132.69867301299, 49346.753266234875, 53111.73444132755, 53121.0, 53145.202821958475, 53204.0, 568737.0, 573599.0, 573953.0, 574962.0, 575383.0, 22577.322680319616, 23023.424414389774, 24312.635310470003, 24797.25608231756, 24980.875095624404, 40530.39204411877, 42088.36867447052, 42857.35713964231, 43173.0, 43489.78255108704, 34347.656523434445, 35226.47160292546, 35235.47146792749, 36101.277974439836, 36183.0, 34955.60177592868, 35008.12479688028, 35571.82214088913, 35854.82072589621, 36281.548738051235, 34097.659023410444, 34478.13787284789, 35242.942711718686, 35379.82310088433, 35539.28921421505, 30379.848100759355, 31437.842810785798, 31584.472192507434, 31720.682793172695, 32217.838910805294, 19315.51711207231, 20739.368957655144, 22729.77845319499, 23307.53384932258, 23450.0], "value": 19774.2754056839, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.9968900310996, 337.308517539045, 390.4923599320884, 397.21153510282096, 426.413681188366, 19900.800991990094, 20024.799752002476, 20693.586128277424, 20881.477963050933, 21061.052252648627, 12261.693457663563, 12290.877091229086, 17452.1273936303, 20734.688979665316, 21466.463338416546, 5372.2210279509445, 5594.888102237953, 5596.048671725816, 5597.6641401515835, 5614.27014488118, 5696.202531645573, 5991.101334799793, 6054.666993315366, 6072.6356418614805, 6077.058056001327, 5854.238948936632, 6024.638521688691, 6071.332153463116, 6071.696415179245, 6072.544559158058, 6065.059915713072, 6065.423784740465, 6094.969525152368, 6096.603720758181, 6106.2977757558, 5749.281339832521, 5788.04497257952, 5934.465898069151, 5941.3761555036535, 5948.167256584082, 13544.255065971367, 13578.388972496261, 13641.045126841125, 13766.518171864036, 13769.03616746828, 2560.129555950986, 2598.628170679017, 2650.2446802661343, 2713.9185824425103, 2725.3731641722316, 9748.073932976356, 10347.482625868677, 10581.206409519316, 10587.78824423515, 10695.732606684818, 1799.8200179981898, 1811.4022372617005, 1836.7255513909752, 1864.5618279704258, 1890.5179179309325, 131736.0, 135393.64606353908, 136251.31874340665, 138161.9275710865, 138970.3051484746, 8686.348523860735, 9123.406978546373, 9702.611895524242, 11626.651200463999, 11651.53393864253, 15106.39574417033, 15328.23358832054, 15338.616534586725, 15354.769678454832, 15387.61530961735, 8329.6668133274, 8614.0, 8642.956785216034, 8774.078721734253, 8810.339224558056, 8447.915520844714, 8465.619047142893, 8468.915310846813, 8644.22202001823, 8671.783205419788, 4563.520830312836, 4635.930461043087, 4649.837255696102, 4691.812327506861, 4728.361671174416, 1523.6724104317625, 1665.7251553493538, 1993.6212119697211, 2003.1586733571935, 2010.115549158395, 835.4444294544181, 971.4705485510273, 974.5760594141572, 1009.6920439265947, 1036.7304500829687, 19152.61694766097, 20272.49318767013, 20824.0, 21808.781912180675, 21902.561948760937, 875.7898104455012, 974.9860145448796, 1022.0648106982177, 1050.1808589300358, 1056.5773690523852, 11055.447227638586, 11286.887131128748, 11347.943260283646, 11350.14873884462, 11368.602098926498, 701890.0, 705620.0, 710916.7904086321, 725020.0, 732299.0, 149278.0, 150803.0, 151182.0, 151445.48554514314, 151927.0, 978.2272005116021, 1021.3361315145066, 1048.8217003109337, 1052.6736711619421, 1053.1364281289423, 18786.436406907815, 18872.622547549247, 19059.809401905804, 19064.0, 19226.51933701613, 58925.41074589199, 59391.406085938586, 59692.0, 60670.0, 61540.0, 86451.13548864432, 88061.55969220113, 88788.0, 89699.55150224207, 90219.54890225508, 8150.551719655476, 8190.672373105247, 8460.377283042277, 8657.82684346297, 8727.781805454915, 11506.539738410369, 12070.879291206975, 12391.442385092872, 12597.93701031489, 13410.32948352559, 11068.667939961813, 11274.549018039515, 11520.193586449202, 11745.412729363326, 11791.410429478663, 10789.460526973777, 11226.158038147334, 11420.942895285803, 11441.656750297505, 11569.074474041889, 11485.253458525169, 11598.0, 12023.338716370334, 12050.156489045683, 12079.39603019863, 8645.438046526955, 12384.690382740144, 12437.564685235973, 12589.559365422167, 12966.546170883974, 11434.771304573696, 11714.121440892137, 11781.646550603497, 12059.879401205875, 12201.572944946884], "value": 9802.125039753068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.9269090200048, 1443.2855736410477, 1449.7390469715451, 1452.2738630684657, 1469.8456662050492, 7380.372668323193, 7615.276548727876, 7747.1090824555195, 7924.762257132295, 7939.206079392058, 7863.80340491488, 7879.290863822255, 7944.96027519863, 7950.36397088233, 7952.721654742085, 2040.5102775333962, 2268.727752669682, 2308.9422764430856, 2309.6650985607075, 2311.3297143828268, 2126.3302059851176, 2272.6704627828954, 2343.2267351773876, 2356.6229403295474, 2363.1374548289923, 2305.9538809223804, 2323.3494621506006, 2325.6860323856317, 2328.7321957974796, 2331.591971405006, 2025.463252238158, 2107.3677896630948, 2253.3915842722454, 2309.145616122029, 2311.445253139243, 2118.8834614096218, 2255.729312482513, 2323.674685544025, 2340.6957095577636, 2344.2381226101584, 8232.464889782144, 8307.46001509906, 8309.875351869727, 8310.70912518065, 8347.833043339098, 4966.056449274626, 5128.1282182029145, 5132.871678208037, 5138.486151384869, 5140.126178549655, 3315.4032274190636, 3466.9653303466894, 3474.6004209515977, 3516.841742121585, 3528.6118526962014, 1146.4611632532697, 1207.4626791077974, 1224.5729649674784, 1252.2173641474078, 1255.8995280377549, 10454.738631534197, 10466.895331046744, 10625.362478251329, 10633.361998280128, 10644.361338319726, 4405.383246345515, 4548.272276435754, 4626.7223966562115, 4648.047150334173, 4653.115907977473, 9140.954295228481, 9192.402493837879, 9233.0, 9275.953620231856, 9385.483798391155, 5151.716655583904, 5153.484651534816, 5154.278401023859, 5159.509846564571, 5177.3269474968765, 4500.9099818004115, 4600.6549508786975, 4639.559241872017, 4705.623550115983, 4705.64707646921, 3723.795191264452, 3762.6049264826797, 3786.1670432504807, 3833.8274777635074, 3846.7114966377635, 1124.3141683573015, 1248.4631608408472, 1253.4735411127167, 1271.586734311334, 1271.7011502296953, 758.211460081509, 759.1573353577525, 782.9352081169604, 785.7485604606585, 805.7059173401666, 5091.974540127276, 5337.519623233928, 5482.890342193134, 5487.122060470306, 5603.439656034364, 493.5410068636131, 562.1483452569361, 576.9423057694197, 590.1943846649293, 592.3277080513648, 3651.7626354286886, 3654.8538058477893, 3728.925421491555, 3803.391457366808, 3813.580506144322, 9369.437833729999, 9713.174380177623, 9781.266405019653, 9784.608615655436, 9804.607815687436, 9690.51547422626, 9730.17293530058, 9738.805223895482, 9757.12185903272, 9813.362131461432, 7283.3809126223805, 7553.924460755322, 7626.961865190749, 7632.694692212361, 7713.0, 5571.470710282517, 5677.403872593483, 5685.8862822742485, 5738.99567575681, 5753.539716822728, 8490.533020683923, 8875.73372798817, 8894.822103558023, 9007.639694412412, 9030.864537031819, 8805.339599529932, 9098.772530686521, 9221.400608960395, 9327.067293270618, 9375.531223438937, 6992.16094068715, 7106.182788979127, 7170.928290717026, 7175.354218120394, 7179.497435179487, 7448.217937116741, 7787.766367008999, 7803.7268695595385, 7873.724419645285, 7884.093329267208, 6984.895226571504, 7028.226895041644, 7056.223815380406, 7065.929340706527, 7185.0, 6900.723971041102, 6906.482013848881, 6907.516473846783, 6946.235914049552, 6964.4080253179045, 6262.655553944577, 6295.811125666238, 6300.905486417616, 6352.809415717536, 6396.0, 4552.044070745181, 4591.724496530219, 4932.2601609757385, 4973.179425394769, 4992.326035985096, 3935.6654684351006, 4850.659127159594, 4945.925811112764, 5062.1141300271565, 5152.252923326172], "value": 4279.477751088696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.08998872896655, 358.3334996905755, 365.5595008015341, 373.6599694278207, 374.8425661222288, 4815.9277610835825, 4969.47820478849, 5141.948580514194, 5274.789008439662, 5309.840704778858, 4887.462379138292, 5089.720065396402, 5096.184610462317, 5199.452268388491, 5216.452272511388, 3599.6580324869096, 3659.451082337651, 4119.402686610455, 4133.6693064554765, 4138.461999940018, 3134.4484480182227, 4102.466679331683, 4103.917921641565, 4107.137501124767, 4141.109661422794, 3454.533637958881, 3540.6459354064646, 3919.568847426781, 3989.9027767364064, 3991.4611527443712, 3910.452536644872, 3913.6086391360923, 3921.2353591049755, 3930.8034598269974, 3972.086420123359, 3172.74618030557, 3435.553378060836, 3443.741719371057, 3454.3746752468055, 3455.3434847378917, 4837.467878533358, 5094.847154585332, 5108.0, 5110.795568177268, 5111.821086261963, 3705.980855264797, 4167.9577007266225, 4479.992001799602, 4480.395146655225, 4539.750313732743, 5449.711121329051, 5463.453654634544, 5479.863003424906, 5494.80768173112, 5499.680076781584, 3114.7073964304786, 3735.2529494101286, 3758.32350176968, 3804.2581696568905, 3848.2111167210933, 4715.811367545294, 5740.339860916007, 5839.0949402842625, 5843.357230704619, 5875.265591801025, 3842.884713458601, 3856.016715737525, 3857.864974725871, 3894.9610503894596, 3897.3569361055106, 3039.498482750366, 3919.6864250859862, 3923.372260438316, 3924.920646822147, 3944.7435916665327, 4428.889277768081, 4693.859184224479, 4772.76136193189, 4781.928271075936, 4784.105616102208, 4712.670113092119, 5567.693776842231, 5628.875973834479, 5641.617803638135, 5657.490825825613, 1162.91859569831, 1221.84116064911, 1309.43039777697, 1328.4420543371807, 1356.7693492106366, 848.7326492154951, 956.9186619137452, 987.4963768478128, 987.918229538654, 993.8310487217191, 4658.114958157939, 4691.179043667345, 4751.786169622375, 4947.381577302837, 5006.249062640633, 5038.193888977746, 5115.462876397924, 5140.511651393112, 5182.890265840466, 5368.91946620801, 4337.652987761035, 4963.950360496348, 4981.726005069683, 4995.000999800054, 4995.151793836304, 2545.0074470956342, 2758.634475934425, 2758.7103354147926, 2847.8860845565946, 2863.096041132665, 4872.634552408513, 5134.922976155361, 5165.236598419828, 5361.498780341511, 5550.333959924835, 4498.662600304925, 4681.6020638245445, 4735.697683137165, 5028.823991160365, 5574.832755017356, 4632.351470794024, 5284.9471505284455, 5620.97189514058, 5628.789810190747, 5666.744996475169, 4868.225111686304, 5386.703731294817, 5403.891922161456, 5436.646617969977, 5438.190131986207, 4885.413750349839, 4942.8764280893265, 4975.452700203047, 5232.450592687713, 5406.998820872447, 5225.399079105951, 5333.320014184881, 5607.607467477237, 5608.7195640217005, 5618.134751276796, 3321.355928815252, 3725.850965961331, 3872.6514613684903, 3913.1977944520736, 3950.9209815804097, 4500.909981800281, 5120.692758434506, 5221.120396657277, 5277.604179686462, 5416.079266524779, 4099.774512401727, 4196.412502249626, 4573.656975726767, 5203.777112378512, 5344.812931547377, 4795.808167673254, 5349.732513374393, 5427.1045277528765, 5437.3747019091725, 5514.476124768141, 5336.706481143575, 5439.972800135974, 5468.371137319259, 5468.781248750005, 5489.945100549103, 4344.301995710009, 5526.253955715927, 5575.470330318613, 5594.0, 5632.718364081861, 5136.178211486144, 5321.574274057989, 5357.303550538405, 5454.699991500505, 5472.562195024469], "value": 3982.6745983586557, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.3731079339385, 711.0152438872167, 775.9679626097292, 812.1188510466144, 819.1849110135416, 12303.585087714904, 14084.29578521075, 14609.780853287182, 14864.851351486483, 14941.252937353129, 14605.977581569294, 15320.846791532082, 15914.0, 16060.759088613651, 16418.26117824698, 832.6169961817541, 846.1749793950895, 847.0682249525535, 867.1805144138791, 871.376965469689, 679.7926632377123, 689.035350509286, 736.466062104975, 864.5288317866778, 866.4801119328384, 913.5067063785548, 921.8110287391103, 932.6502561539422, 932.7994481186544, 934.5700977550335, 887.0154128916929, 887.0375642427973, 887.0419946457843, 903.814717982812, 923.8614207868807, 532.3425569421761, 547.1491830204031, 549.950504454597, 693.7571849852511, 695.0339028750042, 12411.255324680547, 12477.50089996399, 13459.855912247373, 14297.78553321701, 14317.642058948506, 13980.860191398058, 14141.434342626282, 14187.88551320116, 14211.147331160164, 14235.430582776677, 11823.763524729544, 11947.701307467296, 12076.577319793852, 12175.45210465531, 12209.511619535208, 3083.8766449342, 3625.2024554597947, 3709.332320182366, 3863.806809659534, 3870.438786375988, 104533.0, 106108.0, 107234.0, 108038.91961080367, 108176.0, 10086.697399078039, 10752.516136773864, 10901.073408760185, 10945.671629850958, 11320.886791132149, 22125.557488850456, 22194.334169974925, 22263.666045009337, 22412.775872241396, 22581.548369032527, 7737.806554836062, 7740.729074482366, 7746.612669366509, 7760.844783104306, 7974.52152870818, 4032.737872038308, 4295.763732994716, 4344.478662560513, 4380.452443444569, 4457.2199865023495, 3477.826108694555, 3582.749207555446, 3584.193556449778, 3753.2681127180485, 3955.406688996616, 702.220535205921, 703.4513079797766, 705.8023753349071, 725.1986554856912, 726.5241266970143, 639.2989618860278, 677.695037233247, 688.9655517224119, 702.6732569355274, 745.1015549512401, 7608.391328693802, 10304.381737095799, 10541.156707463384, 10586.947065264778, 10662.0, 694.7151667816272, 707.8053535277737, 722.458156382713, 728.6720975561019, 736.1681300130817, 4682.906341873144, 5078.695278283315, 5090.541851233407, 5101.0, 5111.591072714174, 83473.58263208646, 97789.51105244429, 102965.48517257365, 106132.0, 112355.0, 51816.74091629518, 77467.0, 83478.0, 85639.0, 89658.0, 58492.12261816076, 67894.0, 69165.27086822769, 77699.61150194213, 79248.603756982, 10204.0, 10336.741581460223, 10862.565497380016, 11047.337159770439, 11163.720906977065, 45423.0, 45940.0, 49449.0, 51566.74216629043, 51666.483335166165, 65286.673566631864, 66195.0, 67174.64126793543, 67878.66060669665, 68034.0, 13211.66970825737, 13241.106719367528, 13494.865051349754, 13680.0, 14039.298035098, 14771.409143634135, 14931.552053438414, 15045.548633541011, 15162.620934476285, 15513.34599620087, 13704.725905481635, 14019.439222430989, 14115.2942352884, 14138.858611413754, 14303.856961430252, 13388.0, 13489.662758430724, 13569.0, 13836.239006854317, 13894.23581703016, 13241.867581324064, 13486.86513134856, 13638.113522620997, 13656.726865462437, 14228.0, 10844.566217351217, 11367.772644547229, 11398.886011139783, 11508.194426390073, 11695.532178712756, 10861.0, 10951.54919513282, 11080.833787493355, 11120.332780033224, 11167.218294719616], "value": 7511.54437659269, "unit": "score"}], "name": "dromaeo_css", "value": 7198.351535333923, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 109.0, 118.0, 146.0, 111.0, 109.0, 109.0, 107.0, 151.0, 109.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 183.0, 182.0, 183.0, 180.0, 184.0, 183.0, 184.0, 185.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 90.0, 61.0, 61.0, 60.0, 58.0, 73.0, 58.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 86.0, 70.0, 69.0, 93.0, 115.0, 99.0, 68.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 86.0, 84.0, 86.0, 84.0, 86.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 106.0, 94.0, 93.0, 102.0, 93.0, 93.0, 92.0, 93.0, 94.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 130.0, 123.0, 86.0, 95.0, 86.0, 87.0, 88.0, 85.0, 87.0], "value": 100.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 54.0, 55.0, 54.0, 55.0, 55.0, 57.0, 56.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 67.0, 68.0, 79.0, 72.0, 72.0, 71.0, 72.0, 74.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 88.0, 98.0, 107.0, 106.0, 89.0, 100.0, 110.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 151.0, 155.0, 140.0, 139.0, 151.0, 150.0, 151.0, 228.0, 131.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 173.0, 173.0, 173.0, 172.0, 173.0, 173.0, 175.0, 176.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 66.0, 68.0, 68.0, 68.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1471.1, "alertThreshold": 2.0}]} 00:46:00 INFO - Return code: 0 00:46:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:46:00 ERROR - # TBPL SUCCESS # 00:46:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:46:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:46:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:46:00 INFO - 2017-01-17 00:46:00.927 screenresolution[7181:137096] starting screenresolution argv=screenresolution get 00:46:00 INFO - 2017-01-17 00:46:00.929 screenresolution[7181:137096] Display 0: 1600x1200x32@60 00:46:00 INFO - 2017-01-17 00:46:00.935 screenresolution[7182:137099] starting screenresolution argv=screenresolution list 00:46:00 INFO - Available Modes on Display 0 00:46:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:46:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:46:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:46:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:46:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:46:01 INFO - Intel Iris: 00:46:01 INFO - Chipset Model: Intel Iris 00:46:01 INFO - Type: GPU 00:46:01 INFO - Bus: Built-In 00:46:01 INFO - VRAM (Dynamic, Max): 1536 MB 00:46:01 INFO - Vendor: Intel (0x8086) 00:46:01 INFO - Device ID: 0x0a2e 00:46:01 INFO - Revision ID: 0x0009 00:46:01 INFO - Displays: 00:46:01 INFO - Display: 00:46:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:46:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:46:01 INFO - Display Serial Number: 1600x1200 60 00:46:01 INFO - Main Display: Yes 00:46:01 INFO - Mirror: Off 00:46:01 INFO - Online: Yes 00:46:01 INFO - Rotation: Supported 00:46:01 INFO - Return code: 0 00:46:01 INFO - Running post-action listener: _resource_record_post_action 00:46:01 INFO - [mozharness: 2017-01-17 08:46:01.173666Z] Finished run-tests step (success) 00:46:01 INFO - Running post-run listener: _resource_record_post_run 00:46:01 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 237568; Write bytes: 552432128; Read time: 2; Write time: 1659 00:46:01 INFO - TinderboxPrint: CPU usage
53.7% 00:46:01 INFO - TinderboxPrint: I/O read bytes / time
237,568 / 2 00:46:01 INFO - TinderboxPrint: I/O write bytes / time
552,432,128 / 1,659 00:46:01 INFO - TinderboxPrint: CPU idle
2,224.4 (46.3%) 00:46:01 INFO - TinderboxPrint: CPU system
963.2 (20.0%) 00:46:01 INFO - TinderboxPrint: CPU user
1,618.1 (33.7%) 00:46:01 INFO - TinderboxPrint: Swap in / out
251,334,656 / 0 00:46:01 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249917952; Write bytes: 244250112; Read time: 18063; Write time: 514 00:46:01 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 200704; Write bytes: 295603200; Read time: 1; Write time: 1108 00:46:01 INFO - Running post-run listener: _upload_blobber_files 00:46:01 INFO - Blob upload gear active. 00:46:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:46:01 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 00:46:01 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'] 00:46:01 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 00:46:02 INFO - (blobuploader) - INFO - Open directory for files ... 00:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:02 INFO - (blobuploader) - INFO - Done attempting. 00:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:03 INFO - (blobuploader) - INFO - Done attempting. 00:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:04 INFO - (blobuploader) - INFO - Done attempting. 00:46:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:46:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:06 INFO - (blobuploader) - INFO - Done attempting. 00:46:06 INFO - (blobuploader) - INFO - Iteration through files over. 00:46:06 INFO - Return code: 0 00:46:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:46:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:46:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0b9858448fa697a270a712b69e6a7a6c330eab600dc9975e3ea1f0864672846518bb01d072a7c47f117a24a0e52c914b78103daed1b7e2364bf2822decea4607", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9e7c984359f7549d02146e7d4df81d71542c319f7123636d716e6d26b481b6f641a43d9a0cc7f0f3f68e2e50c98c403c5306d8a5b1d8c19bf6be8c1b119ccc42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/053cf0be4ae67467de1b720521b143214383e668388f2e1d6a8eeac5d36db0e68919b797060ec73270730386b2f1de98e4a9daa945f9e430598e4a3b47a08caa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d847d02b58c78b0785c07f083d9775a16799297865edc56619db3c39ab197c653a2c959fe27e11c64bb81809bb18e4452b6c220bc64eb7fc1cbb4833b9b6e209"} 00:46:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:46:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:46:06 INFO - Contents: 00:46:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0b9858448fa697a270a712b69e6a7a6c330eab600dc9975e3ea1f0864672846518bb01d072a7c47f117a24a0e52c914b78103daed1b7e2364bf2822decea4607", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9e7c984359f7549d02146e7d4df81d71542c319f7123636d716e6d26b481b6f641a43d9a0cc7f0f3f68e2e50c98c403c5306d8a5b1d8c19bf6be8c1b119ccc42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/053cf0be4ae67467de1b720521b143214383e668388f2e1d6a8eeac5d36db0e68919b797060ec73270730386b2f1de98e4a9daa945f9e430598e4a3b47a08caa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d847d02b58c78b0785c07f083d9775a16799297865edc56619db3c39ab197c653a2c959fe27e11c64bb81809bb18e4452b6c220bc64eb7fc1cbb4833b9b6e209"} 00:46:06 INFO - Running post-run listener: copy_logs_to_upload_dir 00:46:06 INFO - Copying logs to upload dir... 00:46:06 INFO - mkdir: /builds/slave/test/build/upload/logs 00:46:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.228146 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-17 00:46:06.918853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 00:46:06.922903) ========= 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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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/0b9858448fa697a270a712b69e6a7a6c330eab600dc9975e3ea1f0864672846518bb01d072a7c47f117a24a0e52c914b78103daed1b7e2364bf2822decea4607", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9e7c984359f7549d02146e7d4df81d71542c319f7123636d716e6d26b481b6f641a43d9a0cc7f0f3f68e2e50c98c403c5306d8a5b1d8c19bf6be8c1b119ccc42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/053cf0be4ae67467de1b720521b143214383e668388f2e1d6a8eeac5d36db0e68919b797060ec73270730386b2f1de98e4a9daa945f9e430598e4a3b47a08caa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d847d02b58c78b0785c07f083d9775a16799297865edc56619db3c39ab197c653a2c959fe27e11c64bb81809bb18e4452b6c220bc64eb7fc1cbb4833b9b6e209"} build_url:https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011657 build_url: 'https://queue.taskcluster.net/v1/task/PWQwX78RRyO3en7MGe3iQA/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/0b9858448fa697a270a712b69e6a7a6c330eab600dc9975e3ea1f0864672846518bb01d072a7c47f117a24a0e52c914b78103daed1b7e2364bf2822decea4607", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9e7c984359f7549d02146e7d4df81d71542c319f7123636d716e6d26b481b6f641a43d9a0cc7f0f3f68e2e50c98c403c5306d8a5b1d8c19bf6be8c1b119ccc42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/053cf0be4ae67467de1b720521b143214383e668388f2e1d6a8eeac5d36db0e68919b797060ec73270730386b2f1de98e4a9daa945f9e430598e4a3b47a08caa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d847d02b58c78b0785c07f083d9775a16799297865edc56619db3c39ab197c653a2c959fe27e11c64bb81809bb18e4452b6c220bc64eb7fc1cbb4833b9b6e209"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 00:46:06.958753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 00:46:06.959201) ========= 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.mf3yCBNUl3/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.Nd9JxU2sI7/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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.005498 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 00:46:07.008799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 00:46:07.009172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 00:46:07.009621) ========= ========= Total master_lag: 0.19 =========