builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0383 starttime: 1487076134.1 results: success (0) buildid: 20170214030231 builduid: 32724e61737248c0a7662001856ffdf3 revision: 195049fabb7ac5709e5f75614ba630ba3d1b5a9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:14.097047) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:14.097505) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:14.097778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:14.124235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:14.124617) ========= 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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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-02-14 04:42:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2017-02-14 04:42:14 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:14.236773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:14.237094) ========= 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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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.026041 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:14.285766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-14 04:42:14.286098) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 195049fabb7ac5709e5f75614ba630ba3d1b5a9b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 195049fabb7ac5709e5f75614ba630ba3d1b5a9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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-02-14 04:42:14,598 truncating revision to first 12 chars 2017-02-14 04:42:14,598 Setting DEBUG logging. 2017-02-14 04:42:14,598 attempt 1/10 2017-02-14 04:42:14,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/195049fabb7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 04:42:15,299 unpacking tar archive at: mozilla-central-195049fabb7a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.976659 ========= master_lag: 1.92 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-14 04:42:17.180805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:17.181150) ========= script_repo_revision: 195049fabb7ac5709e5f75614ba630ba3d1b5a9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:17.181583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:17.181848) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 04:42:17.214048) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-02-14 04:42:17.214501) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:42:17 INFO - MultiFileLogger online at 20170214 04:42:17 in /builds/slave/test 04:42:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:17 INFO - {'append_to_log': False, 04:42:17 INFO - 'base_work_dir': '/builds/slave/test', 04:42:17 INFO - 'blob_upload_branch': 'Firefox', 04:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:17 INFO - 'branch': 'Firefox', 04:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:17 INFO - 'config_files': ('talos/mac_config.py',), 04:42:17 INFO - 'default_actions': ('clobber', 04:42:17 INFO - 'read-buildbot-config', 04:42:17 INFO - 'download-and-extract', 04:42:17 INFO - 'populate-webroot', 04:42:17 INFO - 'create-virtualenv', 04:42:17 INFO - 'install', 04:42:17 INFO - 'run-tests'), 04:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:17 INFO - 'download_minidump_stackwalk': True, 04:42:17 INFO - 'download_symbols': 'ondemand', 04:42:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:17 INFO - 'installer_path': 'installer.exe', 04:42:17 INFO - 'log_level': 'info', 04:42:17 INFO - 'log_name': 'talos', 04:42:17 INFO - 'log_to_console': True, 04:42:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:17 INFO - 'opt_config_files': (), 04:42:17 INFO - 'pip_index': False, 04:42:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:17 INFO - 'cmd': ('bash', 04:42:17 INFO - '-c', 04:42:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:17 INFO - 'enabled': True, 04:42:17 INFO - 'halt_on_failure': False, 04:42:17 INFO - 'name': 'check_screen_resolution'},), 04:42:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:17 INFO - 'cmd': ('bash', 04:42:17 INFO - '-c', 04:42:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:17 INFO - 'enabled': True, 04:42:17 INFO - 'halt_on_failure': False, 04:42:17 INFO - 'name': 'check_screen_resolution'},), 04:42:17 INFO - 'run_cmd_checks_enabled': True, 04:42:17 INFO - 'sps_profile': False, 04:42:17 INFO - 'sps_profile_interval': 0, 04:42:17 INFO - 'suite': 'dromaeojs', 04:42:17 INFO - 'system_bits': '32', 04:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:17 INFO - 'title': 't-yosemite-r7-0383', 04:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:17 INFO - 'use_talos_json': True, 04:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:17 INFO - 'work_dir': 'build'} 04:42:17 INFO - [mozharness: 2017-02-14 12:42:17.634187Z] Running clobber step. 04:42:17 INFO - Running pre-action listener: _resource_record_pre_action 04:42:17 INFO - Running main action method: clobber 04:42:17 INFO - rmtree: /builds/slave/test/build 04:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:19 INFO - Running post-action listener: _resource_record_post_action 04:42:19 INFO - [mozharness: 2017-02-14 12:42:19.933785Z] Finished clobber step (success) 04:42:19 INFO - [mozharness: 2017-02-14 12:42:19.933945Z] Running read-buildbot-config step. 04:42:19 INFO - Running pre-action listener: _resource_record_pre_action 04:42:19 INFO - Running main action method: read_buildbot_config 04:42:19 INFO - Using buildbot properties: 04:42:19 INFO - { 04:42:19 INFO - "project": "", 04:42:19 INFO - "product": "firefox", 04:42:19 INFO - "script_repo_revision": "production", 04:42:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:42:19 INFO - "repository": "", 04:42:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:42:19 INFO - "buildid": "20170214030231", 04:42:19 INFO - "stage_platform": "macosx64", 04:42:19 INFO - "basedir": "/builds/slave/test", 04:42:19 INFO - "nightly_build": "True", 04:42:19 INFO - "buildnumber": 33, 04:42:19 INFO - "slavename": "t-yosemite-r7-0383", 04:42:19 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:42:19 INFO - "platform": "yosemite_r7", 04:42:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:42:19 INFO - "branch": "mozilla-central", 04:42:19 INFO - "repo_path": "mozilla-central", 04:42:19 INFO - "revision": "195049fabb7ac5709e5f75614ba630ba3d1b5a9b", 04:42:19 INFO - "pgo_build": "False", 04:42:19 INFO - "builduid": "32724e61737248c0a7662001856ffdf3", 04:42:19 INFO - "slavebuilddir": "test" 04:42:19 INFO - } 04:42:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:42:19 INFO - Running post-action listener: _resource_record_post_action 04:42:19 INFO - [mozharness: 2017-02-14 12:42:19.937517Z] Finished read-buildbot-config step (success) 04:42:19 INFO - [mozharness: 2017-02-14 12:42:19.937620Z] Running download-and-extract step. 04:42:19 INFO - Running pre-action listener: _resource_record_pre_action 04:42:19 INFO - Running main action method: download_and_extract 04:42:19 INFO - mkdir: /builds/slave/test/build/tests 04:42:19 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')]} 04:42:19 INFO - trying https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:42:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:42:20 INFO - Downloaded 1199 bytes. 04:42:20 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:42:20 INFO - Using the following test package requirements: 04:42:20 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:42:20 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:42:20 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:42:20 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:42:20 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:42:20 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:42:20 INFO - u'jsshell-mac.zip'], 04:42:20 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:42:20 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:42:20 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:42:20 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:42:20 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:42:20 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:42:20 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:42:20 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:42:20 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:42:20 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:42:20 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:42:20 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:42:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:42:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:42:22 INFO - Expected file size: 51502740 04:42:22 INFO - Obtained file size: 51502740 04:42:38 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:42:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:42:40 INFO - Expected file size: 51502740 04:42:40 INFO - Obtained file size: 51502740 04:42:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:42:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:42:57 INFO - Expected file size: 14403647 04:42:57 INFO - Obtained file size: 14403647 04:42:57 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')]} 04:42:57 INFO - trying https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:42:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:43:00 INFO - Downloaded 70447132 bytes. 04:43:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:43:00 INFO - mkdir: /builds/slave/test/properties 04:43:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:43:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:43:00 INFO - Contents: 04:43:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:43:00 INFO - Running post-action listener: _resource_record_post_action 04:43:00 INFO - Running post-action listener: set_extra_try_arguments 04:43:00 INFO - [mozharness: 2017-02-14 12:43:00.926941Z] Finished download-and-extract step (success) 04:43:00 INFO - [mozharness: 2017-02-14 12:43:00.927089Z] Running populate-webroot step. 04:43:00 INFO - Running pre-action listener: _resource_record_pre_action 04:43:00 INFO - Running main action method: populate_webroot 04:43:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:43:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:43:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:43:00 INFO - '--tppagecycles', 04:43:00 INFO - '7'], 04:43:00 INFO - 'tests': ['tsvgm']}}, 04:43:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:43:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:43:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:43:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:43:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['damp', 'tps']}, 04:43:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'tests': ['damp', 'tps']}, 04:43:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['dromaeo_dom']}, 04:43:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:43:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['basic_compositor_video']}, 04:43:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:43:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other-e10s': {'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['a11yr', 04:43:00 INFO - 'ts_paint', 04:43:00 INFO - 'tpaint', 04:43:00 INFO - 'sessionrestore', 04:43:00 INFO - 'sessionrestore_no_auto_restore', 04:43:00 INFO - 'tabpaint']}, 04:43:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['tsvgx', 04:43:00 INFO - 'tsvgr_opacity', 04:43:00 INFO - 'tart', 04:43:00 INFO - 'tscrollx', 04:43:00 INFO - 'cart', 04:43:00 INFO - 'tsvg_static']}, 04:43:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:43:00 INFO - 'tsvgr_opacity', 04:43:00 INFO - 'tart', 04:43:00 INFO - 'tscrollx', 04:43:00 INFO - 'cart', 04:43:00 INFO - 'tsvg_static']}, 04:43:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--disable-e10s'], 04:43:00 INFO - 'tests': ['tp5o']}, 04:43:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:43:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--disable-e10s', 04:43:00 INFO - '--xperf_path', 04:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:00 INFO - 'tests': ['tp5n']}, 04:43:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:43:00 INFO - 'talos_options': ['--xperf_path', 04:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:00 INFO - 'tests': ['tp5n']}}, 04:43:00 INFO - 'talos.zip': {'path': '', 04:43:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:43:00 INFO - Running post-action listener: _resource_record_post_action 04:43:00 INFO - [mozharness: 2017-02-14 12:43:00.945333Z] Finished populate-webroot step (success) 04:43:00 INFO - [mozharness: 2017-02-14 12:43:00.945447Z] Running create-virtualenv step. 04:43:00 INFO - Running pre-action listener: _resource_record_pre_action 04:43:00 INFO - Running main action method: create_virtualenv 04:43:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:43:00 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 04:43:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:43:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:43:01 INFO - Using real prefix '/tools/python27' 04:43:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:43:04 INFO - Installing pip.................done. 04:43:04 INFO - Return code: 0 04:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:43:04 INFO - Reading from file tmpfile_stdout 04:43:04 INFO - Output received: 04:43:04 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) 04:43:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:04 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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:04 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 04:43:04 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 04:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:04 INFO - 'HOME': '/Users/cltbld', 04:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:04 INFO - 'LOGNAME': 'cltbld', 04:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:04 INFO - 'MOZ_NO_REMOTE': '1', 04:43:04 INFO - 'NO_EM_RESTART': '1', 04:43:04 INFO - 'PAGER': '/bin/cat', 04:43:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:04 INFO - 'PWD': '/builds/slave/test', 04:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:04 INFO - 'SHELL': '/bin/bash', 04:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:04 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:04 INFO - 'USER': 'cltbld', 04:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:04 INFO - 'XPC_FLAGS': '0x0', 04:43:04 INFO - 'XPC_SERVICE_NAME': '0', 04:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:43:05 INFO - Cleaning up... 04:43:05 INFO - Return code: 0 04:43:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:05 INFO - 'HOME': '/Users/cltbld', 04:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:05 INFO - 'LOGNAME': 'cltbld', 04:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:05 INFO - 'MOZ_NO_REMOTE': '1', 04:43:05 INFO - 'NO_EM_RESTART': '1', 04:43:05 INFO - 'PAGER': '/bin/cat', 04:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:05 INFO - 'PWD': '/builds/slave/test', 04:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:05 INFO - 'SHELL': '/bin/bash', 04:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:05 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:05 INFO - 'USER': 'cltbld', 04:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:05 INFO - 'XPC_FLAGS': '0x0', 04:43:05 INFO - 'XPC_SERVICE_NAME': '0', 04:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:05 INFO - Downloading/unpacking psutil>=3.1.1 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:09 INFO - Installing collected packages: psutil 04:43:09 INFO - Running setup.py install for psutil 04:43:09 INFO - building 'psutil._psutil_osx' extension 04:43:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:43:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:43:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:43:09 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 04:43:09 INFO - building 'psutil._psutil_posix' extension 04:43:09 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 04:43:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:43:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:43:09 INFO - ^ 04:43:09 INFO - 1 warning generated. 04:43:09 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 04:43:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:10 INFO - Successfully installed psutil 04:43:10 INFO - Cleaning up... 04:43:10 INFO - Return code: 0 04:43:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:10 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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:10 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 04:43:10 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 04:43:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:10 INFO - 'HOME': '/Users/cltbld', 04:43:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:10 INFO - 'LOGNAME': 'cltbld', 04:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:10 INFO - 'MOZ_NO_REMOTE': '1', 04:43:10 INFO - 'NO_EM_RESTART': '1', 04:43:10 INFO - 'PAGER': '/bin/cat', 04:43:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:10 INFO - 'PWD': '/builds/slave/test', 04:43:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:10 INFO - 'SHELL': '/bin/bash', 04:43:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:10 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:10 INFO - 'USER': 'cltbld', 04:43:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:10 INFO - 'XPC_FLAGS': '0x0', 04:43:10 INFO - 'XPC_SERVICE_NAME': '0', 04:43:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:43:13 INFO - Installing collected packages: mozsystemmonitor 04:43:13 INFO - Running setup.py install for mozsystemmonitor 04:43:13 INFO - Successfully installed mozsystemmonitor 04:43:13 INFO - Cleaning up... 04:43:13 INFO - Return code: 0 04:43:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:13 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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:13 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 04:43:13 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 04:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:13 INFO - 'HOME': '/Users/cltbld', 04:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:13 INFO - 'LOGNAME': 'cltbld', 04:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:13 INFO - 'MOZ_NO_REMOTE': '1', 04:43:13 INFO - 'NO_EM_RESTART': '1', 04:43:13 INFO - 'PAGER': '/bin/cat', 04:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:13 INFO - 'PWD': '/builds/slave/test', 04:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:13 INFO - 'SHELL': '/bin/bash', 04:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:13 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:13 INFO - 'USER': 'cltbld', 04:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:13 INFO - 'XPC_FLAGS': '0x0', 04:43:13 INFO - 'XPC_SERVICE_NAME': '0', 04:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:14 INFO - Downloading/unpacking jsonschema==2.5.1 04:43:14 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 04:43:14 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 04:43:14 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 04:43:14 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 04:43:14 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 04:43:14 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 04:43:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:43:16 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 04:43:16 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 04:43:16 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 04:43:16 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 04:43:16 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 04:43:16 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 04:43:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:17 INFO - warning: no files found matching '*.txt' 04:43:17 INFO - no previously-included directories found matching 'build' 04:43:17 INFO - no previously-included directories found matching 'dist' 04:43:17 INFO - no previously-included directories found matching '.git*' 04:43:17 INFO - Installing collected packages: jsonschema, functools32 04:43:17 INFO - Running setup.py install for functools32 04:43:17 INFO - warning: no files found matching '*.txt' 04:43:17 INFO - no previously-included directories found matching 'build' 04:43:17 INFO - no previously-included directories found matching 'dist' 04:43:17 INFO - no previously-included directories found matching '.git*' 04:43:17 INFO - Successfully installed jsonschema functools32 04:43:17 INFO - Cleaning up... 04:43:17 INFO - Return code: 0 04:43:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:17 INFO - 'HOME': '/Users/cltbld', 04:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:17 INFO - 'LOGNAME': 'cltbld', 04:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:17 INFO - 'MOZ_NO_REMOTE': '1', 04:43:17 INFO - 'NO_EM_RESTART': '1', 04:43:17 INFO - 'PAGER': '/bin/cat', 04:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:17 INFO - 'PWD': '/builds/slave/test', 04:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:17 INFO - 'SHELL': '/bin/bash', 04:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:17 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:17 INFO - 'USER': 'cltbld', 04:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:17 INFO - 'XPC_FLAGS': '0x0', 04:43:17 INFO - 'XPC_SERVICE_NAME': '0', 04:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:43:17 INFO - Cleaning up... 04:43:17 INFO - Return code: 0 04:43:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:17 INFO - 'HOME': '/Users/cltbld', 04:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:17 INFO - 'LOGNAME': 'cltbld', 04:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:17 INFO - 'MOZ_NO_REMOTE': '1', 04:43:17 INFO - 'NO_EM_RESTART': '1', 04:43:17 INFO - 'PAGER': '/bin/cat', 04:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:17 INFO - 'PWD': '/builds/slave/test', 04:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:17 INFO - 'SHELL': '/bin/bash', 04:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:17 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:17 INFO - 'USER': 'cltbld', 04:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:17 INFO - 'XPC_FLAGS': '0x0', 04:43:17 INFO - 'XPC_SERVICE_NAME': '0', 04:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:43:18 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 04:43:18 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 04:43:18 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 04:43:18 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 04:43:18 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 04:43:18 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 04:43:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:43:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:43:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:21 INFO - Downloading docopt-0.6.1.tar.gz 04:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:43:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:43:22 INFO - Running setup.py install for blobuploader 04:43:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:43:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:43:22 INFO - Running setup.py install for requests 04:43:22 INFO - Running setup.py install for docopt 04:43:22 INFO - Successfully installed blobuploader requests docopt 04:43:22 INFO - Cleaning up... 04:43:22 INFO - Return code: 0 04:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:22 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')]} 04:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:22 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')]} 04:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:22 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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:22 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 04:43:22 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 04:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:22 INFO - 'HOME': '/Users/cltbld', 04:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:22 INFO - 'LOGNAME': 'cltbld', 04:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:22 INFO - 'MOZ_NO_REMOTE': '1', 04:43:22 INFO - 'NO_EM_RESTART': '1', 04:43:22 INFO - 'PAGER': '/bin/cat', 04:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:22 INFO - 'PWD': '/builds/slave/test', 04:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:22 INFO - 'SHELL': '/bin/bash', 04:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:22 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:22 INFO - 'USER': 'cltbld', 04:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:22 INFO - 'XPC_FLAGS': '0x0', 04:43:22 INFO - 'XPC_SERVICE_NAME': '0', 04:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-of73rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-o1KoOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-zOZmmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-2E9yzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-jnt9sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-U7lmj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-vSLoir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Y3NZiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:23 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-6Dfbqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:24 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-hu6U4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:24 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-5Cl8tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:24 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-NhHr7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:24 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Bc4V0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:24 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-itQG1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:24 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-gmJjhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:24 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-lbYtzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:24 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Fq8gTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:43:24 INFO - Running setup.py install for manifestparser 04:43:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:43:25 INFO - Running setup.py install for mozcrash 04:43:25 INFO - Running setup.py install for mozdebug 04:43:25 INFO - Running setup.py install for mozdevice 04:43:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:43:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:43:25 INFO - Running setup.py install for mozfile 04:43:25 INFO - Running setup.py install for mozhttpd 04:43:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:43:25 INFO - Running setup.py install for mozinfo 04:43:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:43:25 INFO - Running setup.py install for mozInstall 04:43:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Running setup.py install for mozleak 04:43:26 INFO - Running setup.py install for mozlog 04:43:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Running setup.py install for moznetwork 04:43:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Running setup.py install for mozprocess 04:43:26 INFO - Running setup.py install for mozprofile 04:43:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:43:26 INFO - Running setup.py install for mozrunner 04:43:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:43:27 INFO - Running setup.py install for mozscreenshot 04:43:27 INFO - Running setup.py install for moztest 04:43:27 INFO - Running setup.py install for mozversion 04:43:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:43:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:43:27 INFO - Cleaning up... 04:43:27 INFO - Return code: 0 04:43:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:27 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')]} 04:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:27 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')]} 04:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:27 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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:27 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 04:43:27 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 04:43:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:27 INFO - 'HOME': '/Users/cltbld', 04:43:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:27 INFO - 'LOGNAME': 'cltbld', 04:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:27 INFO - 'MOZ_NO_REMOTE': '1', 04:43:27 INFO - 'NO_EM_RESTART': '1', 04:43:27 INFO - 'PAGER': '/bin/cat', 04:43:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:27 INFO - 'PWD': '/builds/slave/test', 04:43:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:27 INFO - 'SHELL': '/bin/bash', 04:43:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:27 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:27 INFO - 'USER': 'cltbld', 04:43:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:27 INFO - 'XPC_FLAGS': '0x0', 04:43:27 INFO - 'XPC_SERVICE_NAME': '0', 04:43:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:27 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-gaXKGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:27 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)) 04:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:27 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-E7mU2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:27 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)) 04:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:27 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-_q9AgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-HlbMWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-OE82jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-cd1fK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-upJv1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-w17lBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-CTgzwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-OZDxtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Vb6xwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:28 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)) 04:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:28 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-2OiX4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:29 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)) 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:29 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-9W6T0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:29 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)) 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:29 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-UfhNtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:29 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)) 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:29 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-uewuzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:29 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)) 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:29 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-FQehol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:29 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)) 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:29 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-90INhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:29 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)) 04:43:29 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)) 04:43:29 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)) 04:43:29 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)) 04:43:29 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)) 04:43:29 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)) 04:43:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:32 INFO - Downloading blessings-1.6.tar.gz 04:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:32 INFO - Installing collected packages: blessings 04:43:32 INFO - Running setup.py install for blessings 04:43:32 INFO - Successfully installed blessings 04:43:32 INFO - Cleaning up... 04:43:32 INFO - Return code: 0 04:43:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:32 INFO - Reading from file tmpfile_stdout 04:43:32 INFO - Current package versions: 04:43:32 INFO - blessings == 1.6 04:43:32 INFO - blobuploader == 1.2.4 04:43:32 INFO - docopt == 0.6.1 04:43:32 INFO - functools32 == 3.2.3-2 04:43:32 INFO - jsonschema == 2.5.1 04:43:32 INFO - manifestparser == 1.1 04:43:32 INFO - mozInstall == 1.12 04:43:32 INFO - mozcrash == 1.0 04:43:32 INFO - mozdebug == 0.1 04:43:32 INFO - mozdevice == 0.49 04:43:32 INFO - mozfile == 1.2 04:43:32 INFO - mozhttpd == 0.7 04:43:32 INFO - mozinfo == 0.9 04:43:32 INFO - mozleak == 0.1 04:43:32 INFO - mozlog == 3.4 04:43:32 INFO - moznetwork == 0.27 04:43:32 INFO - mozprocess == 0.24 04:43:32 INFO - mozprofile == 0.28 04:43:32 INFO - mozrunner == 6.13 04:43:32 INFO - mozscreenshot == 0.1 04:43:32 INFO - mozsystemmonitor == 0.3 04:43:32 INFO - moztest == 0.8 04:43:32 INFO - mozversion == 1.4 04:43:32 INFO - psutil == 3.1.1 04:43:32 INFO - requests == 1.2.3 04:43:32 INFO - wsgiref == 0.1.2 04:43:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:32 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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:32 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 04:43:32 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 04:43:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:32 INFO - 'HOME': '/Users/cltbld', 04:43:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:32 INFO - 'LOGNAME': 'cltbld', 04:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:32 INFO - 'MOZ_NO_REMOTE': '1', 04:43:32 INFO - 'NO_EM_RESTART': '1', 04:43:32 INFO - 'PAGER': '/bin/cat', 04:43:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:32 INFO - 'PWD': '/builds/slave/test', 04:43:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:32 INFO - 'SHELL': '/bin/bash', 04:43:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:32 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:32 INFO - 'USER': 'cltbld', 04:43:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:32 INFO - 'XPC_FLAGS': '0x0', 04:43:32 INFO - 'XPC_SERVICE_NAME': '0', 04:43:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:32 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)) 04:43:32 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)) 04:43:32 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)) 04:43:32 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)) 04:43:32 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)) 04:43:32 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)) 04:43:32 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)) 04:43:33 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)) 04:43:33 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)) 04:43:33 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)) 04:43:33 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)) 04:43:33 INFO - Cleaning up... 04:43:33 INFO - Return code: 0 04:43:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:43:33 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')]} 04:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:33 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')]} 04:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:33 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 0x1027e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac414741a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, '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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 04:43:33 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 04:43:33 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 04:43:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:33 INFO - 'HOME': '/Users/cltbld', 04:43:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:33 INFO - 'LOGNAME': 'cltbld', 04:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:33 INFO - 'MOZ_NO_REMOTE': '1', 04:43:33 INFO - 'NO_EM_RESTART': '1', 04:43:33 INFO - 'PAGER': '/bin/cat', 04:43:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:33 INFO - 'PWD': '/builds/slave/test', 04:43:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:33 INFO - 'SHELL': '/bin/bash', 04:43:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:33 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:33 INFO - 'USER': 'cltbld', 04:43:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:33 INFO - 'XPC_FLAGS': '0x0', 04:43:33 INFO - 'XPC_SERVICE_NAME': '0', 04:43:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:43:33 INFO - Cleaning up... 04:43:33 INFO - Return code: 0 04:43:33 INFO - Running post-action listener: _resource_record_post_action 04:43:33 INFO - Running post-action listener: _start_resource_monitoring 04:43:33 INFO - Starting resource monitoring. 04:43:33 INFO - [mozharness: 2017-02-14 12:43:33.309137Z] Finished create-virtualenv step (success) 04:43:33 INFO - [mozharness: 2017-02-14 12:43:33.309977Z] Running install step. 04:43:33 INFO - Running pre-action listener: _resource_record_pre_action 04:43:33 INFO - Running main action method: install 04:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:33 INFO - Reading from file tmpfile_stdout 04:43:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:33 INFO - Reading from file tmpfile_stdout 04:43:33 INFO - Output received: 04:43:33 INFO - Usage: mozinstall [options] installer 04:43:33 INFO - Options: 04:43:33 INFO - -h, --help show this help message and exit 04:43:33 INFO - -d DEST, --destination=DEST 04:43:33 INFO - Directory to install application into. [default: 04:43:33 INFO - "/builds/slave/test"] 04:43:33 INFO - --app=APP Application being installed. [default: firefox] 04:43:33 INFO - mkdir: /builds/slave/test/build/application 04:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:43:55 INFO - Reading from file tmpfile_stdout 04:43:55 INFO - Output received: 04:43:55 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:43:55 INFO - Running post-action listener: _resource_record_post_action 04:43:55 INFO - [mozharness: 2017-02-14 12:43:55.898653Z] Finished install step (success) 04:43:55 INFO - [mozharness: 2017-02-14 12:43:55.898794Z] Running run-tests step. 04:43:55 INFO - Running pre-action listener: _resource_record_pre_action 04:43:55 INFO - Running main action method: run_tests 04:43:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:55 INFO - 2017-02-14 04:43:55.912 screenresolution[1627:8443] starting screenresolution argv=screenresolution get 04:43:55 INFO - 2017-02-14 04:43:55.914 screenresolution[1627:8443] Display 0: 1600x1200x32@60 04:43:55 INFO - 2017-02-14 04:43:55.920 screenresolution[1628:8445] starting screenresolution argv=screenresolution list 04:43:55 INFO - Available Modes on Display 0 04:43:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:56 INFO - Intel Iris: 04:43:56 INFO - Chipset Model: Intel Iris 04:43:56 INFO - Type: GPU 04:43:56 INFO - Bus: Built-In 04:43:56 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:56 INFO - Vendor: Intel (0x8086) 04:43:56 INFO - Device ID: 0x0a2e 04:43:56 INFO - Revision ID: 0x0009 04:43:56 INFO - Displays: 04:43:56 INFO - Display: 04:43:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:56 INFO - Display Serial Number: 1600x1200 60 04:43:56 INFO - Main Display: Yes 04:43:56 INFO - Mirror: Off 04:43:56 INFO - Online: Yes 04:43:56 INFO - Rotation: Supported 04:43:56 INFO - Return code: 0 04:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:56 INFO - Python 2.7.3 04:43:56 INFO - Return code: 0 04:43:56 INFO - grabbing minidump binary from tooltool 04:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025bed30>, '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 0x1024e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025b3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:43:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:43:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:43:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:56 INFO - Return code: 0 04:43:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0383', '--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 04:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0383 --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 04:43:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ubr5khyJkU/Render', 04:43:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:56 INFO - 'HOME': '/Users/cltbld', 04:43:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:56 INFO - 'LOGNAME': 'cltbld', 04:43:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:56 INFO - 'MOZ_NO_REMOTE': '1', 04:43:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:56 INFO - 'NO_EM_RESTART': '1', 04:43:56 INFO - 'PAGER': '/bin/cat', 04:43:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:56 INFO - 'PWD': '/builds/slave/test', 04:43:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:56 INFO - 'SHELL': '/bin/bash', 04:43:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bxk1Vtt3tu/Listeners', 04:43:56 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 04:43:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:56 INFO - 'USER': 'cltbld', 04:43:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:56 INFO - 'XPC_FLAGS': '0x0', 04:43:56 INFO - 'XPC_SERVICE_NAME': '0', 04:43:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0383', '--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 04:43:56 INFO - mozversion application_buildid: 20170214030231 04:43:56 INFO - mozversion application_changeset: 195049fabb7ac5709e5f75614ba630ba3d1b5a9b 04:43:56 INFO - mozversion application_display_name: Nightly 04:43:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:56 INFO - mozversion application_name: Firefox 04:43:56 INFO - mozversion application_remotingname: firefox 04:43:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:56 INFO - mozversion application_vendor: Mozilla 04:43:56 INFO - mozversion application_version: 54.0a1 04:43:56 INFO - mozversion platform_buildid: 20170214030231 04:43:56 INFO - mozversion platform_changeset: 195049fabb7ac5709e5f75614ba630ba3d1b5a9b 04:43:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:56 INFO - mozversion platform_version: 54.0a1 04:43:56 INFO - using testdate: 1487076236 04:43:56 INFO - actual date: 1487076236 04:43:56 INFO - starting webserver on 'localhost:49236' 04:43:56 INFO - SUITE-START | Running 2 tests 04:43:56 INFO - TEST-START | dromaeo_css 04:43:56 INFO - operating with platform_type : mac_ 04:43:56 INFO - Initialising browser for dromaeo_css test... 04:43:56 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpFBe1wu/profile http://localhost:49236/getInfo.html) 04:43:58 INFO - PROCESS | 1638 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:43:59 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 04:43:59 INFO - PROCESS | 1638 | colorDepth:24 04:43:59 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 04:43:59 INFO - PROCESS | 1638 | __metrics 04:43:59 INFO - PROCESS | 1638 | 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" 04:43:59 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:44:00 INFO - TEST-INFO | 1638: exit 0 04:44:00 INFO - Browser initialized. 04:44:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:44:00 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpFBe1wu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:12 INFO - PROCESS | 1642 | RSS: Main: 236613632 04:44:12 INFO - PROCESS | 1642 | 04:47:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 04:47:18 INFO - PROCESS | 1642 | RSS: Main: 466763776 04:47:18 INFO - PROCESS | 1642 | 04:49:02 INFO - PROCESS | 1642 | ************************* 04:49:02 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 04:49:02 INFO - PROCESS | 1642 | 04:49:02 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:02 INFO - PROCESS | 1642 | Full stack: 04:49:02 INFO - PROCESS | 1642 | ************************* 04:50:22 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 04:50:22 INFO - PROCESS | 1642 | RSS: Main: 373501952 04:50:22 INFO - PROCESS | 1642 | 04:53:25 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 04:53:26 INFO - PROCESS | 1642 | RSS: Main: 365015040 04:53:26 INFO - PROCESS | 1642 | 04:56:28 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 04:56:29 INFO - PROCESS | 1642 | RSS: Main: 352047104 04:56:29 INFO - PROCESS | 1642 | 04:59:32 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 04:59:33 INFO - PROCESS | 1642 | RSS: Main: 342327296 04:59:33 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 05:02:36 INFO - PROCESS | 1642 | RSS: Main: 560054272 05:02:36 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | __start_tp_report 05:02:36 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 05:02:36 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 05:02:36 INFO - PROCESS | 1642 | |i|pagename|runs| 05:02:36 INFO - PROCESS | 1642 | |0;dojo.html;3211.662775408581;3218.388506183825;3229.5640088588034;3248.886288979886;3289.0461766087838;5273.6835789852585;5305.177697456896;5309.123994540896;5411.296531450906;5486.286782718241;5503.174523821429;5505.201745746865;5540.889182216353;5556.499915007648;5579.330480342354;4912.164931961575;4973.825916092928;5026.52248036436;5131.358580177478;5139.974300128494;5061.974690126544;5112.642115051948;5115.769790359424;5150.845474635767;5174.741262936857;4923.975380123113;4968.677035992685;4977.203647416396;5039.672421292605;5068.645194836363;5050.797968081272;5073.315102461194;5079.771410286546;5160.174372100483;5183.429822719498;4994.126027945095;5051.368578927634;5069.264956581275;5080.720560369178;5089.796408143669;5290.338707661543;5338.546223571001;5566;5601.383847776741;5606.074997625387;5833.32916714579;5867.14926335679;5871.794487192928;5872.442117998783;5898.675572843492;5774.047282198432;5908.497777688902;5909.793157239476;5924.466797988159;5930.377310382434;5479.561635069185;5482.095454250084;5486.670799752028;5491.945080549183;5501.477359650827;6036.366181550961;6092.695365231721;6096.146539484475;6106.908396374058;6127.908081378783;5873.442023007808;5887.175795388649;5900.852478688067;5904.0553511437965;5916.26046744157;6055.666938318347;6060.727267272983;6064.605800622945;6067.271927368744;6081.422264884829;4975.278584605212;6029.939700603026;6072.696365181723;6091.299500557493;6092.969535152296;5063.417706963673;6102.938970610326;6104.359042300494;6113.449789518964;6113.938860611337;4752.738599377068;4808.927866082012;4809.927851082237;4835.661503694708;4839.467658557556;4296.0548679290505;4301.935470967938;4399.274119770266;4402.207602631493;4406.1187762447;5404.83785486436;5475.4524547544925;5504.532114770209;5565.471280228372;5571.359293681278;5010.398752149766;6165.630062196283;6167.722452489649;6173.69131543421;6189.473894718999;5668.206451096849;5683.488486036276;5690.687012214368;5696.857578560569;5714.371419143891;5175.922361164586;5231.241469986907;5334.466553344634;5341.225522299244;5345.866353341197;6121.026213050831;6158.507319414526;6196.907046394217;6203.2556093269095;6232.719527621177;6137.478314343331;6162.784302549389;6165.876682466415;6173.629582225081;6180.196574445473;6144.941444616104;6209.906851397323;6215.65813880241;6215.906761398493;6218.160548326099;5832.358440571618;5901.734421950937;5994.28068631767;6046.425589568984;6047.667378294236;6148.385161483816;6152.507799376129;6157.599756015845;6159.137720719193;6166.81499555014;5882.088276317178;5882.23530940975;5888.735006924613;5901.3213480450295;5949.345571986992;4738.668293219442;5535.778568857361;5585.972070139624;5591.245181900392;5857.707114644336;5447.972760136174;5492.093804522369;5494.945050549603;5500.917486237629;5501.642393244426;5632.690202038927;5643.661380317194;5659.603827732019;5660.632058916322;5664.49019588239;5467.753951072291;5509.917351239655;5513.338399392099;5524.944750552443;5531.834044978657 05:02:36 INFO - PROCESS | 1642 | |1;ext.html;465.45309261617604;482.92514660227675;491.668124016289;517.8860650656854;533.9813106541271;34920.82539587302;40441;40747.9813004675;40770.38844417336;42362.72911812643;36119.63880361195;39420.21159576814;40970.795146024226;41335;41397.58602413975;7531;7667.386609071261;9346.205572526327;9556.283278754086;9609.471479068648;7579.54522728638;7663.195364486733;7667.233276672344;11198.66404007877;11494.540218391254;11449.771004579903;11522.827157592643;11542.884571154307;11559;11560.248583842023;11405.54377824886;11456.541738330416;11466.598669046543;11478.196526243166;11480.024197943185;7480.326770590673;7657.864753033356;11224.66326010221;11329.98030177288;11339.319640821577;28540.715667795;28838.42323153546;28865;39300;40058.399124013165;3774.131949651568;3774.792386418746;3777.7166712496673;3777.9433308500393;3820.9426858597144;28495.572566411312;28987.13038608845;29932.251693707833;30257.697423025707;30903.845480772452;3095.4428202923464;3107.1046661536443;3142.842857857121;3206.695363940422;3258.6904244096772;434337;436579;437567;438055.9999999968;445316;45561.77219113883;52492.47507524876;53555.92888142293;55885.72057139688;56345.43654563402;46687.564681355216;47587.762061190166;47653.5234647656;56250.71874640683;56469;12498.06264530164;12703.30131842739;14007.929960350337;14379.137251764927;14432.927835360966;11010.614628487965;11088.611898583511;11097.83353249702;11101.72245693848;11105.66682999495;13323.866761332456;15360.539183824503;15413.768793468107;15422.922885385726;15539.378424862878;5702.401247868997;6997.580145191305;7129.322714342129;7171.713131474787;7214.747483838146;768.2240936654019;807.6284908941835;834.1575009240711;853.6585365853584;860.5482121885934;23238.883805580863;23748.39792947887;28417.43165136727;29101.058193161312;29296.26759331034;997.9172597731398;1001.3591301567003;1008.7074748323051;1047.5809676129456;1051.9316244444087;13904.652383690287;14736.189509577076;14803.555893323217;15064.924675376773;15278.15970121654;562883.4953883054;563055;563125;563760;564034;51081.46755597338;53873.1919021215;57261;57527.71236143876;57909.8418031637;1330.381372661717;1375.05121466188;1384.5015794314038;1384.8199734034713;1388.3613537772535;26120;28198.577021344285;28392;28588.571171432028;28669;46619.53380466152;46855.29717054179;46940.53059469498;46949.76525117353;46980.530194698986;494254;502880;505528;505920;516888;34500.654993449745;34999.12519683051;35264.647353527165;35512.46731299084;35522.28955420929;42261.36607950822;42466.36300455434;42691;43119.35320970251;43810.34284485799;29906.85046574753;34802;34873.30253394969;35976.82011589925;36104.91685249447;28439.00463483768;34525.61897524171;34630.480542791374;35747.82126089353;35841.64158358383;34951.300973980884;34988.97626772954;35312.646873531965;35422.114447137996;35673.46489802707;28781.712182878742;30800.898760484513;30955.948754081044;31180.53229201609;31191.660625453635;22839;22977;23569.17507887216;23589.882050589636;23679.64480532759 05:02:36 INFO - PROCESS | 1642 | |2;jquery.html;361.53362162809975;390.19035501334736;394.7986526871295;400.8555573836697;421.64581751328876;13534.323283835818;13751.174929504225;16295.75556366654;20244.59510809783;20748;20481.4879628009;20715.274965376215;21154;21241.044153013114;21272.89363553184;5803.883922321551;5850.970745146268;5988.550858685594;6065.939340606604;6136.079588061782;3861.2856621525107;5959.344472108065;6078.544109191828;6088.238970128734;6088.969555152218;4050.4936882889638;6312.747490100413;6712.798616041527;6732.427743641796;6748.190217173946;6469.320721324288;6610.7355705771715;6716.6305853178055;6744.393004629558;6770.390664840188;5967.49276311514;5968.880622387528;5990.191324171225;5992.460678538952;5996.280446346423;26309.473810523683;26738.06416775423;26828;26855.73144268552;27327.863360683266;2621.5412302846926;2662.8208135177088;2690.3543149644142;2707.9593806092726;2711.8644067796727;14925.776113358308;15221.61945951349;15332.693346133126;15874.36502539897;16021.519354419386;1468.4126349460194;1749.9825001749946;1794.4078454110113;1798.4784412520485;1804.3233787329752;90436.54781726115;105589.99999999923;115732;122329.16506252413;122450;8766.923380627912;10841.457927103771;11021.669349919515;11045.171612129123;11196.66410007701;14613.78079328811;14626.122432654074;14641.487547935983;14643.80342948545;14663.48677796272;7880.763577092696;8144.30773384269;8149.551774652333;8307.252347288773;8312.127226641116;7860.764177074697;7884.960575197088;8054.637541310655;8057.35541156706;8070.47541909774;5972.761089556456;6979.860402792017;7037.733208022605;7098.4445599584105;7125.501214914906;1883.4443839067508;1932.3043704266454;1933.7609504080608;1937.86434949555;1944.6791279438735;797.7833803449786;813.9784570364155;851.9446235994641;879.5338470610586;892.6340200517757;20200.000989614095;20756.68864967027;22126.446838829157;22380.776192238194;22564.984575694132;805.5408417202138;851.1445996773203;905.9740466840783;930.2465003347311;930.4882314727008;10345.586176552853;10640.04239618438;10688.946555267174;10711.916759892565;10730.570777168981;541497;636705;638472;648176;653426;143912;145666;153832;153906.2112479051;155811.22094389683;963.4123184857092;1027.209049032241;1051;1056.6460235820932;1059.4120263253967;17720.734188987433;17909.641807163523;18025.909870450563;18079;18556.44330670082;47645;52278;54335.45664543304;54463.72768136134;54540.727296363264;83274.58362708148;83585;85103;85913.57043214743;87468.56265718886;7920.564368959763;8058.637361318872;8189.181081891763;8242.928419305452;8284.46151000183;10553.314034587727;12385.566505172275;12486.313252770822;12804.423800929168;12895.48418063267;10611.787764244518;10642.680719578426;11098.722531936766;11214.943925280322;11254.043406310555;10896.727581810519;10899.945500272448;10946.39794811293;11284.379359135326;11310.208285419942;11123.610673626385;11162.888371116509;11273.605423810128;11494.942525287655;11507.424628768695;7906.888418022481;8152.755417337489;8157.959210203911;8171.509709417454;8199.71301004462;9138.949020862687;9835.901640983499;9971.950140249251;10206.846897296695;10291 05:02:36 INFO - PROCESS | 1642 | |3;mootools.html;1419.0424428084393;1436.2962148547208;1448.145594099481;1455.8844073682321;1461.751502244618;8188.54962977036;8552.657893684245;8562.486250824939;8575;8599.269062129719;8150.9592452037805;8493.702720404786;8506.447080939735;8570.742877713663;8605.91394086059;1913.9617207655838;2256.2103263857643;2275.8975846086882;2287.4167087392693;2289.6679981402685;2072.1504183284856;2236.709227800384;2267.682524446579;2277.7152855893014;2279.2250634784255;2106.926257580985;2223.2552095048177;2256.4133325335365;2277.829162812787;2282.691836602054;2232.765559616233;2242.8878556072214;2254.458929856839;2257.6274914639066;2273.283915566608;1919.3474218765548;2266.512699769541;2267.0818318581;2292.358139720881;2292.86242825431;8367;8560.272376847975;8561.657533698644;8580.313574913991;8595.140485951417;5023.196288593844;5188.896222075575;5193;5194.896102077937;5201.817936372247;3215.839208039612;3278.704916557497;3448.586169659657;3488.3720930232525;3498.038039539147;1021.7088129882948;1179.9469023893946;1224.3082658298033;1247.8065899785547;1283.1210620724833;9806.117449429514;10183.439910804902;10201.234907381902;10849.945750271278;10869.565217391295;4030.1939612077704;4103.7948102594755;4114.136031433372;4129.421880936671;4223.915521689549;8556.358273129541;8627.870581941275;8645.438046526955;8649.264812491008;8673.913260867437;5005.449400565934;5008.6243531734535;5012.774425150877;5019.247112933016;5020.3724534433195;4138.089620283533;4471.5081341052455;4633.837815676435;4637.582617564435;4644.303354496852;2948.6461624605186;3001.2646901508833;3472.385340816482;3480.9477857832153;3561.4835848801777;1092.5848177692426;1104.8342748587615;1108.8225883858706;1123.5505797680994;1127.1377396291844;802.8233788566506;834.8789425533264;840.3865178419787;865.1002956924854;869.3914260018013;4990.216718266254;5149.4578076200905;5153.742312884341;5372.758225879845;5381.973090134603;942.9815798937268;947.6304241345881;962.7448726087592;969.1762002298132;1001.2790790630734;3635.781853088823;3641.417373220272;3657.9634203658156;3778.7165962552917;3779.7543159694533;9798.608055677836;10097.848532272023;10100.949495252476;10108.24188185889;10146.188304935587;9326.72019839406;9823.508824558743;10036.24728145392;10054.74863128413;10118.443485608363;7482.738104166328;7659.502132361378;7668.961655191688;7695.92304076952;7704.961475192588;5570.080936645408;5599;5601.80393686219;5771.59598828078;5948.345681975065;9250.814983700153;9365.438073715599;9374.062593740844;9391.013943536103;9423.38747981379;7417.8145546361775;8355.908313923645;8710.651573937224;9215.539223038688;9465.763355916157;6445.871082578228;7071.858562828817;7248.166460857069;7255.056842610426;7331.04696389466;7667.386609071373;7990.680372785024;8045.758627241192;8139.14538973423;8140.389470789596;7106.538075025107;7113.324234197743;7195.712171513081;7235.312645298688;7334;6971.093757811452;7002.544834585736;7027.9297207027275;7074.540154890122;7091.2554181810165;5299.973500132474;6215.564910456224;6282.057691346335;6286.045558587457;6342.841428964312;3965.266425711253;4144.52337981136;4862.343583616308;4896;5028.044671512401;4669.41632295963;4882.60939124862;4917.322226595384;4935.457099718957;5034.622403319692 05:02:36 INFO - PROCESS | 1642 | |4;prototype.html;349.5211560162577;360.9079684680408;362.41650941983403;364.8175912043978;368.12019273935283;4533.637309015279;4797.385424943405;5087.847364579059;5144.382674079106;5205.297284866547;4163.20899029185;4405.757683327416;4877.561019508244;4908.067467181242;5068.366454193226;3358.085891042107;3881.9805900970528;3897.13560533008;3907.6678482329035;3909.198614284065;3883.533975922893;3884.747491413049;3893.552241492236;3899.8245078971513;3907.1599606084687;3251.2847173621767;3561.465780132975;3828.923421531568;3874.593167717377;3884.6309600587897;3723.585037685662;3806.619338066199;3843.500344955166;3879.8836034918854;3899.3566061599804;2791.916242512728;3341.4319565673895;3346.2136397946465;3363.1423986883433;3373.2747459296124;4970.179920313144;4971.1606705518825;4985.426675932242;4985.825496107619;4988.950110498885;4216.367544868263;4405.647548196169;4425.336199570058;4429.645628349725;4432.268675668511;4333.569921925757;5283.498067683564;5319.9202011969855;5386.326709161355;5391.622586418952;3528.188516641187;3694.8891533254045;3720.102747598717;3722.981385093084;3797.696184305249;4383.60547550722;5356.678599284017;5487.451254874481;5528.668279903179;5618.578606604521;3368.7136593389346;3583.2654305867236;3684.428913518409;3693.926121477555;3695.7043436525014;3370.2753907909428;3796.259729352805;3805.5623603285976;3816.37029890065;3825.3114439401174;4342.656154760816;4399.560043995575;4409.536998615164;4409.823607055746;4414.624756895636;4352.499462561846;4449.688521803443;4556.70134011805;5395.514403703685;5440.863978400572;1122.8371886076472;1220.9816852747215;1234.8086046662781;1240.4046057892263;1243.2664727810636;776.9162018983599;800.7877912353231;833.1959658929042;844.3540691371106;851.1573542193184;4264.360345948133;4839.2983017462975;4845.3216549683075;4857;4879.634027447955;4821.180399332122;4951.935333903228;5077.746112694351;5224;5344.75948582307;4333.393324934512;4412.271975124068;4549.249373853343;4643.908681459854;4772.880677983008;2331.936236430771;2566.294269075982;2616.9869150654126;2754.614353990443;2764.9769585253184;4568.771561421916;5451.64564303319;5472.835814925558;5499.285092937893;5500.58745594082;4659.860204193879;4819.7108173509005;5160.071187186268;5309.628326017219;5401.351837779492;4531.229690952546;4645.976770116195;5159.8452046439415;5588.748506317225;5594.398604648858;4485.327200919888;4500.797464114057;5227.607929405386;5233.398159211587;5244.396894357198;4094.467719196485;4363.036633514995;4978.5270399312;5262.763175657181;5297.867553311198;4893.1436998524405;5006.4743201963265;5454.790809722069;5460.5085542301385;5523.364813046391;3389.2714715495767;3449.534312867731;3528.788272703646;3532;3548.9645103548633;4153.480814898137;4652.744099074584;4744.935952860516;4756.33411322422;5042.4705405931845;4682.555157260055;5355.464453554613;5367.665065696278;5418.620696551204;5482.506574408322;4537.682362234612;4880.6095512358215;5096.286519887145;5364.517193452608;5429.5656347492895;4976.427710813303;5282.735863206901;5303.068146623677;5308.442613525679;5312.760925758273;4662.603678687214;5333.226682130991;5361.847202851406;5372.785088596413;5488.490665066979;5250.973745131403;5270.868228294324;5271.71005594696;5288.524032837063;5306.28365170697 05:02:36 INFO - PROCESS | 1642 | |5;yui.html;700.5621486570893;711.3988679565772;737.852429514097;808.216030450463;808.6159074439641;16584.33662653494;17475.912620436913;17501.91249043753;17533.824661753377;17535.947843129423;15973.520794376158;16064;16071;16094.678106437865;16129.919350403232;877.675260153744;910.4537277633433;913.9040400757891;915.199200699388;916.8991410944791;870.490762903699;900.5992333411634;916.8670542771295;920.2775820980531;922.0594993107027;956.4882787708577;958.8561715742625;960.346964064436;961.7547525381018;963.9710808675716;951.6098399656108;952.5189779161514;956.0344052506948;956.3449037409397;958.7267628725849;710.5772065620947;710.6695386645234;711.274500009992;711.9181294151135;712.6258714175048;15048.924755376152;15424.228788560527;15504;15604.765928511082;15614;13781.931090344584;13909.956753243547;13943.651408714763;14018.369173387222;14130.36413361391;11032.757842081435;11543.307401555934;11622.6513204604;11981.221220620631;12125.27248365092;3555.2356243407535;3616.6021737608844;3620.981895090508;3642.435422509489;3644.8177591120602;78079.60960195163;95392;96521;98350;98902;10292.419873156523;10668.839967400496;10712.892871071346;10732.73168170802;11000.779984400267;21761.34715958524;21769;21804.89097554534;21828.126874925143;21903;6826;7610.353119984753;7659.387249020065;7662.9233707663325;7698.2686644768655;3726.9564521933903;4114.485689288839;4232.915341693149;4247.723897946624;4408.669349798778;3551.94672079919;3655.5377848860667;3661.761985470936;3665.5051568038507;3666.834992425347;664.8404382948154;675.0515525686418;679.6533767778468;699.0737273113044;702.6416527570975;641.9486441084701;661.9304972977768;678.8879834827297;681.9215790184193;687.4500399680236;9454.43273403598;9526.237900967906;9561.378510396802;9763.90236097644;9854.211663066937;636.5798572941836;680.4726337088796;682.5430681699842;689.3898899474002;691.4641153106382;4494.887627809266;4696.81212751493;4780.665353425296;4828.975855120772;4863.732494712754;87638;92601;92841;94041;95437;50281;56347.71826140843;56531;57095;84361.31277374418;60934;73338;74725;75903.9999999989;76700.61649691939;10141.695749127539;10358.664914167375;10579.047885690325;10679.412632304988;10710.571577136827;47142.057158857315;47303.763481182374;47835.76082119567;48509.75745121393;49405;51988.220176696625;57106.7144664274;62471;64811;65623.34376656172;12446.626601201979;12498.629208330338;12748.808767868304;12802.487900483877;12904.419301131284;14192.92903535517;14264.643383915485;14335.641608959442;14363.497277595234;15162.3176957035;13062.150960187557;13123.212607243597;13286;13426.731465370443;13669.453221871412;13199.670008249486;13215.273159975908;13374.97830990811;13416.798748018593;13741;12801.871981280441;13142.474301027853;13227.669308266984;13320.467181312639;13337.466501339837;9682.370645907993;10761.354318740901;10782.191335650015;10819.67540973772;11234;9152.908470915472;9481.952590237004;10803.783924321313;10943.671689849318;11107.777844443228 05:02:36 INFO - PROCESS | 1642 | __end_tp_report 05:02:36 INFO - PROCESS | 1642 | __start_cc_report 05:02:36 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,2826 05:02:36 INFO - PROCESS | 1642 | __end_cc_report 05:02:36 INFO - PROCESS | 1642 | __startTimestamp1487077356906__endTimestamp 05:02:36 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | ------- Summary: start ------- 05:02:36 INFO - PROCESS | 1642 | Number of tests: 6 05:02:36 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5523.10 Median:5579.33 stddev:618.68 (11.1%) stddev-sans-first:593.41 05:02:36 INFO - PROCESS | 1642 | Values: 3211.7 3218.4 3229.6 3248.9 3289.0 5273.7 5305.2 5309.1 5411.3 5486.3 5503.2 5505.2 5540.9 5556.5 5579.3 4912.2 4973.8 5026.5 5131.4 5140.0 5062.0 5112.6 5115.8 5150.8 5174.7 4924.0 4968.7 4977.2 5039.7 5068.6 5050.8 5073.3 5079.8 5160.2 5183.4 4994.1 5051.4 5069.3 5080.7 5089.8 5290.3 5338.5 5566.0 5601.4 5606.1 5833.3 5867.1 5871.8 5872.4 5898.7 5774.0 5908.5 5909.8 5924.5 5930.4 5479.6 5482.1 5486.7 5491.9 5501.5 6036.4 6092.7 6096.1 6106.9 6127.9 5873.4 5887.2 5900.9 5904.1 5916.3 6055.7 6060.7 6064.6 6067.3 6081.4 4975.3 6029.9 6072.7 6091.3 6093.0 5063.4 6102.9 6104.4 6113.4 6113.9 4752.7 4808.9 4809.9 4835.7 4839.5 4296.1 4301.9 4399.3 4402.2 4406.1 5404.8 5475.5 5504.5 5565.5 5571.4 5010.4 6165.6 6167.7 6173.7 6189.5 5668.2 5683.5 5690.7 5696.9 5714.4 5175.9 5231.2 5334.5 5341.2 5345.9 6121.0 6158.5 6196.9 6203.3 6232.7 6137.5 6162.8 6165.9 6173.6 6180.2 6144.9 6209.9 6215.7 6215.9 6218.2 5832.4 5901.7 5994.3 6046.4 6047.7 6148.4 6152.5 6157.6 6159.1 6166.8 5882.1 5882.2 5888.7 5901.3 5949.3 4738.7 5535.8 5586.0 5591.2 5857.7 5448.0 5492.1 5494.9 5500.9 5501.6 5632.7 5643.7 5659.6 5660.6 5664.5 5467.8 5509.9 5513.3 5524.9 5531.8 05:02:36 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:63006.09 Median:35467.29 stddev:134613.71 (379.5%) stddev-sans-first:134909.44 05:02:36 INFO - PROCESS | 1642 | Values: 465.5 482.9 491.7 517.9 534.0 34920.8 40441.0 40748.0 40770.4 42362.7 36119.6 39420.2 40970.8 41335.0 41397.6 7531.0 7667.4 9346.2 9556.3 9609.5 7579.5 7663.2 7667.2 11198.7 11494.5 11449.8 11522.8 11542.9 11559.0 11560.2 11405.5 11456.5 11466.6 11478.2 11480.0 7480.3 7657.9 11224.7 11330.0 11339.3 28540.7 28838.4 28865.0 39300.0 40058.4 3774.1 3774.8 3777.7 3777.9 3820.9 28495.6 28987.1 29932.3 30257.7 30903.8 3095.4 3107.1 3142.8 3206.7 3258.7 434337.0 436579.0 437567.0 438056.0 445316.0 45561.8 52492.5 53555.9 55885.7 56345.4 46687.6 47587.8 47653.5 56250.7 56469.0 12498.1 12703.3 14007.9 14379.1 14432.9 11010.6 11088.6 11097.8 11101.7 11105.7 13323.9 15360.5 15413.8 15422.9 15539.4 5702.4 6997.6 7129.3 7171.7 7214.7 768.2 807.6 834.2 853.7 860.5 23238.9 23748.4 28417.4 29101.1 29296.3 997.9 1001.4 1008.7 1047.6 1051.9 13904.7 14736.2 14803.6 15064.9 15278.2 562883.5 563055.0 563125.0 563760.0 564034.0 51081.5 53873.2 57261.0 57527.7 57909.8 1330.4 1375.1 1384.5 1384.8 1388.4 26120.0 28198.6 28392.0 28588.6 28669.0 46619.5 46855.3 46940.5 46949.8 46980.5 494254.0 502880.0 505528.0 505920.0 516888.0 34500.7 34999.1 35264.6 35512.5 35522.3 42261.4 42466.4 42691.0 43119.4 43810.3 29906.9 34802.0 34873.3 35976.8 36104.9 28439.0 34525.6 34630.5 35747.8 35841.6 34951.3 34989.0 35312.6 35422.1 35673.5 28781.7 30800.9 30955.9 31180.5 31191.7 22839.0 22977.0 23569.2 23589.9 23679.6 05:02:36 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:36486.48 Median:2699.16 stddev:104650.44 (3877.2%) stddev-sans-first:104908.86 05:02:36 INFO - PROCESS | 1642 | Values: 361.5 390.2 394.8 400.9 421.6 13534.3 13751.2 16295.8 20244.6 20748.0 20481.5 20715.3 21154.0 21241.0 21272.9 5803.9 5851.0 5988.6 6065.9 6136.1 3861.3 5959.3 6078.5 6088.2 6089.0 4050.5 6312.7 6712.8 6732.4 6748.2 6469.3 6610.7 6716.6 6744.4 6770.4 5967.5 5968.9 5990.2 5992.5 5996.3 26309.5 26738.1 26828.0 26855.7 27327.9 2621.5 2662.8 2690.4 2708.0 2711.9 14925.8 15221.6 15332.7 15874.4 16021.5 1468.4 1750.0 1794.4 1798.5 1804.3 90436.5 105590.0 115732.0 122329.2 122450.0 8766.9 10841.5 11021.7 11045.2 11196.7 14613.8 14626.1 14641.5 14643.8 14663.5 7880.8 8144.3 8149.6 8307.3 8312.1 7860.8 7885.0 8054.6 8057.4 8070.5 5972.8 6979.9 7037.7 7098.4 7125.5 1883.4 1932.3 1933.8 1937.9 1944.7 797.8 814.0 851.9 879.5 892.6 20200.0 20756.7 22126.4 22380.8 22565.0 805.5 851.1 906.0 930.2 930.5 10345.6 10640.0 10688.9 10711.9 10730.6 541497.0 636705.0 638472.0 648176.0 653426.0 143912.0 145666.0 153832.0 153906.2 155811.2 963.4 1027.2 1051.0 1056.6 1059.4 17720.7 17909.6 18025.9 18079.0 18556.4 47645.0 52278.0 54335.5 54463.7 54540.7 83274.6 83585.0 85103.0 85913.6 87468.6 7920.6 8058.6 8189.2 8242.9 8284.5 10553.3 12385.6 12486.3 12804.4 12895.5 10611.8 10642.7 11098.7 11214.9 11254.0 10896.7 10899.9 10946.4 11284.4 11310.2 11123.6 11162.9 11273.6 11494.9 11507.4 7906.9 8152.8 8158.0 8171.5 8199.7 9138.9 9835.9 9972.0 10206.8 10291.0 05:02:36 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5324.30 Median:5021.78 stddev:2951.51 (58.8%) stddev-sans-first:2945.20 05:02:36 INFO - PROCESS | 1642 | Values: 1419.0 1436.3 1448.1 1455.9 1461.8 8188.5 8552.7 8562.5 8575.0 8599.3 8151.0 8493.7 8506.4 8570.7 8605.9 1914.0 2256.2 2275.9 2287.4 2289.7 2072.2 2236.7 2267.7 2277.7 2279.2 2106.9 2223.3 2256.4 2277.8 2282.7 2232.8 2242.9 2254.5 2257.6 2273.3 1919.3 2266.5 2267.1 2292.4 2292.9 8367.0 8560.3 8561.7 8580.3 8595.1 5023.2 5188.9 5193.0 5194.9 5201.8 3215.8 3278.7 3448.6 3488.4 3498.0 1021.7 1179.9 1224.3 1247.8 1283.1 9806.1 10183.4 10201.2 10849.9 10869.6 4030.2 4103.8 4114.1 4129.4 4223.9 8556.4 8627.9 8645.4 8649.3 8673.9 5005.4 5008.6 5012.8 5019.2 5020.4 4138.1 4471.5 4633.8 4637.6 4644.3 2948.6 3001.3 3472.4 3480.9 3561.5 1092.6 1104.8 1108.8 1123.6 1127.1 802.8 834.9 840.4 865.1 869.4 4990.2 5149.5 5153.7 5372.8 5382.0 943.0 947.6 962.7 969.2 1001.3 3635.8 3641.4 3658.0 3778.7 3779.8 9798.6 10097.8 10100.9 10108.2 10146.2 9326.7 9823.5 10036.2 10054.7 10118.4 7482.7 7659.5 7669.0 7695.9 7705.0 5570.1 5599.0 5601.8 5771.6 5948.3 9250.8 9365.4 9374.1 9391.0 9423.4 7417.8 8355.9 8710.7 9215.5 9465.8 6445.9 7071.9 7248.2 7255.1 7331.0 7667.4 7990.7 8045.8 8139.1 8140.4 7106.5 7113.3 7195.7 7235.3 7334.0 6971.1 7002.5 7027.9 7074.5 7091.3 5300.0 6215.6 6282.1 6286.0 6342.8 3965.3 4144.5 4862.3 4896.0 5028.0 4669.4 4882.6 4917.3 4935.5 5034.6 05:02:36 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4227.67 Median:4644.94 stddev:1275.77 (27.5%) stddev-sans-first:1245.70 05:02:36 INFO - PROCESS | 1642 | Values: 349.5 360.9 362.4 364.8 368.1 4533.6 4797.4 5087.8 5144.4 5205.3 4163.2 4405.8 4877.6 4908.1 5068.4 3358.1 3882.0 3897.1 3907.7 3909.2 3883.5 3884.7 3893.6 3899.8 3907.2 3251.3 3561.5 3828.9 3874.6 3884.6 3723.6 3806.6 3843.5 3879.9 3899.4 2791.9 3341.4 3346.2 3363.1 3373.3 4970.2 4971.2 4985.4 4985.8 4989.0 4216.4 4405.6 4425.3 4429.6 4432.3 4333.6 5283.5 5319.9 5386.3 5391.6 3528.2 3694.9 3720.1 3723.0 3797.7 4383.6 5356.7 5487.5 5528.7 5618.6 3368.7 3583.3 3684.4 3693.9 3695.7 3370.3 3796.3 3805.6 3816.4 3825.3 4342.7 4399.6 4409.5 4409.8 4414.6 4352.5 4449.7 4556.7 5395.5 5440.9 1122.8 1221.0 1234.8 1240.4 1243.3 776.9 800.8 833.2 844.4 851.2 4264.4 4839.3 4845.3 4857.0 4879.6 4821.2 4951.9 5077.7 5224.0 5344.8 4333.4 4412.3 4549.2 4643.9 4772.9 2331.9 2566.3 2617.0 2754.6 2765.0 4568.8 5451.6 5472.8 5499.3 5500.6 4659.9 4819.7 5160.1 5309.6 5401.4 4531.2 4646.0 5159.8 5588.7 5594.4 4485.3 4500.8 5227.6 5233.4 5244.4 4094.5 4363.0 4978.5 5262.8 5297.9 4893.1 5006.5 5454.8 5460.5 5523.4 3389.3 3449.5 3528.8 3532.0 3549.0 4153.5 4652.7 4744.9 4756.3 5042.5 4682.6 5355.5 5367.7 5418.6 5482.5 4537.7 4880.6 5096.3 5364.5 5429.6 4976.4 5282.7 5303.1 5308.4 5312.8 4662.6 5333.2 5361.8 5372.8 5488.5 5251.0 5270.9 5271.7 5288.5 5306.3 05:02:36 INFO - PROCESS | 1642 | 05:02:36 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:18709.22 Median:26042.21 stddev:25362.86 (97.4%) stddev-sans-first:25397.96 05:02:36 INFO - PROCESS | 1642 | Values: 700.6 711.4 737.9 808.2 808.6 16584.3 17475.9 17501.9 17533.8 17535.9 15973.5 16064.0 16071.0 16094.7 16129.9 877.7 910.5 913.9 915.2 916.9 870.5 900.6 916.9 920.3 922.1 956.5 958.9 960.3 961.8 964.0 951.6 952.5 956.0 956.3 958.7 710.6 710.7 711.3 711.9 712.6 15048.9 15424.2 15504.0 15604.8 15614.0 13781.9 13910.0 13943.7 14018.4 14130.4 11032.8 11543.3 11622.7 11981.2 12125.3 3555.2 3616.6 3621.0 3642.4 3644.8 78079.6 95392.0 96521.0 98350.0 98902.0 10292.4 10668.8 10712.9 10732.7 11000.8 21761.3 21769.0 21804.9 21828.1 21903.0 6826.0 7610.4 7659.4 7662.9 7698.3 3727.0 4114.5 4232.9 4247.7 4408.7 3551.9 3655.5 3661.8 3665.5 3666.8 664.8 675.1 679.7 699.1 702.6 641.9 661.9 678.9 681.9 687.5 9454.4 9526.2 9561.4 9763.9 9854.2 636.6 680.5 682.5 689.4 691.5 4494.9 4696.8 4780.7 4829.0 4863.7 87638.0 92601.0 92841.0 94041.0 95437.0 50281.0 56347.7 56531.0 57095.0 84361.3 60934.0 73338.0 74725.0 75904.0 76700.6 10141.7 10358.7 10579.0 10679.4 10710.6 47142.1 47303.8 47835.8 48509.8 49405.0 51988.2 57106.7 62471.0 64811.0 65623.3 12446.6 12498.6 12748.8 12802.5 12904.4 14192.9 14264.6 14335.6 14363.5 15162.3 13062.2 13123.2 13286.0 13426.7 13669.5 13199.7 13215.3 13375.0 13416.8 13741.0 12801.9 13142.5 13227.7 13320.5 13337.5 9682.4 10761.4 10782.2 10819.7 11234.0 9152.9 9482.0 10803.8 10943.7 11107.8 05:02:36 INFO - PROCESS | 1642 | -------- Summary: end -------- 05:02:36 INFO - PROCESS | 1642 | 05:02:37 INFO - TEST-INFO | 1642: exit 0 05:02:37 INFO - TEST-OK | dromaeo_css | took 1121021ms 05:02:37 INFO - TEST-START | kraken 05:02:37 INFO - operating with platform_type : mac_ 05:02:37 INFO - Initialising browser for kraken test... 05:02:37 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpDAHex9/profile http://localhost:49236/getInfo.html) 05:02:39 INFO - PROCESS | 1648 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:02:40 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 05:02:40 INFO - PROCESS | 1648 | colorDepth:24 05:02:40 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 05:02:40 INFO - PROCESS | 1648 | __metrics 05:02:40 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:02:40 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:41 INFO - TEST-INFO | 1648: exit 0 05:02:41 INFO - Browser initialized. 05:02:41 INFO - Running cycle 1/1 for kraken test... 05:02:41 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpDAHex9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:53 INFO - PROCESS | 1650 | RSS: Main: 236277760 05:02:53 INFO - PROCESS | 1650 | 05:02:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:57 INFO - PROCESS | 1650 | RSS: Main: 288690176 05:02:57 INFO - PROCESS | 1650 | 05:02:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 05:03:00 INFO - PROCESS | 1650 | RSS: Main: 290672640 05:03:00 INFO - PROCESS | 1650 | 05:03:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 05:03:04 INFO - PROCESS | 1650 | RSS: Main: 380248064 05:03:04 INFO - PROCESS | 1650 | 05:03:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 05:03:07 INFO - PROCESS | 1650 | RSS: Main: 285216768 05:03:07 INFO - PROCESS | 1650 | 05:03:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:09 INFO - PROCESS | 1650 | RSS: Main: 287199232 05:03:09 INFO - PROCESS | 1650 | 05:03:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:13 INFO - PROCESS | 1650 | RSS: Main: 328728576 05:03:13 INFO - PROCESS | 1650 | 05:03:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:16 INFO - PROCESS | 1650 | RSS: Main: 334045184 05:03:16 INFO - PROCESS | 1650 | 05:03:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 05:03:20 INFO - PROCESS | 1650 | RSS: Main: 330489856 05:03:20 INFO - PROCESS | 1650 | 05:03:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:22 INFO - PROCESS | 1650 | RSS: Main: 305696768 05:03:22 INFO - PROCESS | 1650 | 05:03:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:25 INFO - PROCESS | 1650 | RSS: Main: 309256192 05:03:25 INFO - PROCESS | 1650 | 05:03:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:28 INFO - PROCESS | 1650 | RSS: Main: 311939072 05:03:28 INFO - PROCESS | 1650 | 05:03:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:31 INFO - PROCESS | 1650 | RSS: Main: 331141120 05:03:31 INFO - PROCESS | 1650 | 05:03:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:35 INFO - PROCESS | 1650 | RSS: Main: 324956160 05:03:35 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 05:03:37 INFO - PROCESS | 1650 | RSS: Main: 369659904 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | __start_tp_report 05:03:37 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 05:03:37 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 05:03:37 INFO - PROCESS | 1650 | |i|pagename|runs| 05:03:37 INFO - PROCESS | 1650 | |0;ai-astar;116;115;114;114;114;114;113;115;114;113 05:03:37 INFO - PROCESS | 1650 | |1;audio-beat-detection;147;112;114;153;113;113;110;115;135;111 05:03:37 INFO - PROCESS | 1650 | |2;audio-dft;187;183;186;185;180;184;185;184;185;185 05:03:37 INFO - PROCESS | 1650 | |3;audio-fft;80;61;60;94;82;84;83;60;78;61 05:03:37 INFO - PROCESS | 1650 | |4;audio-oscillator;91;71;88;68;70;70;87;69;68;86 05:03:37 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;87;87;88;87;88;87;87;86;87;87 05:03:37 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;95;95;95;94;96;95;95;95;94 05:03:37 INFO - PROCESS | 1650 | |7;imaging-desaturate;87;85;85;88;87;84;88;84;87;86 05:03:37 INFO - PROCESS | 1650 | |8;json-parse-financial;60;58;60;58;59;59;59;59;59;59 05:03:37 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;64;75;65;72;72;72;82;99;100;72 05:03:37 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;97;92;94;113;111;113;89;95;94;94 05:03:37 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;146;145;143;144;163;143;158;148;204;193 05:03:37 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;183;177;179;182;182;180;182;181;179;184 05:03:37 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;75;85;89;71;69;70;68;68;68;68 05:03:37 INFO - PROCESS | 1650 | __end_tp_report 05:03:37 INFO - PROCESS | 1650 | __start_cc_report 05:03:37 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2077 05:03:37 INFO - PROCESS | 1650 | __end_cc_report 05:03:37 INFO - PROCESS | 1650 | __startTimestamp1487077417554__endTimestamp 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | ------- Summary: start ------- 05:03:37 INFO - PROCESS | 1650 | Number of tests: 14 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 05:03:37 INFO - PROCESS | 1650 | Values: 116.0 115.0 114.0 114.0 114.0 114.0 113.0 115.0 114.0 113.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:114.50 stddev:16.31 (14.2%) stddev-sans-first:14.65 05:03:37 INFO - PROCESS | 1650 | Values: 147.0 112.0 114.0 153.0 113.0 113.0 110.0 115.0 135.0 111.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.90 (1.0%) stddev-sans-first:1.76 05:03:37 INFO - PROCESS | 1650 | Values: 187.0 183.0 186.0 185.0 180.0 184.0 185.0 184.0 185.0 185.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:74.30 Median:81.00 stddev:12.59 (15.5%) stddev-sans-first:13.18 05:03:37 INFO - PROCESS | 1650 | Values: 80.0 61.0 60.0 94.0 82.0 84.0 83.0 60.0 78.0 61.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.50 stddev:9.76 (12.4%) stddev-sans-first:8.90 05:03:37 INFO - PROCESS | 1650 | Values: 91.0 71.0 88.0 68.0 70.0 70.0 87.0 69.0 68.0 86.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 05:03:37 INFO - PROCESS | 1650 | Values: 87.0 87.0 88.0 87.0 88.0 87.0 87.0 86.0 87.0 87.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 05:03:37 INFO - PROCESS | 1650 | Values: 94.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 94.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.58 05:03:37 INFO - PROCESS | 1650 | Values: 87.0 85.0 85.0 88.0 87.0 84.0 88.0 84.0 87.0 86.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 05:03:37 INFO - PROCESS | 1650 | Values: 60.0 58.0 60.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:77.30 Median:72.00 stddev:12.71 (17.7%) stddev-sans-first:12.54 05:03:37 INFO - PROCESS | 1650 | Values: 64.0 75.0 65.0 72.0 72.0 72.0 82.0 99.0 100.0 72.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:99.20 Median:94.00 stddev:9.31 (9.9%) stddev-sans-first:9.84 05:03:37 INFO - PROCESS | 1650 | Values: 97.0 92.0 94.0 113.0 111.0 113.0 89.0 95.0 94.0 94.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:158.70 Median:153.00 stddev:22.16 (14.5%) stddev-sans-first:23.02 05:03:37 INFO - PROCESS | 1650 | Values: 146.0 145.0 143.0 144.0 163.0 143.0 158.0 148.0 204.0 193.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:182.00 stddev:2.13 (1.2%) stddev-sans-first:2.12 05:03:37 INFO - PROCESS | 1650 | Values: 183.0 177.0 179.0 182.0 182.0 180.0 182.0 181.0 179.0 184.0 05:03:37 INFO - PROCESS | 1650 | 05:03:37 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:70.50 stddev:7.69 (10.9%) stddev-sans-first:8.13 05:03:37 INFO - PROCESS | 1650 | Values: 75.0 85.0 89.0 71.0 69.0 70.0 68.0 68.0 68.0 68.0 05:03:37 INFO - PROCESS | 1650 | -------- Summary: end -------- 05:03:37 INFO - PROCESS | 1650 | 05:03:38 INFO - TEST-INFO | 1650: exit 0 05:03:38 INFO - TEST-OK | kraken | took 61046ms 05:03:38 INFO - SUITE-END | took 1182s 05:03:38 INFO - Completed test suite (00:19:42) 05:03:38 INFO - javascript benchmark 05:03:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7059.459774717193, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.662775408581, 3218.388506183825, 3229.5640088588034, 3248.886288979886, 3289.0461766087838, 5273.6835789852585, 5305.177697456896, 5309.123994540896, 5411.296531450906, 5486.286782718241, 5503.174523821429, 5505.201745746865, 5540.889182216353, 5556.499915007648, 5579.330480342354, 4912.164931961575, 4973.825916092928, 5026.52248036436, 5131.358580177478, 5139.974300128494, 5061.974690126544, 5112.642115051948, 5115.769790359424, 5150.845474635767, 5174.741262936857, 4923.975380123113, 4968.677035992685, 4977.203647416396, 5039.672421292605, 5068.645194836363, 5050.797968081272, 5073.315102461194, 5079.771410286546, 5160.174372100483, 5183.429822719498, 4994.126027945095, 5051.368578927634, 5069.264956581275, 5080.720560369178, 5089.796408143669, 5290.338707661543, 5338.546223571001, 5566.0, 5601.383847776741, 5606.074997625387, 5833.32916714579, 5867.14926335679, 5871.794487192928, 5872.442117998783, 5898.675572843492, 5774.047282198432, 5908.497777688902, 5909.793157239476, 5924.466797988159, 5930.377310382434, 5479.561635069185, 5482.095454250084, 5486.670799752028, 5491.945080549183, 5501.477359650827, 6036.366181550961, 6092.695365231721, 6096.146539484475, 6106.908396374058, 6127.908081378783, 5873.442023007808, 5887.175795388649, 5900.852478688067, 5904.0553511437965, 5916.26046744157, 6055.666938318347, 6060.727267272983, 6064.605800622945, 6067.271927368744, 6081.422264884829, 4975.278584605212, 6029.939700603026, 6072.696365181723, 6091.299500557493, 6092.969535152296, 5063.417706963673, 6102.938970610326, 6104.359042300494, 6113.449789518964, 6113.938860611337, 4752.738599377068, 4808.927866082012, 4809.927851082237, 4835.661503694708, 4839.467658557556, 4296.0548679290505, 4301.935470967938, 4399.274119770266, 4402.207602631493, 4406.1187762447, 5404.83785486436, 5475.4524547544925, 5504.532114770209, 5565.471280228372, 5571.359293681278, 5010.398752149766, 6165.630062196283, 6167.722452489649, 6173.69131543421, 6189.473894718999, 5668.206451096849, 5683.488486036276, 5690.687012214368, 5696.857578560569, 5714.371419143891, 5175.922361164586, 5231.241469986907, 5334.466553344634, 5341.225522299244, 5345.866353341197, 6121.026213050831, 6158.507319414526, 6196.907046394217, 6203.2556093269095, 6232.719527621177, 6137.478314343331, 6162.784302549389, 6165.876682466415, 6173.629582225081, 6180.196574445473, 6144.941444616104, 6209.906851397323, 6215.65813880241, 6215.906761398493, 6218.160548326099, 5832.358440571618, 5901.734421950937, 5994.28068631767, 6046.425589568984, 6047.667378294236, 6148.385161483816, 6152.507799376129, 6157.599756015845, 6159.137720719193, 6166.81499555014, 5882.088276317178, 5882.23530940975, 5888.735006924613, 5901.3213480450295, 5949.345571986992, 4738.668293219442, 5535.778568857361, 5585.972070139624, 5591.245181900392, 5857.707114644336, 5447.972760136174, 5492.093804522369, 5494.945050549603, 5500.917486237629, 5501.642393244426, 5632.690202038927, 5643.661380317194, 5659.603827732019, 5660.632058916322, 5664.49019588239, 5467.753951072291, 5509.917351239655, 5513.338399392099, 5524.944750552443, 5531.834044978657], "value": 5484.8623295892, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.45309261617604, 482.92514660227675, 491.668124016289, 517.8860650656854, 533.9813106541271, 34920.82539587302, 40441.0, 40747.9813004675, 40770.38844417336, 42362.72911812643, 36119.63880361195, 39420.21159576814, 40970.795146024226, 41335.0, 41397.58602413975, 7531.0, 7667.386609071261, 9346.205572526327, 9556.283278754086, 9609.471479068648, 7579.54522728638, 7663.195364486733, 7667.233276672344, 11198.66404007877, 11494.540218391254, 11449.771004579903, 11522.827157592643, 11542.884571154307, 11559.0, 11560.248583842023, 11405.54377824886, 11456.541738330416, 11466.598669046543, 11478.196526243166, 11480.024197943185, 7480.326770590673, 7657.864753033356, 11224.66326010221, 11329.98030177288, 11339.319640821577, 28540.715667795, 28838.42323153546, 28865.0, 39300.0, 40058.399124013165, 3774.131949651568, 3774.792386418746, 3777.7166712496673, 3777.9433308500393, 3820.9426858597144, 28495.572566411312, 28987.13038608845, 29932.251693707833, 30257.697423025707, 30903.845480772452, 3095.4428202923464, 3107.1046661536443, 3142.842857857121, 3206.695363940422, 3258.6904244096772, 434337.0, 436579.0, 437567.0, 438055.9999999968, 445316.0, 45561.77219113883, 52492.47507524876, 53555.92888142293, 55885.72057139688, 56345.43654563402, 46687.564681355216, 47587.762061190166, 47653.5234647656, 56250.71874640683, 56469.0, 12498.06264530164, 12703.30131842739, 14007.929960350337, 14379.137251764927, 14432.927835360966, 11010.614628487965, 11088.611898583511, 11097.83353249702, 11101.72245693848, 11105.66682999495, 13323.866761332456, 15360.539183824503, 15413.768793468107, 15422.922885385726, 15539.378424862878, 5702.401247868997, 6997.580145191305, 7129.322714342129, 7171.713131474787, 7214.747483838146, 768.2240936654019, 807.6284908941835, 834.1575009240711, 853.6585365853584, 860.5482121885934, 23238.883805580863, 23748.39792947887, 28417.43165136727, 29101.058193161312, 29296.26759331034, 997.9172597731398, 1001.3591301567003, 1008.7074748323051, 1047.5809676129456, 1051.9316244444087, 13904.652383690287, 14736.189509577076, 14803.555893323217, 15064.924675376773, 15278.15970121654, 562883.4953883054, 563055.0, 563125.0, 563760.0, 564034.0, 51081.46755597338, 53873.1919021215, 57261.0, 57527.71236143876, 57909.8418031637, 1330.381372661717, 1375.05121466188, 1384.5015794314038, 1384.8199734034713, 1388.3613537772535, 26120.0, 28198.577021344285, 28392.0, 28588.571171432028, 28669.0, 46619.53380466152, 46855.29717054179, 46940.53059469498, 46949.76525117353, 46980.530194698986, 494254.0, 502880.0, 505528.0, 505920.0, 516888.0, 34500.654993449745, 34999.12519683051, 35264.647353527165, 35512.46731299084, 35522.28955420929, 42261.36607950822, 42466.36300455434, 42691.0, 43119.35320970251, 43810.34284485799, 29906.85046574753, 34802.0, 34873.30253394969, 35976.82011589925, 36104.91685249447, 28439.00463483768, 34525.61897524171, 34630.480542791374, 35747.82126089353, 35841.64158358383, 34951.300973980884, 34988.97626772954, 35312.646873531965, 35422.114447137996, 35673.46489802707, 28781.712182878742, 30800.898760484513, 30955.948754081044, 31180.53229201609, 31191.660625453635, 22839.0, 22977.0, 23569.17507887216, 23589.882050589636, 23679.64480532759], "value": 18797.01657855984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.53362162809975, 390.19035501334736, 394.7986526871295, 400.8555573836697, 421.64581751328876, 13534.323283835818, 13751.174929504225, 16295.75556366654, 20244.59510809783, 20748.0, 20481.4879628009, 20715.274965376215, 21154.0, 21241.044153013114, 21272.89363553184, 5803.883922321551, 5850.970745146268, 5988.550858685594, 6065.939340606604, 6136.079588061782, 3861.2856621525107, 5959.344472108065, 6078.544109191828, 6088.238970128734, 6088.969555152218, 4050.4936882889638, 6312.747490100413, 6712.798616041527, 6732.427743641796, 6748.190217173946, 6469.320721324288, 6610.7355705771715, 6716.6305853178055, 6744.393004629558, 6770.390664840188, 5967.49276311514, 5968.880622387528, 5990.191324171225, 5992.460678538952, 5996.280446346423, 26309.473810523683, 26738.06416775423, 26828.0, 26855.73144268552, 27327.863360683266, 2621.5412302846926, 2662.8208135177088, 2690.3543149644142, 2707.9593806092726, 2711.8644067796727, 14925.776113358308, 15221.61945951349, 15332.693346133126, 15874.36502539897, 16021.519354419386, 1468.4126349460194, 1749.9825001749946, 1794.4078454110113, 1798.4784412520485, 1804.3233787329752, 90436.54781726115, 105589.99999999923, 115732.0, 122329.16506252413, 122450.0, 8766.923380627912, 10841.457927103771, 11021.669349919515, 11045.171612129123, 11196.66410007701, 14613.78079328811, 14626.122432654074, 14641.487547935983, 14643.80342948545, 14663.48677796272, 7880.763577092696, 8144.30773384269, 8149.551774652333, 8307.252347288773, 8312.127226641116, 7860.764177074697, 7884.960575197088, 8054.637541310655, 8057.35541156706, 8070.47541909774, 5972.761089556456, 6979.860402792017, 7037.733208022605, 7098.4445599584105, 7125.501214914906, 1883.4443839067508, 1932.3043704266454, 1933.7609504080608, 1937.86434949555, 1944.6791279438735, 797.7833803449786, 813.9784570364155, 851.9446235994641, 879.5338470610586, 892.6340200517757, 20200.000989614095, 20756.68864967027, 22126.446838829157, 22380.776192238194, 22564.984575694132, 805.5408417202138, 851.1445996773203, 905.9740466840783, 930.2465003347311, 930.4882314727008, 10345.586176552853, 10640.04239618438, 10688.946555267174, 10711.916759892565, 10730.570777168981, 541497.0, 636705.0, 638472.0, 648176.0, 653426.0, 143912.0, 145666.0, 153832.0, 153906.2112479051, 155811.22094389683, 963.4123184857092, 1027.209049032241, 1051.0, 1056.6460235820932, 1059.4120263253967, 17720.734188987433, 17909.641807163523, 18025.909870450563, 18079.0, 18556.44330670082, 47645.0, 52278.0, 54335.45664543304, 54463.72768136134, 54540.727296363264, 83274.58362708148, 83585.0, 85103.0, 85913.57043214743, 87468.56265718886, 7920.564368959763, 8058.637361318872, 8189.181081891763, 8242.928419305452, 8284.46151000183, 10553.314034587727, 12385.566505172275, 12486.313252770822, 12804.423800929168, 12895.48418063267, 10611.787764244518, 10642.680719578426, 11098.722531936766, 11214.943925280322, 11254.043406310555, 10896.727581810519, 10899.945500272448, 10946.39794811293, 11284.379359135326, 11310.208285419942, 11123.610673626385, 11162.888371116509, 11273.605423810128, 11494.942525287655, 11507.424628768695, 7906.888418022481, 8152.755417337489, 8157.959210203911, 8171.509709417454, 8199.71301004462, 9138.949020862687, 9835.901640983499, 9971.950140249251, 10206.846897296695, 10291.0], "value": 9798.69021305121, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.0424428084393, 1436.2962148547208, 1448.145594099481, 1455.8844073682321, 1461.751502244618, 8188.54962977036, 8552.657893684245, 8562.486250824939, 8575.0, 8599.269062129719, 8150.9592452037805, 8493.702720404786, 8506.447080939735, 8570.742877713663, 8605.91394086059, 1913.9617207655838, 2256.2103263857643, 2275.8975846086882, 2287.4167087392693, 2289.6679981402685, 2072.1504183284856, 2236.709227800384, 2267.682524446579, 2277.7152855893014, 2279.2250634784255, 2106.926257580985, 2223.2552095048177, 2256.4133325335365, 2277.829162812787, 2282.691836602054, 2232.765559616233, 2242.8878556072214, 2254.458929856839, 2257.6274914639066, 2273.283915566608, 1919.3474218765548, 2266.512699769541, 2267.0818318581, 2292.358139720881, 2292.86242825431, 8367.0, 8560.272376847975, 8561.657533698644, 8580.313574913991, 8595.140485951417, 5023.196288593844, 5188.896222075575, 5193.0, 5194.896102077937, 5201.817936372247, 3215.839208039612, 3278.704916557497, 3448.586169659657, 3488.3720930232525, 3498.038039539147, 1021.7088129882948, 1179.9469023893946, 1224.3082658298033, 1247.8065899785547, 1283.1210620724833, 9806.117449429514, 10183.439910804902, 10201.234907381902, 10849.945750271278, 10869.565217391295, 4030.1939612077704, 4103.7948102594755, 4114.136031433372, 4129.421880936671, 4223.915521689549, 8556.358273129541, 8627.870581941275, 8645.438046526955, 8649.264812491008, 8673.913260867437, 5005.449400565934, 5008.6243531734535, 5012.774425150877, 5019.247112933016, 5020.3724534433195, 4138.089620283533, 4471.5081341052455, 4633.837815676435, 4637.582617564435, 4644.303354496852, 2948.6461624605186, 3001.2646901508833, 3472.385340816482, 3480.9477857832153, 3561.4835848801777, 1092.5848177692426, 1104.8342748587615, 1108.8225883858706, 1123.5505797680994, 1127.1377396291844, 802.8233788566506, 834.8789425533264, 840.3865178419787, 865.1002956924854, 869.3914260018013, 4990.216718266254, 5149.4578076200905, 5153.742312884341, 5372.758225879845, 5381.973090134603, 942.9815798937268, 947.6304241345881, 962.7448726087592, 969.1762002298132, 1001.2790790630734, 3635.781853088823, 3641.417373220272, 3657.9634203658156, 3778.7165962552917, 3779.7543159694533, 9798.608055677836, 10097.848532272023, 10100.949495252476, 10108.24188185889, 10146.188304935587, 9326.72019839406, 9823.508824558743, 10036.24728145392, 10054.74863128413, 10118.443485608363, 7482.738104166328, 7659.502132361378, 7668.961655191688, 7695.92304076952, 7704.961475192588, 5570.080936645408, 5599.0, 5601.80393686219, 5771.59598828078, 5948.345681975065, 9250.814983700153, 9365.438073715599, 9374.062593740844, 9391.013943536103, 9423.38747981379, 7417.8145546361775, 8355.908313923645, 8710.651573937224, 9215.539223038688, 9465.763355916157, 6445.871082578228, 7071.858562828817, 7248.166460857069, 7255.056842610426, 7331.04696389466, 7667.386609071373, 7990.680372785024, 8045.758627241192, 8139.14538973423, 8140.389470789596, 7106.538075025107, 7113.324234197743, 7195.712171513081, 7235.312645298688, 7334.0, 6971.093757811452, 7002.544834585736, 7027.9297207027275, 7074.540154890122, 7091.2554181810165, 5299.973500132474, 6215.564910456224, 6282.057691346335, 6286.045558587457, 6342.841428964312, 3965.266425711253, 4144.52337981136, 4862.343583616308, 4896.0, 5028.044671512401, 4669.41632295963, 4882.60939124862, 4917.322226595384, 4935.457099718957, 5034.622403319692], "value": 4303.132569618691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.5211560162577, 360.9079684680408, 362.41650941983403, 364.8175912043978, 368.12019273935283, 4533.637309015279, 4797.385424943405, 5087.847364579059, 5144.382674079106, 5205.297284866547, 4163.20899029185, 4405.757683327416, 4877.561019508244, 4908.067467181242, 5068.366454193226, 3358.085891042107, 3881.9805900970528, 3897.13560533008, 3907.6678482329035, 3909.198614284065, 3883.533975922893, 3884.747491413049, 3893.552241492236, 3899.8245078971513, 3907.1599606084687, 3251.2847173621767, 3561.465780132975, 3828.923421531568, 3874.593167717377, 3884.6309600587897, 3723.585037685662, 3806.619338066199, 3843.500344955166, 3879.8836034918854, 3899.3566061599804, 2791.916242512728, 3341.4319565673895, 3346.2136397946465, 3363.1423986883433, 3373.2747459296124, 4970.179920313144, 4971.1606705518825, 4985.426675932242, 4985.825496107619, 4988.950110498885, 4216.367544868263, 4405.647548196169, 4425.336199570058, 4429.645628349725, 4432.268675668511, 4333.569921925757, 5283.498067683564, 5319.9202011969855, 5386.326709161355, 5391.622586418952, 3528.188516641187, 3694.8891533254045, 3720.102747598717, 3722.981385093084, 3797.696184305249, 4383.60547550722, 5356.678599284017, 5487.451254874481, 5528.668279903179, 5618.578606604521, 3368.7136593389346, 3583.2654305867236, 3684.428913518409, 3693.926121477555, 3695.7043436525014, 3370.2753907909428, 3796.259729352805, 3805.5623603285976, 3816.37029890065, 3825.3114439401174, 4342.656154760816, 4399.560043995575, 4409.536998615164, 4409.823607055746, 4414.624756895636, 4352.499462561846, 4449.688521803443, 4556.70134011805, 5395.514403703685, 5440.863978400572, 1122.8371886076472, 1220.9816852747215, 1234.8086046662781, 1240.4046057892263, 1243.2664727810636, 776.9162018983599, 800.7877912353231, 833.1959658929042, 844.3540691371106, 851.1573542193184, 4264.360345948133, 4839.2983017462975, 4845.3216549683075, 4857.0, 4879.634027447955, 4821.180399332122, 4951.935333903228, 5077.746112694351, 5224.0, 5344.75948582307, 4333.393324934512, 4412.271975124068, 4549.249373853343, 4643.908681459854, 4772.880677983008, 2331.936236430771, 2566.294269075982, 2616.9869150654126, 2754.614353990443, 2764.9769585253184, 4568.771561421916, 5451.64564303319, 5472.835814925558, 5499.285092937893, 5500.58745594082, 4659.860204193879, 4819.7108173509005, 5160.071187186268, 5309.628326017219, 5401.351837779492, 4531.229690952546, 4645.976770116195, 5159.8452046439415, 5588.748506317225, 5594.398604648858, 4485.327200919888, 4500.797464114057, 5227.607929405386, 5233.398159211587, 5244.396894357198, 4094.467719196485, 4363.036633514995, 4978.5270399312, 5262.763175657181, 5297.867553311198, 4893.1436998524405, 5006.4743201963265, 5454.790809722069, 5460.5085542301385, 5523.364813046391, 3389.2714715495767, 3449.534312867731, 3528.788272703646, 3532.0, 3548.9645103548633, 4153.480814898137, 4652.744099074584, 4744.935952860516, 4756.33411322422, 5042.4705405931845, 4682.555157260055, 5355.464453554613, 5367.665065696278, 5418.620696551204, 5482.506574408322, 4537.682362234612, 4880.6095512358215, 5096.286519887145, 5364.517193452608, 5429.5656347492895, 4976.427710813303, 5282.735863206901, 5303.068146623677, 5308.442613525679, 5312.760925758273, 4662.603678687214, 5333.226682130991, 5361.847202851406, 5372.785088596413, 5488.490665066979, 5250.973745131403, 5270.868228294324, 5271.71005594696, 5288.524032837063, 5306.28365170697], "value": 3839.6325280981314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.5621486570893, 711.3988679565772, 737.852429514097, 808.216030450463, 808.6159074439641, 16584.33662653494, 17475.912620436913, 17501.91249043753, 17533.824661753377, 17535.947843129423, 15973.520794376158, 16064.0, 16071.0, 16094.678106437865, 16129.919350403232, 877.675260153744, 910.4537277633433, 913.9040400757891, 915.199200699388, 916.8991410944791, 870.490762903699, 900.5992333411634, 916.8670542771295, 920.2775820980531, 922.0594993107027, 956.4882787708577, 958.8561715742625, 960.346964064436, 961.7547525381018, 963.9710808675716, 951.6098399656108, 952.5189779161514, 956.0344052506948, 956.3449037409397, 958.7267628725849, 710.5772065620947, 710.6695386645234, 711.274500009992, 711.9181294151135, 712.6258714175048, 15048.924755376152, 15424.228788560527, 15504.0, 15604.765928511082, 15614.0, 13781.931090344584, 13909.956753243547, 13943.651408714763, 14018.369173387222, 14130.36413361391, 11032.757842081435, 11543.307401555934, 11622.6513204604, 11981.221220620631, 12125.27248365092, 3555.2356243407535, 3616.6021737608844, 3620.981895090508, 3642.435422509489, 3644.8177591120602, 78079.60960195163, 95392.0, 96521.0, 98350.0, 98902.0, 10292.419873156523, 10668.839967400496, 10712.892871071346, 10732.73168170802, 11000.779984400267, 21761.34715958524, 21769.0, 21804.89097554534, 21828.126874925143, 21903.0, 6826.0, 7610.353119984753, 7659.387249020065, 7662.9233707663325, 7698.2686644768655, 3726.9564521933903, 4114.485689288839, 4232.915341693149, 4247.723897946624, 4408.669349798778, 3551.94672079919, 3655.5377848860667, 3661.761985470936, 3665.5051568038507, 3666.834992425347, 664.8404382948154, 675.0515525686418, 679.6533767778468, 699.0737273113044, 702.6416527570975, 641.9486441084701, 661.9304972977768, 678.8879834827297, 681.9215790184193, 687.4500399680236, 9454.43273403598, 9526.237900967906, 9561.378510396802, 9763.90236097644, 9854.211663066937, 636.5798572941836, 680.4726337088796, 682.5430681699842, 689.3898899474002, 691.4641153106382, 4494.887627809266, 4696.81212751493, 4780.665353425296, 4828.975855120772, 4863.732494712754, 87638.0, 92601.0, 92841.0, 94041.0, 95437.0, 50281.0, 56347.71826140843, 56531.0, 57095.0, 84361.31277374418, 60934.0, 73338.0, 74725.0, 75903.9999999989, 76700.61649691939, 10141.695749127539, 10358.664914167375, 10579.047885690325, 10679.412632304988, 10710.571577136827, 47142.057158857315, 47303.763481182374, 47835.76082119567, 48509.75745121393, 49405.0, 51988.220176696625, 57106.7144664274, 62471.0, 64811.0, 65623.34376656172, 12446.626601201979, 12498.629208330338, 12748.808767868304, 12802.487900483877, 12904.419301131284, 14192.92903535517, 14264.643383915485, 14335.641608959442, 14363.497277595234, 15162.3176957035, 13062.150960187557, 13123.212607243597, 13286.0, 13426.731465370443, 13669.453221871412, 13199.670008249486, 13215.273159975908, 13374.97830990811, 13416.798748018593, 13741.0, 12801.871981280441, 13142.474301027853, 13227.669308266984, 13320.467181312639, 13337.466501339837, 9682.370645907993, 10761.354318740901, 10782.191335650015, 10819.67540973772, 11234.0, 9152.908470915472, 9481.952590237004, 10803.783924321313, 10943.671689849318, 11107.777844443228], "value": 7414.496314433899, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 114.0, 153.0, 113.0, 113.0, 110.0, 115.0, 135.0, 111.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 186.0, 185.0, 180.0, 184.0, 185.0, 184.0, 185.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 60.0, 94.0, 82.0, 84.0, 83.0, 60.0, 78.0, 61.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 88.0, 68.0, 70.0, 70.0, 87.0, 69.0, 68.0, 86.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 87.0, 88.0, 87.0, 87.0, 86.0, 87.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 88.0, 87.0, 84.0, 88.0, 84.0, 87.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 60.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 65.0, 72.0, 72.0, 72.0, 82.0, 99.0, 100.0, 72.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 92.0, 94.0, 113.0, 111.0, 113.0, 89.0, 95.0, 94.0, 94.0], "value": 99.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 143.0, 144.0, 163.0, 143.0, 158.0, 148.0, 204.0, 193.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 177.0, 179.0, 182.0, 182.0, 180.0, 182.0, 181.0, 179.0, 184.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 85.0, 89.0, 71.0, 69.0, 70.0, 68.0, 68.0, 68.0, 68.0], "value": 73.1, "unit": "score"}]}]} 05:03:38 INFO - Return code: 0 05:03:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:03:38 ERROR - # TBPL SUCCESS # 05:03:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:38 INFO - 2017-02-14 05:03:38.860 screenresolution[1654:10867] starting screenresolution argv=screenresolution get 05:03:38 INFO - 2017-02-14 05:03:38.863 screenresolution[1654:10867] Display 0: 1600x1200x32@60 05:03:38 INFO - 2017-02-14 05:03:38.869 screenresolution[1655:10870] starting screenresolution argv=screenresolution list 05:03:38 INFO - Available Modes on Display 0 05:03:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:39 INFO - Intel Iris: 05:03:39 INFO - Chipset Model: Intel Iris 05:03:39 INFO - Type: GPU 05:03:39 INFO - Bus: Built-In 05:03:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:39 INFO - Vendor: Intel (0x8086) 05:03:39 INFO - Device ID: 0x0a2e 05:03:39 INFO - Revision ID: 0x0009 05:03:39 INFO - Displays: 05:03:39 INFO - Display: 05:03:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:39 INFO - Display Serial Number: 1600x1200 60 05:03:39 INFO - Main Display: Yes 05:03:39 INFO - Mirror: Off 05:03:39 INFO - Online: Yes 05:03:39 INFO - Rotation: Supported 05:03:39 INFO - Return code: 0 05:03:39 INFO - Running post-action listener: _resource_record_post_action 05:03:39 INFO - [mozharness: 2017-02-14 13:03:39.111841Z] Finished run-tests step (success) 05:03:39 INFO - Running post-run listener: _resource_record_post_run 05:03:39 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 32627712; Write bytes: 553936384; Read time: 200; Write time: 1643 05:03:39 INFO - TinderboxPrint: CPU usage
53.8% 05:03:39 INFO - TinderboxPrint: I/O read bytes / time
32,627,712 / 200 05:03:39 INFO - TinderboxPrint: I/O write bytes / time
553,936,384 / 1,643 05:03:39 INFO - TinderboxPrint: CPU idle
2,225.4 (46.2%) 05:03:39 INFO - TinderboxPrint: CPU system
960.9 (19.9%) 05:03:39 INFO - TinderboxPrint: CPU user
1,635.5 (33.9%) 05:03:39 INFO - TinderboxPrint: Swap in / out
281,604,096 / 0 05:03:39 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 242911744; Write bytes: 236730368; Read time: 17705; Write time: 493 05:03:39 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 30804992; Write bytes: 297831936; Read time: 183; Write time: 1104 05:03:39 INFO - Running post-run listener: _upload_blobber_files 05:03:39 INFO - Blob upload gear active. 05:03:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:03:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:41 INFO - (blobuploader) - INFO - Done attempting. 05:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:42 INFO - (blobuploader) - INFO - Done attempting. 05:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:43 INFO - (blobuploader) - INFO - Done attempting. 05:03:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:45 INFO - (blobuploader) - INFO - Done attempting. 05:03:45 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:45 INFO - Return code: 0 05:03:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/422bbeb37cefd64326432462760441c53e0bb9392fc287701c8fca086c6b2f3a4f0d2d0994514a7532dae1ecb0eb62e9f2a23259ac24065c067333bfa9d103d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf495f4e3a7cbb9ac84811a15767449e31270c38914cf0f36b33b0b4594381c0bf44c6e78f765add0f7180f567c055a56dca81768a33ef3a5271eb2466e02cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/084da4cb075468786e69dbd6eacec3824e8a033c3cef82061d60216a7fcdf0b9b771216a07afd5361d3bcee715d6fe950cc11e2dab17b298d71cd40daae8a9ee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef373a9e945b2c64ff1e1e56d85d4322c128311edfc3ded80c5e665ba0ca83fc1ac72b7e045e6551fd290805b5b25b1e949569c9371b50d580c747ff62874799"} 05:03:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:45 INFO - Contents: 05:03:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/422bbeb37cefd64326432462760441c53e0bb9392fc287701c8fca086c6b2f3a4f0d2d0994514a7532dae1ecb0eb62e9f2a23259ac24065c067333bfa9d103d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf495f4e3a7cbb9ac84811a15767449e31270c38914cf0f36b33b0b4594381c0bf44c6e78f765add0f7180f567c055a56dca81768a33ef3a5271eb2466e02cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/084da4cb075468786e69dbd6eacec3824e8a033c3cef82061d60216a7fcdf0b9b771216a07afd5361d3bcee715d6fe950cc11e2dab17b298d71cd40daae8a9ee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef373a9e945b2c64ff1e1e56d85d4322c128311edfc3ded80c5e665ba0ca83fc1ac72b7e045e6551fd290805b5b25b1e949569c9371b50d580c747ff62874799"} 05:03:45 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:45 INFO - Copying logs to upload dir... 05:03:45 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.235223 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-02-14 05:03:45.680514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 05:03:45.684522) ========= 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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/422bbeb37cefd64326432462760441c53e0bb9392fc287701c8fca086c6b2f3a4f0d2d0994514a7532dae1ecb0eb62e9f2a23259ac24065c067333bfa9d103d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf495f4e3a7cbb9ac84811a15767449e31270c38914cf0f36b33b0b4594381c0bf44c6e78f765add0f7180f567c055a56dca81768a33ef3a5271eb2466e02cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/084da4cb075468786e69dbd6eacec3824e8a033c3cef82061d60216a7fcdf0b9b771216a07afd5361d3bcee715d6fe950cc11e2dab17b298d71cd40daae8a9ee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef373a9e945b2c64ff1e1e56d85d4322c128311edfc3ded80c5e665ba0ca83fc1ac72b7e045e6551fd290805b5b25b1e949569c9371b50d580c747ff62874799"} build_url:https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010527 build_url: 'https://queue.taskcluster.net/v1/task/Q3l3u-BSQIyRjUqwP22MhA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/422bbeb37cefd64326432462760441c53e0bb9392fc287701c8fca086c6b2f3a4f0d2d0994514a7532dae1ecb0eb62e9f2a23259ac24065c067333bfa9d103d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf495f4e3a7cbb9ac84811a15767449e31270c38914cf0f36b33b0b4594381c0bf44c6e78f765add0f7180f567c055a56dca81768a33ef3a5271eb2466e02cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/084da4cb075468786e69dbd6eacec3824e8a033c3cef82061d60216a7fcdf0b9b771216a07afd5361d3bcee715d6fe950cc11e2dab17b298d71cd40daae8a9ee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef373a9e945b2c64ff1e1e56d85d4322c128311edfc3ded80c5e665ba0ca83fc1ac72b7e045e6551fd290805b5b25b1e949569c9371b50d580c747ff62874799"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 05:03:45.718541) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:03:45.718870) ========= 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.Ubr5khyJkU/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.bxk1Vtt3tu/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:03:45.767071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 05:03:45.767399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 05:03:45.767816) ========= ========= Total master_lag: 2.26 =========