builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0314 starttime: 1487156381.69 results: success (0) buildid: 20170209170211 builduid: eadb590b78a6436a8ffabcb183f51b85 revision: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:41.687458) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:41.687956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:41.688270) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:41.714927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:41.715295) ========= 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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-15 02:59:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2017-02-15 02:59:41 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140500 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:41.879556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:41.879865) ========= 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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.029953 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:41.932267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-15 02:59:41.932636) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 25a94c1047e793ef096d8556fa3c26dd72bd37d7 --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 25a94c1047e793ef096d8556fa3c26dd72bd37d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-15 02:59:42,027 truncating revision to first 12 chars 2017-02-15 02:59:42,027 Setting DEBUG logging. 2017-02-15 02:59:42,027 attempt 1/10 2017-02-15 02:59:42,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/25a94c1047e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 02:59:42,743 unpacking tar archive at: mozilla-central-25a94c1047e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.994904 ========= master_lag: 1.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-15 02:59:44.475029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:44.475367) ========= script_repo_revision: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:44.475763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:44.476027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 02:59:44.503685) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-15 02:59:44.504006) ========= /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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 02:59:44 INFO - MultiFileLogger online at 20170215 02:59:44 in /builds/slave/test 02:59:44 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 02:59:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:44 INFO - {'append_to_log': False, 02:59:44 INFO - 'base_work_dir': '/builds/slave/test', 02:59:44 INFO - 'blob_upload_branch': 'Firefox', 02:59:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:44 INFO - 'branch': 'Firefox', 02:59:44 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:44 INFO - 'config_files': ('talos/mac_config.py',), 02:59:44 INFO - 'default_actions': ('clobber', 02:59:44 INFO - 'read-buildbot-config', 02:59:44 INFO - 'download-and-extract', 02:59:44 INFO - 'populate-webroot', 02:59:44 INFO - 'create-virtualenv', 02:59:44 INFO - 'install', 02:59:44 INFO - 'run-tests'), 02:59:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:44 INFO - 'download_minidump_stackwalk': True, 02:59:44 INFO - 'download_symbols': 'ondemand', 02:59:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:44 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:44 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:44 INFO - 'installer_path': 'installer.exe', 02:59:44 INFO - 'log_level': 'info', 02:59:44 INFO - 'log_name': 'talos', 02:59:44 INFO - 'log_to_console': True, 02:59:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:59:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:59:44 INFO - 'opt_config_files': (), 02:59:44 INFO - 'pip_index': False, 02:59:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:59:44 INFO - 'cmd': ('bash', 02:59:44 INFO - '-c', 02:59:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:59:44 INFO - 'enabled': True, 02:59:44 INFO - 'halt_on_failure': False, 02:59:44 INFO - 'name': 'check_screen_resolution'},), 02:59:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:59:44 INFO - 'cmd': ('bash', 02:59:44 INFO - '-c', 02:59:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:59:44 INFO - 'enabled': True, 02:59:44 INFO - 'halt_on_failure': False, 02:59:44 INFO - 'name': 'check_screen_resolution'},), 02:59:44 INFO - 'run_cmd_checks_enabled': True, 02:59:44 INFO - 'sps_profile': False, 02:59:44 INFO - 'sps_profile_interval': 0, 02:59:44 INFO - 'suite': 'dromaeojs', 02:59:44 INFO - 'system_bits': '32', 02:59:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:44 INFO - 'title': 't-yosemite-r7-0314', 02:59:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:44 INFO - 'use_talos_json': True, 02:59:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:44 INFO - 'work_dir': 'build'} 02:59:44 INFO - [mozharness: 2017-02-15 10:59:44.702089Z] Running clobber step. 02:59:44 INFO - Running pre-action listener: _resource_record_pre_action 02:59:44 INFO - Running main action method: clobber 02:59:44 INFO - rmtree: /builds/slave/test/build 02:59:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:47 INFO - Running post-action listener: _resource_record_post_action 02:59:47 INFO - [mozharness: 2017-02-15 10:59:47.100345Z] Finished clobber step (success) 02:59:47 INFO - [mozharness: 2017-02-15 10:59:47.100561Z] Running read-buildbot-config step. 02:59:47 INFO - Running pre-action listener: _resource_record_pre_action 02:59:47 INFO - Running main action method: read_buildbot_config 02:59:47 INFO - Using buildbot properties: 02:59:47 INFO - { 02:59:47 INFO - "project": "", 02:59:47 INFO - "product": "firefox", 02:59:47 INFO - "script_repo_revision": "production", 02:59:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:59:47 INFO - "repository": "", 02:59:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:59:47 INFO - "buildid": "20170209170211", 02:59:47 INFO - "pgo_build": "False", 02:59:47 INFO - "basedir": "/builds/slave/test", 02:59:47 INFO - "buildnumber": 36, 02:59:47 INFO - "slavename": "t-yosemite-r7-0314", 02:59:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:59:47 INFO - "platform": "yosemite_r7", 02:59:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:59:47 INFO - "branch": "mozilla-central", 02:59:47 INFO - "repo_path": "mozilla-central", 02:59:47 INFO - "revision": "25a94c1047e793ef096d8556fa3c26dd72bd37d7", 02:59:47 INFO - "stage_platform": "macosx64", 02:59:47 INFO - "builduid": "eadb590b78a6436a8ffabcb183f51b85", 02:59:47 INFO - "slavebuilddir": "test" 02:59:47 INFO - } 02:59:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 02:59:47 INFO - Running post-action listener: _resource_record_post_action 02:59:47 INFO - [mozharness: 2017-02-15 10:59:47.103820Z] Finished read-buildbot-config step (success) 02:59:47 INFO - [mozharness: 2017-02-15 10:59:47.103969Z] Running download-and-extract step. 02:59:47 INFO - Running pre-action listener: _resource_record_pre_action 02:59:47 INFO - Running main action method: download_and_extract 02:59:47 INFO - mkdir: /builds/slave/test/build/tests 02:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:47 INFO - trying https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 02:59:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/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 02:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/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 02:59:48 INFO - Downloaded 1199 bytes. 02:59:48 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 02:59:48 INFO - Using the following test package requirements: 02:59:48 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 02:59:48 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:59:48 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 02:59:48 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:59:48 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 02:59:48 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:59:48 INFO - u'jsshell-mac.zip'], 02:59:48 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:59:48 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 02:59:48 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 02:59:48 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:59:48 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 02:59:48 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:59:48 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 02:59:48 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:59:48 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 02:59:48 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:59:48 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 02:59:48 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:59:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 02:59:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:59:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 02:59:49 INFO - Expected file size: 34949027 02:59:49 INFO - Obtained file size: 34949027 02:59:55 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 02:59:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 02:59:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:59:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 02:59:57 INFO - Expected file size: 34949027 02:59:57 INFO - Obtained file size: 34949027 03:00:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 03:00:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:00:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 03:00:04 INFO - Expected file size: 14403454 03:00:04 INFO - Obtained file size: 14403454 03:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:05 INFO - trying https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 03:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/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 03:00:07 INFO - Downloaded 70348678 bytes. 03:00:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:07 INFO - mkdir: /builds/slave/test/properties 03:00:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:07 INFO - Contents: 03:00:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:08 INFO - Running post-action listener: _resource_record_post_action 03:00:08 INFO - Running post-action listener: set_extra_try_arguments 03:00:08 INFO - [mozharness: 2017-02-15 11:00:08.063955Z] Finished download-and-extract step (success) 03:00:08 INFO - [mozharness: 2017-02-15 11:00:08.064105Z] Running populate-webroot step. 03:00:08 INFO - Running pre-action listener: _resource_record_pre_action 03:00:08 INFO - Running main action method: populate_webroot 03:00:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:08 INFO - '--tppagecycles', 03:00:08 INFO - '7'], 03:00:08 INFO - 'tests': ['tsvgm']}}, 03:00:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:00:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['damp', 'tps']}, 03:00:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'tests': ['damp', 'tps']}, 03:00:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['dromaeo_dom']}, 03:00:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['basic_compositor_video']}, 03:00:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:00:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['tsvgx', 03:00:08 INFO - 'tsvgr_opacity', 03:00:08 INFO - 'tart', 03:00:08 INFO - 'tscrollx', 03:00:08 INFO - 'cart', 03:00:08 INFO - 'tsvg_static']}, 03:00:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:08 INFO - 'tsvgr_opacity', 03:00:08 INFO - 'tart', 03:00:08 INFO - 'tscrollx', 03:00:08 INFO - 'cart', 03:00:08 INFO - 'tsvg_static']}, 03:00:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['tp5o']}, 03:00:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:00:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--disable-e10s', 03:00:08 INFO - '--xperf_path', 03:00:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:08 INFO - 'tests': ['tp5n']}, 03:00:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--xperf_path', 03:00:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:08 INFO - 'tests': ['tp5n']}}, 03:00:08 INFO - 'talos.zip': {'path': '', 03:00:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:08 INFO - Running post-action listener: _resource_record_post_action 03:00:08 INFO - [mozharness: 2017-02-15 11:00:08.082261Z] Finished populate-webroot step (success) 03:00:08 INFO - [mozharness: 2017-02-15 11:00:08.082360Z] Running create-virtualenv step. 03:00:08 INFO - Running pre-action listener: _resource_record_pre_action 03:00:08 INFO - Running main action method: create_virtualenv 03:00:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:00:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:08 INFO - Using real prefix '/tools/python27' 03:00:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:11 INFO - Installing pip.................done. 03:00:11 INFO - Return code: 0 03:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:00:12 INFO - Reading from file tmpfile_stdout 03:00:12 INFO - Output received: 03:00:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:00:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:12 INFO - 'HOME': '/Users/cltbld', 03:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:12 INFO - 'LOGNAME': 'cltbld', 03:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:12 INFO - 'MOZ_NO_REMOTE': '1', 03:00:12 INFO - 'NO_EM_RESTART': '1', 03:00:12 INFO - 'PAGER': '/bin/cat', 03:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:12 INFO - 'PWD': '/builds/slave/test', 03:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:12 INFO - 'SHELL': '/bin/bash', 03:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:12 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:12 INFO - 'USER': 'cltbld', 03:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:12 INFO - 'XPC_FLAGS': '0x0', 03:00:12 INFO - 'XPC_SERVICE_NAME': '0', 03:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:00:12 INFO - Cleaning up... 03:00:12 INFO - Return code: 0 03:00:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:12 INFO - 'HOME': '/Users/cltbld', 03:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:12 INFO - 'LOGNAME': 'cltbld', 03:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:12 INFO - 'MOZ_NO_REMOTE': '1', 03:00:12 INFO - 'NO_EM_RESTART': '1', 03:00:12 INFO - 'PAGER': '/bin/cat', 03:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:12 INFO - 'PWD': '/builds/slave/test', 03:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:12 INFO - 'SHELL': '/bin/bash', 03:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:12 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:12 INFO - 'USER': 'cltbld', 03:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:12 INFO - 'XPC_FLAGS': '0x0', 03:00:12 INFO - 'XPC_SERVICE_NAME': '0', 03:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:12 INFO - Downloading/unpacking psutil>=3.1.1 03:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:16 INFO - Installing collected packages: psutil 03:00:16 INFO - Running setup.py install for psutil 03:00:16 INFO - building 'psutil._psutil_osx' extension 03:00:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:00:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:00:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:00:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:00:16 INFO - building 'psutil._psutil_posix' extension 03:00:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:00:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:00:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:00:16 INFO - ^ 03:00:17 INFO - 1 warning generated. 03:00:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:00:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:17 INFO - Successfully installed psutil 03:00:17 INFO - Cleaning up... 03:00:17 INFO - Return code: 0 03:00:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:00:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:17 INFO - 'HOME': '/Users/cltbld', 03:00:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:17 INFO - 'LOGNAME': 'cltbld', 03:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:17 INFO - 'MOZ_NO_REMOTE': '1', 03:00:17 INFO - 'NO_EM_RESTART': '1', 03:00:17 INFO - 'PAGER': '/bin/cat', 03:00:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:17 INFO - 'PWD': '/builds/slave/test', 03:00:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:17 INFO - 'SHELL': '/bin/bash', 03:00:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:17 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:17 INFO - 'USER': 'cltbld', 03:00:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:17 INFO - 'XPC_FLAGS': '0x0', 03:00:17 INFO - 'XPC_SERVICE_NAME': '0', 03:00:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:20 INFO - Installing collected packages: mozsystemmonitor 03:00:20 INFO - Running setup.py install for mozsystemmonitor 03:00:20 INFO - Successfully installed mozsystemmonitor 03:00:20 INFO - Cleaning up... 03:00:20 INFO - Return code: 0 03:00:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:00:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:20 INFO - 'HOME': '/Users/cltbld', 03:00:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:20 INFO - 'LOGNAME': 'cltbld', 03:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:20 INFO - 'MOZ_NO_REMOTE': '1', 03:00:20 INFO - 'NO_EM_RESTART': '1', 03:00:20 INFO - 'PAGER': '/bin/cat', 03:00:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:20 INFO - 'PWD': '/builds/slave/test', 03:00:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:20 INFO - 'SHELL': '/bin/bash', 03:00:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:20 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:20 INFO - 'USER': 'cltbld', 03:00:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:20 INFO - 'XPC_FLAGS': '0x0', 03:00:20 INFO - 'XPC_SERVICE_NAME': '0', 03:00:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:20 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:23 INFO - warning: no files found matching '*.txt' 03:00:23 INFO - no previously-included directories found matching 'build' 03:00:23 INFO - no previously-included directories found matching 'dist' 03:00:23 INFO - no previously-included directories found matching '.git*' 03:00:23 INFO - Installing collected packages: jsonschema, functools32 03:00:23 INFO - Running setup.py install for functools32 03:00:24 INFO - warning: no files found matching '*.txt' 03:00:24 INFO - no previously-included directories found matching 'build' 03:00:24 INFO - no previously-included directories found matching 'dist' 03:00:24 INFO - no previously-included directories found matching '.git*' 03:00:24 INFO - Successfully installed jsonschema functools32 03:00:24 INFO - Cleaning up... 03:00:24 INFO - Return code: 0 03:00:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:24 INFO - 'HOME': '/Users/cltbld', 03:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:24 INFO - 'LOGNAME': 'cltbld', 03:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:24 INFO - 'MOZ_NO_REMOTE': '1', 03:00:24 INFO - 'NO_EM_RESTART': '1', 03:00:24 INFO - 'PAGER': '/bin/cat', 03:00:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:24 INFO - 'PWD': '/builds/slave/test', 03:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:24 INFO - 'SHELL': '/bin/bash', 03:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:24 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:24 INFO - 'USER': 'cltbld', 03:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:24 INFO - 'XPC_FLAGS': '0x0', 03:00:24 INFO - 'XPC_SERVICE_NAME': '0', 03:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:00:24 INFO - Cleaning up... 03:00:24 INFO - Return code: 0 03:00:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:24 INFO - 'HOME': '/Users/cltbld', 03:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:24 INFO - 'LOGNAME': 'cltbld', 03:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:24 INFO - 'MOZ_NO_REMOTE': '1', 03:00:24 INFO - 'NO_EM_RESTART': '1', 03:00:24 INFO - 'PAGER': '/bin/cat', 03:00:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:24 INFO - 'PWD': '/builds/slave/test', 03:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:24 INFO - 'SHELL': '/bin/bash', 03:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:24 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:24 INFO - 'USER': 'cltbld', 03:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:24 INFO - 'XPC_FLAGS': '0x0', 03:00:24 INFO - 'XPC_SERVICE_NAME': '0', 03:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:28 INFO - Downloading docopt-0.6.1.tar.gz 03:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:28 INFO - Running setup.py install for blobuploader 03:00:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:28 INFO - Running setup.py install for requests 03:00:29 INFO - Running setup.py install for docopt 03:00:29 INFO - Successfully installed blobuploader requests docopt 03:00:29 INFO - Cleaning up... 03:00:29 INFO - Return code: 0 03:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:29 INFO - 'HOME': '/Users/cltbld', 03:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:29 INFO - 'LOGNAME': 'cltbld', 03:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:29 INFO - 'MOZ_NO_REMOTE': '1', 03:00:29 INFO - 'NO_EM_RESTART': '1', 03:00:29 INFO - 'PAGER': '/bin/cat', 03:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:29 INFO - 'PWD': '/builds/slave/test', 03:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:29 INFO - 'SHELL': '/bin/bash', 03:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:29 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:29 INFO - 'USER': 'cltbld', 03:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:29 INFO - 'XPC_FLAGS': '0x0', 03:00:29 INFO - 'XPC_SERVICE_NAME': '0', 03:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-rUInOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-6G82w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-j9p9U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-s39VZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-YBYUFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-EZOGFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-DGK7ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-9Y572q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-KyK3aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-1rit4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tMmAjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:30 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-8_iR2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:31 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-SCwydO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:31 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-1ejYis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:31 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-JM9dzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:31 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-sv3nzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:31 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-GcEMar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:31 INFO - Running setup.py install for manifestparser 03:00:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:31 INFO - Running setup.py install for mozcrash 03:00:31 INFO - Running setup.py install for mozdebug 03:00:31 INFO - Running setup.py install for mozdevice 03:00:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:32 INFO - Running setup.py install for mozfile 03:00:32 INFO - Running setup.py install for mozhttpd 03:00:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:32 INFO - Running setup.py install for mozinfo 03:00:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:32 INFO - Running setup.py install for mozInstall 03:00:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:32 INFO - Running setup.py install for mozleak 03:00:32 INFO - Running setup.py install for mozlog 03:00:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:33 INFO - Running setup.py install for moznetwork 03:00:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:33 INFO - Running setup.py install for mozprocess 03:00:33 INFO - Running setup.py install for mozprofile 03:00:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:33 INFO - Running setup.py install for mozrunner 03:00:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:33 INFO - Running setup.py install for mozscreenshot 03:00:33 INFO - Running setup.py install for moztest 03:00:34 INFO - Running setup.py install for mozversion 03:00:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:34 INFO - Cleaning up... 03:00:34 INFO - Return code: 0 03:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:34 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 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:34 INFO - 'HOME': '/Users/cltbld', 03:00:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:34 INFO - 'LOGNAME': 'cltbld', 03:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:34 INFO - 'MOZ_NO_REMOTE': '1', 03:00:34 INFO - 'NO_EM_RESTART': '1', 03:00:34 INFO - 'PAGER': '/bin/cat', 03:00:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:34 INFO - 'PWD': '/builds/slave/test', 03:00:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:34 INFO - 'SHELL': '/bin/bash', 03:00:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:34 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:34 INFO - 'USER': 'cltbld', 03:00:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:34 INFO - 'XPC_FLAGS': '0x0', 03:00:34 INFO - 'XPC_SERVICE_NAME': '0', 03:00:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:34 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qpAKnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:34 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-azgcKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:34 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-XdWZqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:34 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-rv8bQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:34 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)) 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:34 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ZGdjFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:34 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-vzugOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-KBYTEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-nosJaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-k_uATE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-JgibSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-pzkCOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-lhPn5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:35 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)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-HIivPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-0lGelh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:35 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-5C1ikw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:36 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-fVYjiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:36 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-78PZBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:00:36 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)) 03:00:36 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)) 03:00:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:38 INFO - Downloading blessings-1.6.tar.gz 03:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:39 INFO - Installing collected packages: blessings 03:00:39 INFO - Running setup.py install for blessings 03:00:39 INFO - Successfully installed blessings 03:00:39 INFO - Cleaning up... 03:00:39 INFO - Return code: 0 03:00:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:39 INFO - Reading from file tmpfile_stdout 03:00:39 INFO - Current package versions: 03:00:39 INFO - blessings == 1.6 03:00:39 INFO - blobuploader == 1.2.4 03:00:39 INFO - docopt == 0.6.1 03:00:39 INFO - functools32 == 3.2.3-2 03:00:39 INFO - jsonschema == 2.5.1 03:00:39 INFO - manifestparser == 1.1 03:00:39 INFO - mozInstall == 1.12 03:00:39 INFO - mozcrash == 1.0 03:00:39 INFO - mozdebug == 0.1 03:00:39 INFO - mozdevice == 0.49 03:00:39 INFO - mozfile == 1.2 03:00:39 INFO - mozhttpd == 0.7 03:00:39 INFO - mozinfo == 0.9 03:00:39 INFO - mozleak == 0.1 03:00:39 INFO - mozlog == 3.4 03:00:39 INFO - moznetwork == 0.27 03:00:39 INFO - mozprocess == 0.24 03:00:39 INFO - mozprofile == 0.28 03:00:39 INFO - mozrunner == 6.13 03:00:39 INFO - mozscreenshot == 0.1 03:00:39 INFO - mozsystemmonitor == 0.3 03:00:39 INFO - moztest == 0.8 03:00:39 INFO - mozversion == 1.4 03:00:39 INFO - psutil == 3.1.1 03:00:39 INFO - requests == 1.2.3 03:00:39 INFO - wsgiref == 0.1.2 03:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:40 INFO - 'HOME': '/Users/cltbld', 03:00:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:40 INFO - 'LOGNAME': 'cltbld', 03:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:40 INFO - 'MOZ_NO_REMOTE': '1', 03:00:40 INFO - 'NO_EM_RESTART': '1', 03:00:40 INFO - 'PAGER': '/bin/cat', 03:00:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:40 INFO - 'PWD': '/builds/slave/test', 03:00:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:40 INFO - 'SHELL': '/bin/bash', 03:00:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:40 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:40 INFO - 'USER': 'cltbld', 03:00:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:40 INFO - 'XPC_FLAGS': '0x0', 03:00:40 INFO - 'XPC_SERVICE_NAME': '0', 03:00:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:00:40 INFO - Cleaning up... 03:00:40 INFO - Return code: 0 03:00:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110483b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110486768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99da5811d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, '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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:00:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:00:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:40 INFO - 'HOME': '/Users/cltbld', 03:00:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:40 INFO - 'LOGNAME': 'cltbld', 03:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:40 INFO - 'MOZ_NO_REMOTE': '1', 03:00:40 INFO - 'NO_EM_RESTART': '1', 03:00:40 INFO - 'PAGER': '/bin/cat', 03:00:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:40 INFO - 'PWD': '/builds/slave/test', 03:00:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:40 INFO - 'SHELL': '/bin/bash', 03:00:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:00:40 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:00:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:40 INFO - 'USER': 'cltbld', 03:00:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:40 INFO - 'XPC_FLAGS': '0x0', 03:00:40 INFO - 'XPC_SERVICE_NAME': '0', 03:00:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:41 INFO - Cleaning up... 03:00:41 INFO - Return code: 0 03:00:41 INFO - Running post-action listener: _resource_record_post_action 03:00:41 INFO - Running post-action listener: _start_resource_monitoring 03:00:41 INFO - Starting resource monitoring. 03:00:41 INFO - [mozharness: 2017-02-15 11:00:41.186790Z] Finished create-virtualenv step (success) 03:00:41 INFO - [mozharness: 2017-02-15 11:00:41.187783Z] Running install step. 03:00:41 INFO - Running pre-action listener: _resource_record_pre_action 03:00:41 INFO - Running main action method: install 03:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:41 INFO - Reading from file tmpfile_stdout 03:00:41 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:41 INFO - Reading from file tmpfile_stdout 03:00:41 INFO - Output received: 03:00:41 INFO - Usage: mozinstall [options] installer 03:00:41 INFO - Options: 03:00:41 INFO - -h, --help show this help message and exit 03:00:41 INFO - -d DEST, --destination=DEST 03:00:41 INFO - Directory to install application into. [default: 03:00:41 INFO - "/builds/slave/test"] 03:00:41 INFO - --app=APP Application being installed. [default: firefox] 03:00:41 INFO - mkdir: /builds/slave/test/build/application 03:00:41 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'] 03:00:41 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 03:01:03 INFO - Reading from file tmpfile_stdout 03:01:03 INFO - Output received: 03:01:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:01:03 INFO - Running post-action listener: _resource_record_post_action 03:01:03 INFO - [mozharness: 2017-02-15 11:01:03.408338Z] Finished install step (success) 03:01:03 INFO - [mozharness: 2017-02-15 11:01:03.408480Z] Running run-tests step. 03:01:03 INFO - Running pre-action listener: _resource_record_pre_action 03:01:03 INFO - Running main action method: run_tests 03:01:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:01:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:01:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:01:03 INFO - 2017-02-15 03:01:03.423 screenresolution[1650:7620] starting screenresolution argv=screenresolution get 03:01:03 INFO - 2017-02-15 03:01:03.425 screenresolution[1650:7620] Display 0: 1600x1200x32@60 03:01:03 INFO - 2017-02-15 03:01:03.430 screenresolution[1651:7622] starting screenresolution argv=screenresolution list 03:01:03 INFO - Available Modes on Display 0 03:01:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:01:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:01:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:01:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:01:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:01:03 INFO - Intel Iris: 03:01:03 INFO - Chipset Model: Intel Iris 03:01:03 INFO - Type: GPU 03:01:03 INFO - Bus: Built-In 03:01:03 INFO - VRAM (Dynamic, Max): 1536 MB 03:01:03 INFO - Vendor: Intel (0x8086) 03:01:03 INFO - Device ID: 0x0a2e 03:01:03 INFO - Revision ID: 0x0009 03:01:03 INFO - Displays: 03:01:03 INFO - Display: 03:01:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:01:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:01:03 INFO - Display Serial Number: 1600x1200 60 03:01:03 INFO - Main Display: Yes 03:01:03 INFO - Mirror: Off 03:01:03 INFO - Online: Yes 03:01:03 INFO - Rotation: Supported 03:01:03 INFO - Return code: 0 03:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:03 INFO - Python 2.7.3 03:01:03 INFO - Return code: 0 03:01:03 INFO - grabbing minidump binary from tooltool 03:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:03 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261d30>, '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 0x110188db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110256be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:01:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:01:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:01:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:03 INFO - Return code: 0 03:01:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:01:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:01:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AzSe0qZ3AC/Render', 03:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:03 INFO - 'HOME': '/Users/cltbld', 03:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:03 INFO - 'LOGNAME': 'cltbld', 03:01:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:03 INFO - 'MOZ_NO_REMOTE': '1', 03:01:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:03 INFO - 'NO_EM_RESTART': '1', 03:01:03 INFO - 'PAGER': '/bin/cat', 03:01:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:03 INFO - 'PWD': '/builds/slave/test', 03:01:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:03 INFO - 'SHELL': '/bin/bash', 03:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7PpwFfhW5b/Listeners', 03:01:03 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 03:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:03 INFO - 'USER': 'cltbld', 03:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:03 INFO - 'XPC_FLAGS': '0x0', 03:01:03 INFO - 'XPC_SERVICE_NAME': '0', 03:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:01:04 INFO - mozversion application_buildid: 20170209170211 03:01:04 INFO - mozversion application_changeset: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 03:01:04 INFO - mozversion application_display_name: Nightly 03:01:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:04 INFO - mozversion application_name: Firefox 03:01:04 INFO - mozversion application_remotingname: firefox 03:01:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:01:04 INFO - mozversion application_vendor: Mozilla 03:01:04 INFO - mozversion application_version: 54.0a1 03:01:04 INFO - mozversion platform_buildid: 20170209170211 03:01:04 INFO - mozversion platform_changeset: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 03:01:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:01:04 INFO - mozversion platform_version: 54.0a1 03:01:04 INFO - using testdate: 1487156464 03:01:04 INFO - actual date: 1487156464 03:01:04 INFO - starting webserver on 'localhost:49241' 03:01:04 INFO - SUITE-START | Running 2 tests 03:01:04 INFO - TEST-START | dromaeo_css 03:01:04 INFO - operating with platform_type : mac_ 03:01:04 INFO - Initialising browser for dromaeo_css test... 03:01:04 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp3aFJhV/profile http://localhost:49241/getInfo.html) 03:01:06 INFO - PROCESS | 1661 | 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] 03:01:06 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 03:01:06 INFO - PROCESS | 1661 | colorDepth:24 03:01:06 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 03:01:06 INFO - PROCESS | 1661 | __metrics 03:01:06 INFO - PROCESS | 1661 | 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" 03:01:06 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:01:07 INFO - TEST-INFO | 1661: exit 0 03:01:07 INFO - Browser initialized. 03:01:07 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:07 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp3aFJhV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:19 INFO - PROCESS | 1663 | RSS: Main: 236609536 03:01:19 INFO - PROCESS | 1663 | 03:04:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 03:04:25 INFO - PROCESS | 1663 | RSS: Main: 364666880 03:04:25 INFO - PROCESS | 1663 | 03:06:09 INFO - PROCESS | 1663 | ************************* 03:06:09 INFO - PROCESS | 1663 | A coding exception was thrown and uncaught in a Task. 03:06:09 INFO - PROCESS | 1663 | 03:06:09 ERROR - PROCESS | 1663 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:06:09 INFO - PROCESS | 1663 | Full stack: 03:06:09 INFO - PROCESS | 1663 | ************************* 03:07:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 03:07:28 INFO - PROCESS | 1663 | RSS: Main: 368308224 03:07:28 INFO - PROCESS | 1663 | 03:10:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 03:10:31 INFO - PROCESS | 1663 | RSS: Main: 364560384 03:10:31 INFO - PROCESS | 1663 | 03:13:34 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 03:13:34 INFO - PROCESS | 1663 | RSS: Main: 339619840 03:13:34 INFO - PROCESS | 1663 | 03:16:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 03:16:38 INFO - PROCESS | 1663 | RSS: Main: 331608064 03:16:38 INFO - PROCESS | 1663 | 03:19:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 03:19:42 INFO - PROCESS | 1663 | RSS: Main: 527687680 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - PROCESS | 1663 | __start_tp_report 03:19:42 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 03:19:42 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 03:19:42 INFO - PROCESS | 1663 | |i|pagename|runs| 03:19:42 INFO - PROCESS | 1663 | |0;dojo.html;2861.971380286197;3320.5887497813424;3339.215284408165;3352.949705754414;3370.713489353405;5403.621746477748;5511.9724401378035;5534.584906132041;5595.18869763884;5604.83185504435;4557.589816916477;5471.562275017999;5562.471565201309;5609.803656872;5630.943690563093;4863.902721945559;5061.367329083864;5104.489551044884;5106.029854327684;5175.068487672217;5050.090983622947;5216.504432078966;5227.163653815391;5239.659422137568;5279.128943724281;4980.551750342486;5029.673071250394;5107.540321371057;5112.41207261166;5123.820666276681;5039.622028347889;5053.772580233898;5073.264376665363;5084.79660813567;5116.590672746209;5050.343455350818;5098.923516147261;5116.2069879168785;5118.053160165381;5179.689218646856;5590.580706447033;5601.6358936668985;5609.074502707049;5637.605367624268;5683.5169010634145;5855.531557475391;5878.470937615635;5887.0580707086665;5984.371640977678;6136.23297087864;6045.516358691294;6100.5119590433105;6107.053406721965;6110.114033465167;6114.938850611526;4733.83431579893;5616.719164041781;5680.545556355523;5688.687122208235;5732.885342293131;6250.718717657625;6275;6342.809715708536;6355.332690067568;6358.109864618957;5775.335836378787;5825;5976.61152025117;6001.3098493672915;6002.399760023963;6073.726682299307;6096.451319381188;6121.971262793518;6132.171952247742;6163.137160797492;5122.410922743932;6023.096535519707;6089.969550152221;6098.817035488943;6109.991851344567;6120.877582448326;6125.479334256549;6130.540209484307;6138.263408391022;6141;4801.399825021872;4817.927731084036;4832.371791667131;4866;4870.634702397334;4350.564943505624;4375.47494300686;4387.407699960529;4399;4429.981104346019;5674.773009079673;5688.516476099495;5691.4877661010705;5695.316562012502;5714.714264286852;5339.866503337447;6155.661438620829;6172.629642221481;6197.504199664016;6245.28179259391;5482.205080263419;5535;5547.472990065938;5687;5691.658500489983;5268.604854635918;5309.017831701148;5323.1216849219445;5352.357717073976;5373.435789242151;6396.9360306397275;6400.359964003563;6406.167198264196;6410.070539771614;6416.935830641727;5923.200367950444;6184.536159787944;6201.503879689704;6224.782132625336;6231.034189700604;6227.595206311576;6247.219097612799;6250.437460628384;6307.653079080695;6349.269833969152;6128.564234752123;6130.367562715148;6138.878900475427;6140.596275277727;6145.35473775265;5980.820575382745;5993.340732519507;6178.876422471615;6194.81415557534;6198.287196972406;5695.288088988877;5736.139579063174;5954.940450595439;5956.791512297049;5976.760929562769;5791.247137872049;5841.415858414124;5864.560157988253;5884.58807883444;5971;5524.779008839601;5609.354924183608;5645.491905728504;5696.174054762119;5730.3410107838135;5890.145928840208;5892.322382925847;5900.64596124234;5903.793367232126;5935.347111817783;5737.8565535861935;5754.6547207167705;5761.251037365283;5763.971180144073;5765.827025189251 03:19:42 INFO - PROCESS | 1663 | |1;ext.html;447.88802799300174;456.74878816650835;486.50862628744966;506.7770181120305;516.9172932330827;20568.280110196145;39410.60589394105;41169.97075073121;41372.79313603428;41500.37749433761;42014;42338.57661423385;42351.36472952901;42356.57643423565;42453.36319955203;8810.118988101187;9026.909730902673;9047.819043619123;9048.276137908952;9049.095090490964;7924.405669574776;8157.918420815775;10883.619073332435;11170.720731981724;11192.608258710947;11085.778284434307;11125.666230013112;11152.163587730913;11166.274192177523;11187;7779.144294127642;9417.90582094177;11104.167187460893;11106.278091924;11130.888691113107;7898.526088434713;10756.300840445347;11046.33721976684;11070.114390848794;11089;40018;40185.39721904174;40197.59308424191;40225.396619050734;40351.7982410089;3733.085394078441;3743.7192210584317;3764.134249122717;3769.2838360711376;3886.9805650971566;28905.59152792795;29572.55641165384;29896.8505157475;30082.84958575215;30161.245968850733;3017.5473678948115;3135.1378370947946;3184.2357834119643;3208.5347624594538;3218.1150183699438;454955;455042;456190.4714287865;457624;466009;51129;60740;61403.385966139766;61492.69253653703;61588;54863.72568137214;55020.724896375265;61488;62104;62233.37766622366;14745;14883.214014318135;15071.54785356441;15072.773908391382;15083.4720784772;11151.721206969729;11425.771484570429;11525.423728813526;11526.654200374001;11553.653390398133;15305.923470382577;16633.750493742602;17585.296588136585;17633.7354939676;17672.911635441742;6461.612303261725;6486.837829054217;6547.34526547351;6551.21385433751;6562.67186640666;825.038829763319;844.1727107434748;864.4424346296604;867.3364875869964;877.903430622631;28015.299617509725;29067.56398654022;29078;29692.851535742615;29705.702942970725;1004.2668851738126;1008.8083264179783;1050.0864248104199;1055.7993981143559;1058.333250052462;15007.624809379635;15063.698726025417;15176.772348414783;15364.539063828102;15392.769108463383;584628;755550;770716;771073;772538;50679;51052.97894042098;51063.72340691512;51112.488875111514;51158.48841511612;1289.9742005160033;1330.3614265152974;1333.0868355176542;1333.5932540575025;1334.9132306400247;27106.186814395598;27181.59227611548;27675.308117296423;27772;27778;43113.35329970116;48286.517134829606;49572.75213624053;49618.50381496139;51661.483385165666;484674;487790;490073;490886.18479597423;491427.51434914017;21918.671219931395;22410.103595856635;22448.551028979655;23950.041998319874;24570.140045098335;38992.80503597464;40950.59049409587;41111.7944410288;41335.793321034405;41705.37441938434;25820.870895645403;34245.486317705756;34689.479657805656;35642;35705;34021.48967765436;34165;34900.65099348974;35145;35178;33264.66735332616;33321.33357332792;33811;33903.830480847435;34115.82942085274;28291.575626366033;29195.85402072976;30748.692513074584;30836.53745193779;30868.845655771576;22693.88653056724;22700.205492807672;23079.4230144241;23079.76920230776;23107 03:19:42 INFO - PROCESS | 1663 | |2;jquery.html;389.74861214516636;389.777826638816;391.3191047577215;401.80512451461044;421.56999860142656;13874.098183618058;16614.50156495304;19086.522836929085;19645.803541964575;19650.01749912504;15414.383424663;16345;19544.511387215327;19588.60822783547;19872.205111795512;4238.57614238576;5160.225966105077;5213.191955246943;5232.241325007872;5238.4499627539135;4230.048239146183;5267.420583735805;5313.149896016638;5328.653637513568;5363.980843639696;5494.340679118512;5965.4929331006915;6062.878742425149;6087.90868136976;6100.877982440348;5837.562182836305;5989.3711160327975;6050.425209605102;6097.20736304282;6115.8074175535785;5868.2664666916635;5872.0898260769645;5878.382769809194;5880.647161170344;5889.880922624688;13256.602301930958;16190.86663933525;20664.793352066437;24644.260672179862;24653.5069298613;2248.415411992877;2344.7069116360453;2355.4464700795297;2433.2821817563863;2486.3411196032885;9612.615495380247;9930.354526955725;10023.348482348623;10387.68836934893;10645.84031239532;1789.2485156234413;1824.388829742038;1835.880667756605;1837.6232872261287;1846.4923583166449;115001.42499287534;135306.32346838302;137343;137932.620673793;139756;9900.366439537396;11887.346195959306;11912.52349905994;11924.582639607746;12090.69773255658;15789.894707370604;15796.526104216891;15847.366105355657;15853.603659908364;15862.682746345008;7412.888806667905;7752.457327987099;7752.651130699132;8210.671573137008;8482.151784821468;7225.169105552824;8263.834723305621;8563.657453701906;8651.437656552303;8842;8575;8677.913220867837;9813.313068085166;10107.747306317255;10548.894511054945;3460.480927860841;3910.648041676206;4036.4257939403656;4050.4306578454625;4051.331530297527;950.235060776068;966.9274804389698;973.026973026973;977.9217662587118;1005.8139244239838;19200.71198932017;20594.485137871674;20622.175112995614;20626.381208563766;20676.586468270852;935.695898832882;996.3225006995168;1017.9694609161737;1038.7091614347994;1056.3450660590483;10595.576176952989;10825.971532704381;10872.075873550679;10906.727331816768;10959.136946719076;447161;601759;682955;699746;700376;113465;147605;148428;149559;152962.47037529483;444.6331776284578;449.50778897107614;466.20279322359147;468.7117422785031;992.4095163377779;8972.37193396456;9888.555015024198;10891.727706807393;11460.140489463156;11667.708307292385;52834.67913302198;55720;57326.42673573211;57674.71162644328;57977.391017403475;80525;81326;81430.59284703538;81791;82945;7790.922090779246;8038.155993620586;8077.555734434663;8371.83256334882;8404.747857564284;7369.77890663281;9684.951575242361;10787.08309793645;11482.253653512495;12115;9470.431774093577;9711.417314961125;10682.198835087243;10765.623203187852;10983.176261780558;9579.9042009579;10686.412247326472;10752.354858708502;10818.513166907665;11017.614383496539;10768.300060496043;10835.349879007284;11042.834357484484;11213.60752373663;11372.772544549229;6871.209810871814;7992.480488768211;8026.357891368793;8161.347092232489;8532;8933.597988090682;10411.47942602882;10489.737756556147;10734.838977415502;11095.72260693489 03:19:42 INFO - PROCESS | 1663 | |3;mootools.html;1228.9569865054723;1418.5531557559368;1429.692616087541;1437.7699568069108;1439.0286556574317;8034.397420193487;8424.95787521063;8439.789005274872;8451.366147538936;8468.280196183316;6671.566348187376;8189.590520473967;8287.129851365595;8375.99488061432;8384.958075209615;2196.2313190383397;2200.1749343996003;2204.173434961889;2212.1040978403694;2247.404437823978;1964.4106767969624;2196.923107691231;2239.8656080635133;2240.6526988316837;2248.6064938635755;1992;2020.0707674469688;2171.6742488626755;2238;2241.361212054565;2200.0429813031383;2220.0897631970815;2221.4779526811185;2222.5999320122373;2232.9776702232934;2174.9782502175094;2231.4086767006756;2232.5646498932715;2238.5746708125403;2241.3388050525136;8329.08380078191;8373.371997100241;8386.958065209696;8397.83204335916;8412.242898139135;4964.453910069889;5137.921036582322;5138.74306284688;5145.871353216162;5146.459621739701;3258.5763850699495;3285.4414749492644;3438.8108654024018;3490.249596336774;3493.4061209594174;1220.3898050974512;1240.5161986825055;1626.983730162695;1668.2242757117876;1760.6302676437963;10709.410982395964;10849.783004339948;10861.294015888941;10876.836847447295;10879.83680244797;4233.428487154195;4344.869653910388;4354.673399495051;4416.514183439819;4446.73319600825;8722.084181161013;8735.51954642488;8736.301095912311;8751.91248087511;8757.956210218908;5057.898842023139;5060.974695126574;5068.290439338495;5070.138076527;5072.036313100499;4554.4990051094355;4649.116667833101;4669.789859456333;4736.1474934511425;4760.357351757469;3545;3619.3847046002243;3626.4197728363333;3657.6342365763744;3661.3043521730788;1029.6499190275342;1041.729150420896;1091.9735448678375;1094.1465656787718;1106.551846502168;676.7326905872252;707.38104158861;729.2051663686501;729.9671514781847;754.1252147508864;5334.359876814729;5352.8661783454945;5406.486383793534;5665.915011274834;5699.173619825102;888.5646033443695;900.8378491871395;940.1303793990668;945.1682519382899;974.9129720361746;3636.5454318210222;3702.5742039665242;3767.981160094182;3803.1823158021157;3850.942235866464;9466.668666596635;9849.064338887794;9985.45080020606;10004.399736015863;10025;8823.602937867812;9871.80256394868;9970.202383809277;9972.50137493137;9973.252006099572;7477.439192060618;7691.5769632670745;7760.844783104306;7797.259260370256;7797.532148071021;4409.669274804339;5280.603954703336;5326.934613077323;5386.784528618968;5501.724913754216;9105;9109.863352049591;9113.134252246025;9122.087791220825;9198.908010920073;8215.383846211438;8356.206160414751;9322.953385233302;9451.669191578261;9474.005229450808;5605.103183490622;6508.284088750328;6587.835304117435;6597.967010164918;6684.532082754161;7714.382849372149;7719.691212351668;7822.374210063067;7826.139124696393;7844.725434609762;6907.7236910525025;7061.187963384071;7108.893366599402;7188.029616001772;7219.422446204186;6747;6780.423663988616;6946.829729422103;6998.930010700032;7041.859162816818;6172.259328880563;6197.349278325711;6229.470495007975;6230.470410015199;6307;4233.915321693487;4838.419389673261;4879.414470263591;4921.581665558468;4991.80032798684;4921.532454416824;4963.776630051584;4965.950340496549;5050.77271522775;5071.797128114834 03:19:42 INFO - PROCESS | 1663 | |4;prototype.html;348.6234866344348;351.34298861129685;358.1976372924649;362.38394728960776;366.7927620894196;4467.664925130612;5100.897982040357;5199.492147277289;5224.712640804759;5263.657672335812;4471.731696098236;4951.306817045616;5015.348004759376;5044.924326135111;5117.744112794364;3757.4176002719487;3966.968588167083;4106.219818234541;4106.6919981001465;4121.578055570838;3452.430348992426;3635.600083990759;3747.5315585551807;4123.876283711478;4133.297339452301;3607.350676878161;3879.495665563473;3895.8052097395157;3908.5700572936953;3940.2316548273097;3753.5683396409354;3913.726039177259;3917.804109794499;3918.490596222473;3941.5861334559745;2983.8806447742063;3303.223742420529;3379.4086034944035;3427.53728246686;3427.622961474236;3591.1381268495375;4113.588641135892;4208.3687446882905;4857.785553611597;5163.380394352665;4006.9547144170347;4270.508891477489;4294.184105020036;4498.775061246924;4504.527024662396;4339.500957389878;5487.64330318528;5509.614326997112;5518.806841760559;5521.7300020995;3189.6969787870116;3230.9838450807597;3583.62371950944;3737.570179429373;3775.9232422167697;4681.906361872778;5235.633505654606;5260.894782104413;5733.591891405578;5743.6163991943295;3449.87925422609;3666.6433419634905;3824.808759562011;3824.890781673339;3835.884923452301;3525.629808870083;3865.4588357629955;3869.5356557213313;3869.903252418712;3891.0272431892026;3826.9617303827163;3877.689784817208;4445.555444455528;4460.264056430653;4557.7721113944835;4462.397576327155;5073.720945348041;5095.15929871567;5118.616103792156;5512.972435137879;1130.9208355415205;1178.834963105166;1193.8209268609778;1206.318430086998;1223.5044806853061;783.6160281462043;797.1629788721934;840.1556435781999;851.3827475080641;852.6887685994567;4613.238815595456;4858.198397264482;4887.584555312767;4887.682300650446;4900.632452566072;4183.728057676241;4497.482789479186;4881.707097574157;5411.722402013724;5424.891502169935;4578.587927086512;4677.321788340671;4834.268638219395;4894.430424027343;4904.141775189399;2381.8570885746562;2779.902703405371;2808.9297767555977;2843.9004634837684;2861.2846788302923;4774.376711917895;5211.166213405837;5522.779088836482;5546.668799488094;5549.057829759552;4830.903381932341;5196.428392876781;5487.314085739283;5497.45025497447;5587.469190426903;4979.601631869442;5161.509656582619;5523.861903452445;5550.944490555043;5563.972180139073;4514.110968979921;4918.336024636628;5003.974980125076;5289.20661900718;5384.353877534721;4596.540345965377;4810.5670489656095;4906.871419573589;5336.386315573759;5346.679199247902;4955.776990035385;4993.500649935123;5614.550835933034;5614.578906581941;5718.370979192368;3105.2857842695853;3419.2990436959867;3596.5684117906017;3642.725046233903;3643.014557066352;4998.550130488274;5179.507946745204;5266.710330931835;5339;5352.223927530408;4169.812358443816;4541.477730060953;4730.763461826964;4745.715257084586;5182.963407318627;4848.5636292733825;4948.73807179167;4977.850664480072;5127.46161653021;5213.374395072616;5018.84943451697;5054.797808087782;5202.271681964604;5230.163173892159;5247.55395791362;5469.671819690831;5470.851121264579;5487.585462396532;5488.69812160335;5488.780448782004;4561.533234741554;4924.581410580141;5226.55742618771;5379.811706590251;5416.620836541404 03:19:42 INFO - PROCESS | 1663 | |5;yui.html;700.0549258501021;713.429256594724;750.4371721209093;755.5995322479087;840.9992109389824;14059.297035148253;14331.355089020994;14678.63303417415;14741.926290368547;15067.397304107822;13284;13525;13813.654658633539;13835.446582136703;13846.861531384684;741.3439106390856;850.9276711479532;876.2902049340055;877.1316396767219;878.9736307910773;855.4054931822386;865.809521905183;888.8844450221462;889.1064480197392;893.2273583350387;930.5719369090226;934.2245935873209;934.5887809363892;934.6168071090854;935.9532023398837;927.661403587689;929.8837645294338;931.0782325497776;932.2495391210073;933.355984370782;688.3632639808158;690.6650274616807;692.2661978303015;693.3759616345329;698.2598445647579;12319.322437265946;14385;14515.927420362936;14672.559823205322;14712.337944792404;13233.076739941347;13463.394147263396;13739.725205495834;13744.587662370144;13878.653033674138;11090.445477726162;11441.885581144248;11517.76964460706;11571.190016698834;12013.038956883429;3001.654809696891;3678.9080272993388;3682.815859207056;3702.5186725725484;3748.5126933498746;100602;103409.96590034079;104576;105529.4723526385;106648;10428.322159059637;10450.425226612457;10492.055714985689;10871.184661150446;11025.920409448556;16025.839741602435;21552.137914483246;21575.56848863014;21624;21647.45881352979;7206.783796486114;7258.637068146677;7381.409487241008;7435;7559.017327747468;3967.8412863485714;4074.459452058915;4106.548279689232;4118.588141185857;4120.608542188487;3512.1395258161915;3588.551431071116;3618.8009659468457;3619.2580520993133;3631.5460567429072;688.896665500179;714.6176795414532;725.4341613541446;725.7496163823472;738.8337624034549;643.4466358931315;649.9772507962293;689.7378995981495;693.1266604078897;706.3536863769696;9825.312228144105;9844.753881152885;9956.551955162035;10179;10237.18102551794;651.2835880531472;659.8185498987721;669.2805234373069;680.8331958670059;692.8337199072187;4473.530279320625;4802.807887684454;4805.231163013901;4810.903781924412;4838.516148385133;90569.54715226381;92442;92487;92703;93211;46177;65295.347046529874;79226.60386698144;82655.586722066;85261;58876.11685824716;69069;69478.3052169482;70505.58988820297;70740;8772.605232764414;10411.237399532629;10533.525991330256;10601.946990265307;10629;43816.685499435065;44673.32990005088;44715.55284447244;45699;45873;43005.784971076195;58034.70982645229;60490.39509604847;60856.695716521135;61417.464563386275;12144.167131807684;12254.938725306316;12403.565875194325;12474.313912734886;12950.352482376033;13946.4421423146;13996.790048149081;14134.08128471646;14138.78791818144;14448.494302699355;12951.861399196872;13161.276129812952;13234.205947643171;13580.592582222549;13796.517121900686;12823.6217811745;13035;13328.600141995756;13355.53255636048;13632.250226237255;12558.623241302776;12901.806472902726;13105.2136871788;13325.400356983766;13331.733365332446;8407.915920840958;10479.68560943173;10870.510827012646;10885;11031.779364412827;8970.730878073668;10290.948545257226;10410.323328983592;10411.167106631603;10441.060304572322 03:19:42 INFO - PROCESS | 1663 | __end_tp_report 03:19:42 INFO - PROCESS | 1663 | __start_cc_report 03:19:42 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1308 03:19:42 INFO - PROCESS | 1663 | __end_cc_report 03:19:42 INFO - PROCESS | 1663 | __startTimestamp1487157582094__endTimestamp 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - PROCESS | 1663 | ------- Summary: start ------- 03:19:42 INFO - PROCESS | 1663 | Number of tests: 6 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5611.22 Median:5732.89 stddev:646.53 (11.3%) stddev-sans-first:611.49 03:19:42 INFO - PROCESS | 1663 | Values: 2862.0 3320.6 3339.2 3352.9 3370.7 5403.6 5512.0 5534.6 5595.2 5604.8 4557.6 5471.6 5562.5 5609.8 5630.9 4863.9 5061.4 5104.5 5106.0 5175.1 5050.1 5216.5 5227.2 5239.7 5279.1 4980.6 5029.7 5107.5 5112.4 5123.8 5039.6 5053.8 5073.3 5084.8 5116.6 5050.3 5098.9 5116.2 5118.1 5179.7 5590.6 5601.6 5609.1 5637.6 5683.5 5855.5 5878.5 5887.1 5984.4 6136.2 6045.5 6100.5 6107.1 6110.1 6114.9 4733.8 5616.7 5680.5 5688.7 5732.9 6250.7 6275.0 6342.8 6355.3 6358.1 5775.3 5825.0 5976.6 6001.3 6002.4 6073.7 6096.5 6122.0 6132.2 6163.1 5122.4 6023.1 6090.0 6098.8 6110.0 6120.9 6125.5 6130.5 6138.3 6141.0 4801.4 4817.9 4832.4 4866.0 4870.6 4350.6 4375.5 4387.4 4399.0 4430.0 5674.8 5688.5 5691.5 5695.3 5714.7 5339.9 6155.7 6172.6 6197.5 6245.3 5482.2 5535.0 5547.5 5687.0 5691.7 5268.6 5309.0 5323.1 5352.4 5373.4 6396.9 6400.4 6406.2 6410.1 6416.9 5923.2 6184.5 6201.5 6224.8 6231.0 6227.6 6247.2 6250.4 6307.7 6349.3 6128.6 6130.4 6138.9 6140.6 6145.4 5980.8 5993.3 6178.9 6194.8 6198.3 5695.3 5736.1 5954.9 5956.8 5976.8 5791.2 5841.4 5864.6 5884.6 5971.0 5524.8 5609.4 5645.5 5696.2 5730.3 5890.1 5892.3 5900.6 5903.8 5935.3 5737.9 5754.7 5761.3 5764.0 5765.8 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:67943.09 Median:34795.07 stddev:154098.62 (442.9%) stddev-sans-first:154447.58 03:19:42 INFO - PROCESS | 1663 | Values: 447.9 456.7 486.5 506.8 516.9 20568.3 39410.6 41170.0 41372.8 41500.4 42014.0 42338.6 42351.4 42356.6 42453.4 8810.1 9026.9 9047.8 9048.3 9049.1 7924.4 8157.9 10883.6 11170.7 11192.6 11085.8 11125.7 11152.2 11166.3 11187.0 7779.1 9417.9 11104.2 11106.3 11130.9 7898.5 10756.3 11046.3 11070.1 11089.0 40018.0 40185.4 40197.6 40225.4 40351.8 3733.1 3743.7 3764.1 3769.3 3887.0 28905.6 29572.6 29896.9 30082.8 30161.2 3017.5 3135.1 3184.2 3208.5 3218.1 454955.0 455042.0 456190.5 457624.0 466009.0 51129.0 60740.0 61403.4 61492.7 61588.0 54863.7 55020.7 61488.0 62104.0 62233.4 14745.0 14883.2 15071.5 15072.8 15083.5 11151.7 11425.8 11525.4 11526.7 11553.7 15305.9 16633.8 17585.3 17633.7 17672.9 6461.6 6486.8 6547.3 6551.2 6562.7 825.0 844.2 864.4 867.3 877.9 28015.3 29067.6 29078.0 29692.9 29705.7 1004.3 1008.8 1050.1 1055.8 1058.3 15007.6 15063.7 15176.8 15364.5 15392.8 584628.0 755550.0 770716.0 771073.0 772538.0 50679.0 51053.0 51063.7 51112.5 51158.5 1290.0 1330.4 1333.1 1333.6 1334.9 27106.2 27181.6 27675.3 27772.0 27778.0 43113.4 48286.5 49572.8 49618.5 51661.5 484674.0 487790.0 490073.0 490886.2 491427.5 21918.7 22410.1 22448.6 23950.0 24570.1 38992.8 40950.6 41111.8 41335.8 41705.4 25820.9 34245.5 34689.5 35642.0 35705.0 34021.5 34165.0 34900.7 35145.0 35178.0 33264.7 33321.3 33811.0 33903.8 34115.8 28291.6 29195.9 30748.7 30836.5 30868.8 22693.9 22700.2 23079.4 23079.8 23107.0 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:36339.74 Median:2219.12 stddev:106441.23 (4796.6%) stddev-sans-first:106705.60 03:19:42 INFO - PROCESS | 1663 | Values: 389.7 389.8 391.3 401.8 421.6 13874.1 16614.5 19086.5 19645.8 19650.0 15414.4 16345.0 19544.5 19588.6 19872.2 4238.6 5160.2 5213.2 5232.2 5238.4 4230.0 5267.4 5313.1 5328.7 5364.0 5494.3 5965.5 6062.9 6087.9 6100.9 5837.6 5989.4 6050.4 6097.2 6115.8 5868.3 5872.1 5878.4 5880.6 5889.9 13256.6 16190.9 20664.8 24644.3 24653.5 2248.4 2344.7 2355.4 2433.3 2486.3 9612.6 9930.4 10023.3 10387.7 10645.8 1789.2 1824.4 1835.9 1837.6 1846.5 115001.4 135306.3 137343.0 137932.6 139756.0 9900.4 11887.3 11912.5 11924.6 12090.7 15789.9 15796.5 15847.4 15853.6 15862.7 7412.9 7752.5 7752.7 8210.7 8482.2 7225.2 8263.8 8563.7 8651.4 8842.0 8575.0 8677.9 9813.3 10107.7 10548.9 3460.5 3910.6 4036.4 4050.4 4051.3 950.2 966.9 973.0 977.9 1005.8 19200.7 20594.5 20622.2 20626.4 20676.6 935.7 996.3 1018.0 1038.7 1056.3 10595.6 10826.0 10872.1 10906.7 10959.1 447161.0 601759.0 682955.0 699746.0 700376.0 113465.0 147605.0 148428.0 149559.0 152962.5 444.6 449.5 466.2 468.7 992.4 8972.4 9888.6 10891.7 11460.1 11667.7 52834.7 55720.0 57326.4 57674.7 57977.4 80525.0 81326.0 81430.6 81791.0 82945.0 7790.9 8038.2 8077.6 8371.8 8404.7 7369.8 9685.0 10787.1 11482.3 12115.0 9470.4 9711.4 10682.2 10765.6 10983.2 9579.9 10686.4 10752.4 10818.5 11017.6 10768.3 10835.3 11042.8 11213.6 11372.8 6871.2 7992.5 8026.4 8161.3 8532.0 8933.6 10411.5 10489.7 10734.8 11095.7 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5308.19 Median:5142.31 stddev:2918.93 (56.8%) stddev-sans-first:2911.01 03:19:42 INFO - PROCESS | 1663 | Values: 1229.0 1418.6 1429.7 1437.8 1439.0 8034.4 8425.0 8439.8 8451.4 8468.3 6671.6 8189.6 8287.1 8376.0 8385.0 2196.2 2200.2 2204.2 2212.1 2247.4 1964.4 2196.9 2239.9 2240.7 2248.6 1992.0 2020.1 2171.7 2238.0 2241.4 2200.0 2220.1 2221.5 2222.6 2233.0 2175.0 2231.4 2232.6 2238.6 2241.3 8329.1 8373.4 8387.0 8397.8 8412.2 4964.5 5137.9 5138.7 5145.9 5146.5 3258.6 3285.4 3438.8 3490.2 3493.4 1220.4 1240.5 1627.0 1668.2 1760.6 10709.4 10849.8 10861.3 10876.8 10879.8 4233.4 4344.9 4354.7 4416.5 4446.7 8722.1 8735.5 8736.3 8751.9 8758.0 5057.9 5061.0 5068.3 5070.1 5072.0 4554.5 4649.1 4669.8 4736.1 4760.4 3545.0 3619.4 3626.4 3657.6 3661.3 1029.6 1041.7 1092.0 1094.1 1106.6 676.7 707.4 729.2 730.0 754.1 5334.4 5352.9 5406.5 5665.9 5699.2 888.6 900.8 940.1 945.2 974.9 3636.5 3702.6 3768.0 3803.2 3850.9 9466.7 9849.1 9985.5 10004.4 10025.0 8823.6 9871.8 9970.2 9972.5 9973.3 7477.4 7691.6 7760.8 7797.3 7797.5 4409.7 5280.6 5326.9 5386.8 5501.7 9105.0 9109.9 9113.1 9122.1 9198.9 8215.4 8356.2 9323.0 9451.7 9474.0 5605.1 6508.3 6587.8 6598.0 6684.5 7714.4 7719.7 7822.4 7826.1 7844.7 6907.7 7061.2 7108.9 7188.0 7219.4 6747.0 6780.4 6946.8 6998.9 7041.9 6172.3 6197.3 6229.5 6230.5 6307.0 4233.9 4838.4 4879.4 4921.6 4991.8 4921.5 4963.8 4966.0 5050.8 5071.8 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4266.47 Median:4792.47 stddev:1292.07 (27.0%) stddev-sans-first:1261.79 03:19:42 INFO - PROCESS | 1663 | Values: 348.6 351.3 358.2 362.4 366.8 4467.7 5100.9 5199.5 5224.7 5263.7 4471.7 4951.3 5015.3 5044.9 5117.7 3757.4 3967.0 4106.2 4106.7 4121.6 3452.4 3635.6 3747.5 4123.9 4133.3 3607.4 3879.5 3895.8 3908.6 3940.2 3753.6 3913.7 3917.8 3918.5 3941.6 2983.9 3303.2 3379.4 3427.5 3427.6 3591.1 4113.6 4208.4 4857.8 5163.4 4007.0 4270.5 4294.2 4498.8 4504.5 4339.5 5487.6 5509.6 5518.8 5521.7 3189.7 3231.0 3583.6 3737.6 3775.9 4681.9 5235.6 5260.9 5733.6 5743.6 3449.9 3666.6 3824.8 3824.9 3835.9 3525.6 3865.5 3869.5 3869.9 3891.0 3827.0 3877.7 4445.6 4460.3 4557.8 4462.4 5073.7 5095.2 5118.6 5513.0 1130.9 1178.8 1193.8 1206.3 1223.5 783.6 797.2 840.2 851.4 852.7 4613.2 4858.2 4887.6 4887.7 4900.6 4183.7 4497.5 4881.7 5411.7 5424.9 4578.6 4677.3 4834.3 4894.4 4904.1 2381.9 2779.9 2808.9 2843.9 2861.3 4774.4 5211.2 5522.8 5546.7 5549.1 4830.9 5196.4 5487.3 5497.5 5587.5 4979.6 5161.5 5523.9 5550.9 5564.0 4514.1 4918.3 5004.0 5289.2 5384.4 4596.5 4810.6 4906.9 5336.4 5346.7 4955.8 4993.5 5614.6 5614.6 5718.4 3105.3 3419.3 3596.6 3642.7 3643.0 4998.6 5179.5 5266.7 5339.0 5352.2 4169.8 4541.5 4730.8 4745.7 5183.0 4848.6 4948.7 4977.9 5127.5 5213.4 5018.8 5054.8 5202.3 5230.2 5247.6 5469.7 5470.9 5487.6 5488.7 5488.8 4561.5 4924.6 5226.6 5379.8 5416.6 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18709.25 Median:4090.50 stddev:26371.00 (644.7%) stddev-sans-first:26410.31 03:19:42 INFO - PROCESS | 1663 | Values: 700.1 713.4 750.4 755.6 841.0 14059.3 14331.4 14678.6 14741.9 15067.4 13284.0 13525.0 13813.7 13835.4 13846.9 741.3 850.9 876.3 877.1 879.0 855.4 865.8 888.9 889.1 893.2 930.6 934.2 934.6 934.6 936.0 927.7 929.9 931.1 932.2 933.4 688.4 690.7 692.3 693.4 698.3 12319.3 14385.0 14515.9 14672.6 14712.3 13233.1 13463.4 13739.7 13744.6 13878.7 11090.4 11441.9 11517.8 11571.2 12013.0 3001.7 3678.9 3682.8 3702.5 3748.5 100602.0 103410.0 104576.0 105529.5 106648.0 10428.3 10450.4 10492.1 10871.2 11025.9 16025.8 21552.1 21575.6 21624.0 21647.5 7206.8 7258.6 7381.4 7435.0 7559.0 3967.8 4074.5 4106.5 4118.6 4120.6 3512.1 3588.6 3618.8 3619.3 3631.5 688.9 714.6 725.4 725.7 738.8 643.4 650.0 689.7 693.1 706.4 9825.3 9844.8 9956.6 10179.0 10237.2 651.3 659.8 669.3 680.8 692.8 4473.5 4802.8 4805.2 4810.9 4838.5 90569.5 92442.0 92487.0 92703.0 93211.0 46177.0 65295.3 79226.6 82655.6 85261.0 58876.1 69069.0 69478.3 70505.6 70740.0 8772.6 10411.2 10533.5 10601.9 10629.0 43816.7 44673.3 44715.6 45699.0 45873.0 43005.8 58034.7 60490.4 60856.7 61417.5 12144.2 12254.9 12403.6 12474.3 12950.4 13946.4 13996.8 14134.1 14138.8 14448.5 12951.9 13161.3 13234.2 13580.6 13796.5 12823.6 13035.0 13328.6 13355.5 13632.3 12558.6 12901.8 13105.2 13325.4 13331.7 8407.9 10479.7 10870.5 10885.0 11031.8 8970.7 10290.9 10410.3 10411.2 10441.1 03:19:42 INFO - PROCESS | 1663 | -------- Summary: end -------- 03:19:42 INFO - PROCESS | 1663 | 03:19:42 INFO - TEST-INFO | 1663: exit 0 03:19:42 INFO - TEST-OK | dromaeo_css | took 1118744ms 03:19:42 INFO - TEST-START | kraken 03:19:42 INFO - operating with platform_type : mac_ 03:19:42 INFO - Initialising browser for kraken test... 03:19:42 INFO - TEST-INFO | started process 1783 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmphZ_vZC/profile http://localhost:49241/getInfo.html) 03:19:45 INFO - PROCESS | 1783 | 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] 03:19:45 INFO - PROCESS | 1783 | __metrics Screen width/height:1600/1200 03:19:45 INFO - PROCESS | 1783 | colorDepth:24 03:19:45 INFO - PROCESS | 1783 | Browser inner width/height: 1024/689 03:19:45 INFO - PROCESS | 1783 | __metrics 03:19:45 INFO - PROCESS | 1783 | 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" 03:19:45 INFO - PROCESS | 1783 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:19:46 INFO - TEST-INFO | 1783: exit 0 03:19:46 INFO - Browser initialized. 03:19:46 INFO - Running cycle 1/1 for kraken test... 03:19:46 INFO - TEST-INFO | started process 1785 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmphZ_vZC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:58 INFO - PROCESS | 1785 | RSS: Main: 237412352 03:19:58 INFO - PROCESS | 1785 | 03:20:00 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:01 INFO - PROCESS | 1785 | RSS: Main: 288419840 03:20:01 INFO - PROCESS | 1785 | 03:20:04 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 03:20:05 INFO - PROCESS | 1785 | RSS: Main: 290398208 03:20:05 INFO - PROCESS | 1785 | 03:20:08 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 03:20:09 INFO - PROCESS | 1785 | RSS: Main: 380022784 03:20:09 INFO - PROCESS | 1785 | 03:20:11 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 03:20:11 INFO - PROCESS | 1785 | RSS: Main: 282787840 03:20:11 INFO - PROCESS | 1785 | 03:20:13 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:14 INFO - PROCESS | 1785 | RSS: Main: 286273536 03:20:14 INFO - PROCESS | 1785 | 03:20:17 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:17 INFO - PROCESS | 1785 | RSS: Main: 327528448 03:20:17 INFO - PROCESS | 1785 | 03:20:20 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:21 INFO - PROCESS | 1785 | RSS: Main: 331632640 03:20:21 INFO - PROCESS | 1785 | 03:20:24 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 03:20:24 INFO - PROCESS | 1785 | RSS: Main: 328986624 03:20:24 INFO - PROCESS | 1785 | 03:20:26 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:27 INFO - PROCESS | 1785 | RSS: Main: 304914432 03:20:27 INFO - PROCESS | 1785 | 03:20:28 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:29 INFO - PROCESS | 1785 | RSS: Main: 308514816 03:20:29 INFO - PROCESS | 1785 | 03:20:31 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:32 INFO - PROCESS | 1785 | RSS: Main: 310018048 03:20:32 INFO - PROCESS | 1785 | 03:20:35 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:36 INFO - PROCESS | 1785 | RSS: Main: 330346496 03:20:36 INFO - PROCESS | 1785 | 03:20:39 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:39 INFO - PROCESS | 1785 | RSS: Main: 324321280 03:20:39 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 03:20:41 INFO - PROCESS | 1785 | RSS: Main: 369664000 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | __start_tp_report 03:20:41 INFO - PROCESS | 1785 | _x_x_mozilla_page_load 03:20:41 INFO - PROCESS | 1785 | _x_x_mozilla_page_load_details 03:20:41 INFO - PROCESS | 1785 | |i|pagename|runs| 03:20:41 INFO - PROCESS | 1785 | |0;ai-astar;114;114;113;113;115;114;113;114;112;114 03:20:41 INFO - PROCESS | 1785 | |1;audio-beat-detection;139;113;111;166;138;136;125;108;131;111 03:20:41 INFO - PROCESS | 1785 | |2;audio-dft;186;183;183;185;184;182;182;186;183;183 03:20:41 INFO - PROCESS | 1785 | |3;audio-fft;80;59;59;105;82;81;63;59;74;59 03:20:41 INFO - PROCESS | 1785 | |4;audio-oscillator;90;69;87;68;69;68;83;68;68;85 03:20:41 INFO - PROCESS | 1785 | |5;imaging-gaussian-blur;94;133;87;86;87;88;88;86;86;87 03:20:41 INFO - PROCESS | 1785 | |6;imaging-darkroom;94;94;94;93;94;94;95;94;94;94 03:20:41 INFO - PROCESS | 1785 | |7;imaging-desaturate;86;88;87;88;88;85;88;86;86;85 03:20:41 INFO - PROCESS | 1785 | |8;json-parse-financial;62;60;60;60;61;60;59;56;57;58 03:20:41 INFO - PROCESS | 1785 | |9;json-stringify-tinderbox;66;69;80;76;73;69;70;71;71;77 03:20:41 INFO - PROCESS | 1785 | |10;stanford-crypto-aes;88;91;88;89;88;89;87;90;93;90 03:20:41 INFO - PROCESS | 1785 | |11;stanford-crypto-ccm;147;146;145;142;141;143;145;159;195;182 03:20:41 INFO - PROCESS | 1785 | |12;stanford-crypto-pbkdf2;181;173;172;164;149;213;234;215;174;173 03:20:41 INFO - PROCESS | 1785 | |13;stanford-crypto-sha256-iterative;68;68;66;66;66;66;66;67;66;66 03:20:41 INFO - PROCESS | 1785 | __end_tp_report 03:20:41 INFO - PROCESS | 1785 | __start_cc_report 03:20:41 INFO - PROCESS | 1785 | _x_x_mozilla_cycle_collect,2082 03:20:41 INFO - PROCESS | 1785 | __end_cc_report 03:20:41 INFO - PROCESS | 1785 | __startTimestamp1487157641908__endTimestamp 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | ------- Summary: start ------- 03:20:41 INFO - PROCESS | 1785 | Number of tests: 14 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.84 (0.7%) stddev-sans-first:0.88 03:20:41 INFO - PROCESS | 1785 | Values: 114.0 114.0 113.0 113.0 115.0 114.0 113.0 114.0 112.0 114.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:133.50 stddev:18.10 (13.6%) stddev-sans-first:18.74 03:20:41 INFO - PROCESS | 1785 | Values: 139.0 113.0 111.0 166.0 138.0 136.0 125.0 108.0 131.0 111.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#2] audio-dft Cycles:10 Average:183.70 Median:183.50 stddev:1.49 (0.8%) stddev-sans-first:1.33 03:20:41 INFO - PROCESS | 1785 | Values: 186.0 183.0 183.0 185.0 184.0 182.0 182.0 186.0 183.0 183.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#3] audio-fft Cycles:10 Average:72.10 Median:68.50 stddev:15.26 (22.3%) stddev-sans-first:15.91 03:20:41 INFO - PROCESS | 1785 | Values: 80.0 59.0 59.0 105.0 82.0 81.0 63.0 59.0 74.0 59.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.00 stddev:9.42 (12.4%) stddev-sans-first:8.40 03:20:41 INFO - PROCESS | 1785 | Values: 90.0 69.0 87.0 68.0 69.0 68.0 83.0 68.0 68.0 85.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:87.00 stddev:14.53 (16.7%) stddev-sans-first:15.39 03:20:41 INFO - PROCESS | 1785 | Values: 94.0 133.0 87.0 86.0 87.0 88.0 88.0 86.0 86.0 87.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:20:41 INFO - PROCESS | 1785 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 95.0 94.0 94.0 94.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.50 stddev:1.25 (1.4%) stddev-sans-first:1.30 03:20:41 INFO - PROCESS | 1785 | Values: 86.0 88.0 87.0 88.0 88.0 85.0 88.0 86.0 86.0 85.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:60.00 stddev:1.83 (3.0%) stddev-sans-first:1.66 03:20:41 INFO - PROCESS | 1785 | Values: 62.0 60.0 60.0 60.0 61.0 60.0 59.0 56.0 57.0 58.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:4.29 (6.0%) stddev-sans-first:3.92 03:20:41 INFO - PROCESS | 1785 | Values: 66.0 69.0 80.0 76.0 73.0 69.0 70.0 71.0 71.0 77.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:89.50 stddev:1.77 (2.0%) stddev-sans-first:1.81 03:20:41 INFO - PROCESS | 1785 | Values: 88.0 91.0 88.0 89.0 88.0 89.0 87.0 90.0 93.0 90.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:146.50 stddev:18.85 (12.9%) stddev-sans-first:19.79 03:20:41 INFO - PROCESS | 1785 | Values: 147.0 146.0 145.0 142.0 141.0 143.0 145.0 159.0 195.0 182.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:177.50 stddev:26.70 (15.0%) stddev-sans-first:28.28 03:20:41 INFO - PROCESS | 1785 | Values: 181.0 173.0 172.0 164.0 149.0 213.0 234.0 215.0 174.0 173.0 03:20:41 INFO - PROCESS | 1785 | 03:20:41 INFO - PROCESS | 1785 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 03:20:41 INFO - PROCESS | 1785 | Values: 68.0 68.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 03:20:41 INFO - PROCESS | 1785 | -------- Summary: end -------- 03:20:41 INFO - PROCESS | 1785 | 03:20:42 INFO - TEST-INFO | 1785: exit 0 03:20:42 INFO - TEST-OK | kraken | took 60080ms 03:20:42 INFO - SUITE-END | took 1178s 03:20:43 INFO - Completed test suite (00:19:39) 03:20:43 INFO - javascript benchmark 03:20:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7036.668665963272, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2861.971380286197, 3320.5887497813424, 3339.215284408165, 3352.949705754414, 3370.713489353405, 5403.621746477748, 5511.9724401378035, 5534.584906132041, 5595.18869763884, 5604.83185504435, 4557.589816916477, 5471.562275017999, 5562.471565201309, 5609.803656872, 5630.943690563093, 4863.902721945559, 5061.367329083864, 5104.489551044884, 5106.029854327684, 5175.068487672217, 5050.090983622947, 5216.504432078966, 5227.163653815391, 5239.659422137568, 5279.128943724281, 4980.551750342486, 5029.673071250394, 5107.540321371057, 5112.41207261166, 5123.820666276681, 5039.622028347889, 5053.772580233898, 5073.264376665363, 5084.79660813567, 5116.590672746209, 5050.343455350818, 5098.923516147261, 5116.2069879168785, 5118.053160165381, 5179.689218646856, 5590.580706447033, 5601.6358936668985, 5609.074502707049, 5637.605367624268, 5683.5169010634145, 5855.531557475391, 5878.470937615635, 5887.0580707086665, 5984.371640977678, 6136.23297087864, 6045.516358691294, 6100.5119590433105, 6107.053406721965, 6110.114033465167, 6114.938850611526, 4733.83431579893, 5616.719164041781, 5680.545556355523, 5688.687122208235, 5732.885342293131, 6250.718717657625, 6275.0, 6342.809715708536, 6355.332690067568, 6358.109864618957, 5775.335836378787, 5825.0, 5976.61152025117, 6001.3098493672915, 6002.399760023963, 6073.726682299307, 6096.451319381188, 6121.971262793518, 6132.171952247742, 6163.137160797492, 5122.410922743932, 6023.096535519707, 6089.969550152221, 6098.817035488943, 6109.991851344567, 6120.877582448326, 6125.479334256549, 6130.540209484307, 6138.263408391022, 6141.0, 4801.399825021872, 4817.927731084036, 4832.371791667131, 4866.0, 4870.634702397334, 4350.564943505624, 4375.47494300686, 4387.407699960529, 4399.0, 4429.981104346019, 5674.773009079673, 5688.516476099495, 5691.4877661010705, 5695.316562012502, 5714.714264286852, 5339.866503337447, 6155.661438620829, 6172.629642221481, 6197.504199664016, 6245.28179259391, 5482.205080263419, 5535.0, 5547.472990065938, 5687.0, 5691.658500489983, 5268.604854635918, 5309.017831701148, 5323.1216849219445, 5352.357717073976, 5373.435789242151, 6396.9360306397275, 6400.359964003563, 6406.167198264196, 6410.070539771614, 6416.935830641727, 5923.200367950444, 6184.536159787944, 6201.503879689704, 6224.782132625336, 6231.034189700604, 6227.595206311576, 6247.219097612799, 6250.437460628384, 6307.653079080695, 6349.269833969152, 6128.564234752123, 6130.367562715148, 6138.878900475427, 6140.596275277727, 6145.35473775265, 5980.820575382745, 5993.340732519507, 6178.876422471615, 6194.81415557534, 6198.287196972406, 5695.288088988877, 5736.139579063174, 5954.940450595439, 5956.791512297049, 5976.760929562769, 5791.247137872049, 5841.415858414124, 5864.560157988253, 5884.58807883444, 5971.0, 5524.779008839601, 5609.354924183608, 5645.491905728504, 5696.174054762119, 5730.3410107838135, 5890.145928840208, 5892.322382925847, 5900.64596124234, 5903.793367232126, 5935.347111817783, 5737.8565535861935, 5754.6547207167705, 5761.251037365283, 5763.971180144073, 5765.827025189251], "value": 5569.593856140842, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.88802799300174, 456.74878816650835, 486.50862628744966, 506.7770181120305, 516.9172932330827, 20568.280110196145, 39410.60589394105, 41169.97075073121, 41372.79313603428, 41500.37749433761, 42014.0, 42338.57661423385, 42351.36472952901, 42356.57643423565, 42453.36319955203, 8810.118988101187, 9026.909730902673, 9047.819043619123, 9048.276137908952, 9049.095090490964, 7924.405669574776, 8157.918420815775, 10883.619073332435, 11170.720731981724, 11192.608258710947, 11085.778284434307, 11125.666230013112, 11152.163587730913, 11166.274192177523, 11187.0, 7779.144294127642, 9417.90582094177, 11104.167187460893, 11106.278091924, 11130.888691113107, 7898.526088434713, 10756.300840445347, 11046.33721976684, 11070.114390848794, 11089.0, 40018.0, 40185.39721904174, 40197.59308424191, 40225.396619050734, 40351.7982410089, 3733.085394078441, 3743.7192210584317, 3764.134249122717, 3769.2838360711376, 3886.9805650971566, 28905.59152792795, 29572.55641165384, 29896.8505157475, 30082.84958575215, 30161.245968850733, 3017.5473678948115, 3135.1378370947946, 3184.2357834119643, 3208.5347624594538, 3218.1150183699438, 454955.0, 455042.0, 456190.4714287865, 457624.0, 466009.0, 51129.0, 60740.0, 61403.385966139766, 61492.69253653703, 61588.0, 54863.72568137214, 55020.724896375265, 61488.0, 62104.0, 62233.37766622366, 14745.0, 14883.214014318135, 15071.54785356441, 15072.773908391382, 15083.4720784772, 11151.721206969729, 11425.771484570429, 11525.423728813526, 11526.654200374001, 11553.653390398133, 15305.923470382577, 16633.750493742602, 17585.296588136585, 17633.7354939676, 17672.911635441742, 6461.612303261725, 6486.837829054217, 6547.34526547351, 6551.21385433751, 6562.67186640666, 825.038829763319, 844.1727107434748, 864.4424346296604, 867.3364875869964, 877.903430622631, 28015.299617509725, 29067.56398654022, 29078.0, 29692.851535742615, 29705.702942970725, 1004.2668851738126, 1008.8083264179783, 1050.0864248104199, 1055.7993981143559, 1058.333250052462, 15007.624809379635, 15063.698726025417, 15176.772348414783, 15364.539063828102, 15392.769108463383, 584628.0, 755550.0, 770716.0, 771073.0, 772538.0, 50679.0, 51052.97894042098, 51063.72340691512, 51112.488875111514, 51158.48841511612, 1289.9742005160033, 1330.3614265152974, 1333.0868355176542, 1333.5932540575025, 1334.9132306400247, 27106.186814395598, 27181.59227611548, 27675.308117296423, 27772.0, 27778.0, 43113.35329970116, 48286.517134829606, 49572.75213624053, 49618.50381496139, 51661.483385165666, 484674.0, 487790.0, 490073.0, 490886.18479597423, 491427.51434914017, 21918.671219931395, 22410.103595856635, 22448.551028979655, 23950.041998319874, 24570.140045098335, 38992.80503597464, 40950.59049409587, 41111.7944410288, 41335.793321034405, 41705.37441938434, 25820.870895645403, 34245.486317705756, 34689.479657805656, 35642.0, 35705.0, 34021.48967765436, 34165.0, 34900.65099348974, 35145.0, 35178.0, 33264.66735332616, 33321.33357332792, 33811.0, 33903.830480847435, 34115.82942085274, 28291.575626366033, 29195.85402072976, 30748.692513074584, 30836.53745193779, 30868.845655771576, 22693.88653056724, 22700.205492807672, 23079.4230144241, 23079.76920230776, 23107.0], "value": 18995.70480932317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.74861214516636, 389.777826638816, 391.3191047577215, 401.80512451461044, 421.56999860142656, 13874.098183618058, 16614.50156495304, 19086.522836929085, 19645.803541964575, 19650.01749912504, 15414.383424663, 16345.0, 19544.511387215327, 19588.60822783547, 19872.205111795512, 4238.57614238576, 5160.225966105077, 5213.191955246943, 5232.241325007872, 5238.4499627539135, 4230.048239146183, 5267.420583735805, 5313.149896016638, 5328.653637513568, 5363.980843639696, 5494.340679118512, 5965.4929331006915, 6062.878742425149, 6087.90868136976, 6100.877982440348, 5837.562182836305, 5989.3711160327975, 6050.425209605102, 6097.20736304282, 6115.8074175535785, 5868.2664666916635, 5872.0898260769645, 5878.382769809194, 5880.647161170344, 5889.880922624688, 13256.602301930958, 16190.86663933525, 20664.793352066437, 24644.260672179862, 24653.5069298613, 2248.415411992877, 2344.7069116360453, 2355.4464700795297, 2433.2821817563863, 2486.3411196032885, 9612.615495380247, 9930.354526955725, 10023.348482348623, 10387.68836934893, 10645.84031239532, 1789.2485156234413, 1824.388829742038, 1835.880667756605, 1837.6232872261287, 1846.4923583166449, 115001.42499287534, 135306.32346838302, 137343.0, 137932.620673793, 139756.0, 9900.366439537396, 11887.346195959306, 11912.52349905994, 11924.582639607746, 12090.69773255658, 15789.894707370604, 15796.526104216891, 15847.366105355657, 15853.603659908364, 15862.682746345008, 7412.888806667905, 7752.457327987099, 7752.651130699132, 8210.671573137008, 8482.151784821468, 7225.169105552824, 8263.834723305621, 8563.657453701906, 8651.437656552303, 8842.0, 8575.0, 8677.913220867837, 9813.313068085166, 10107.747306317255, 10548.894511054945, 3460.480927860841, 3910.648041676206, 4036.4257939403656, 4050.4306578454625, 4051.331530297527, 950.235060776068, 966.9274804389698, 973.026973026973, 977.9217662587118, 1005.8139244239838, 19200.71198932017, 20594.485137871674, 20622.175112995614, 20626.381208563766, 20676.586468270852, 935.695898832882, 996.3225006995168, 1017.9694609161737, 1038.7091614347994, 1056.3450660590483, 10595.576176952989, 10825.971532704381, 10872.075873550679, 10906.727331816768, 10959.136946719076, 447161.0, 601759.0, 682955.0, 699746.0, 700376.0, 113465.0, 147605.0, 148428.0, 149559.0, 152962.47037529483, 444.6331776284578, 449.50778897107614, 466.20279322359147, 468.7117422785031, 992.4095163377779, 8972.37193396456, 9888.555015024198, 10891.727706807393, 11460.140489463156, 11667.708307292385, 52834.67913302198, 55720.0, 57326.42673573211, 57674.71162644328, 57977.391017403475, 80525.0, 81326.0, 81430.59284703538, 81791.0, 82945.0, 7790.922090779246, 8038.155993620586, 8077.555734434663, 8371.83256334882, 8404.747857564284, 7369.77890663281, 9684.951575242361, 10787.08309793645, 11482.253653512495, 12115.0, 9470.431774093577, 9711.417314961125, 10682.198835087243, 10765.623203187852, 10983.176261780558, 9579.9042009579, 10686.412247326472, 10752.354858708502, 10818.513166907665, 11017.614383496539, 10768.300060496043, 10835.349879007284, 11042.834357484484, 11213.60752373663, 11372.772544549229, 6871.209810871814, 7992.480488768211, 8026.357891368793, 8161.347092232489, 8532.0, 8933.597988090682, 10411.47942602882, 10489.737756556147, 10734.838977415502, 11095.72260693489], "value": 9501.248274840014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.9569865054723, 1418.5531557559368, 1429.692616087541, 1437.7699568069108, 1439.0286556574317, 8034.397420193487, 8424.95787521063, 8439.789005274872, 8451.366147538936, 8468.280196183316, 6671.566348187376, 8189.590520473967, 8287.129851365595, 8375.99488061432, 8384.958075209615, 2196.2313190383397, 2200.1749343996003, 2204.173434961889, 2212.1040978403694, 2247.404437823978, 1964.4106767969624, 2196.923107691231, 2239.8656080635133, 2240.6526988316837, 2248.6064938635755, 1992.0, 2020.0707674469688, 2171.6742488626755, 2238.0, 2241.361212054565, 2200.0429813031383, 2220.0897631970815, 2221.4779526811185, 2222.5999320122373, 2232.9776702232934, 2174.9782502175094, 2231.4086767006756, 2232.5646498932715, 2238.5746708125403, 2241.3388050525136, 8329.08380078191, 8373.371997100241, 8386.958065209696, 8397.83204335916, 8412.242898139135, 4964.453910069889, 5137.921036582322, 5138.74306284688, 5145.871353216162, 5146.459621739701, 3258.5763850699495, 3285.4414749492644, 3438.8108654024018, 3490.249596336774, 3493.4061209594174, 1220.3898050974512, 1240.5161986825055, 1626.983730162695, 1668.2242757117876, 1760.6302676437963, 10709.410982395964, 10849.783004339948, 10861.294015888941, 10876.836847447295, 10879.83680244797, 4233.428487154195, 4344.869653910388, 4354.673399495051, 4416.514183439819, 4446.73319600825, 8722.084181161013, 8735.51954642488, 8736.301095912311, 8751.91248087511, 8757.956210218908, 5057.898842023139, 5060.974695126574, 5068.290439338495, 5070.138076527, 5072.036313100499, 4554.4990051094355, 4649.116667833101, 4669.789859456333, 4736.1474934511425, 4760.357351757469, 3545.0, 3619.3847046002243, 3626.4197728363333, 3657.6342365763744, 3661.3043521730788, 1029.6499190275342, 1041.729150420896, 1091.9735448678375, 1094.1465656787718, 1106.551846502168, 676.7326905872252, 707.38104158861, 729.2051663686501, 729.9671514781847, 754.1252147508864, 5334.359876814729, 5352.8661783454945, 5406.486383793534, 5665.915011274834, 5699.173619825102, 888.5646033443695, 900.8378491871395, 940.1303793990668, 945.1682519382899, 974.9129720361746, 3636.5454318210222, 3702.5742039665242, 3767.981160094182, 3803.1823158021157, 3850.942235866464, 9466.668666596635, 9849.064338887794, 9985.45080020606, 10004.399736015863, 10025.0, 8823.602937867812, 9871.80256394868, 9970.202383809277, 9972.50137493137, 9973.252006099572, 7477.439192060618, 7691.5769632670745, 7760.844783104306, 7797.259260370256, 7797.532148071021, 4409.669274804339, 5280.603954703336, 5326.934613077323, 5386.784528618968, 5501.724913754216, 9105.0, 9109.863352049591, 9113.134252246025, 9122.087791220825, 9198.908010920073, 8215.383846211438, 8356.206160414751, 9322.953385233302, 9451.669191578261, 9474.005229450808, 5605.103183490622, 6508.284088750328, 6587.835304117435, 6597.967010164918, 6684.532082754161, 7714.382849372149, 7719.691212351668, 7822.374210063067, 7826.139124696393, 7844.725434609762, 6907.7236910525025, 7061.187963384071, 7108.893366599402, 7188.029616001772, 7219.422446204186, 6747.0, 6780.423663988616, 6946.829729422103, 6998.930010700032, 7041.859162816818, 6172.259328880563, 6197.349278325711, 6229.470495007975, 6230.470410015199, 6307.0, 4233.915321693487, 4838.419389673261, 4879.414470263591, 4921.581665558468, 4991.80032798684, 4921.532454416824, 4963.776630051584, 4965.950340496549, 5050.77271522775, 5071.797128114834], "value": 4295.190223126049, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.6234866344348, 351.34298861129685, 358.1976372924649, 362.38394728960776, 366.7927620894196, 4467.664925130612, 5100.897982040357, 5199.492147277289, 5224.712640804759, 5263.657672335812, 4471.731696098236, 4951.306817045616, 5015.348004759376, 5044.924326135111, 5117.744112794364, 3757.4176002719487, 3966.968588167083, 4106.219818234541, 4106.6919981001465, 4121.578055570838, 3452.430348992426, 3635.600083990759, 3747.5315585551807, 4123.876283711478, 4133.297339452301, 3607.350676878161, 3879.495665563473, 3895.8052097395157, 3908.5700572936953, 3940.2316548273097, 3753.5683396409354, 3913.726039177259, 3917.804109794499, 3918.490596222473, 3941.5861334559745, 2983.8806447742063, 3303.223742420529, 3379.4086034944035, 3427.53728246686, 3427.622961474236, 3591.1381268495375, 4113.588641135892, 4208.3687446882905, 4857.785553611597, 5163.380394352665, 4006.9547144170347, 4270.508891477489, 4294.184105020036, 4498.775061246924, 4504.527024662396, 4339.500957389878, 5487.64330318528, 5509.614326997112, 5518.806841760559, 5521.7300020995, 3189.6969787870116, 3230.9838450807597, 3583.62371950944, 3737.570179429373, 3775.9232422167697, 4681.906361872778, 5235.633505654606, 5260.894782104413, 5733.591891405578, 5743.6163991943295, 3449.87925422609, 3666.6433419634905, 3824.808759562011, 3824.890781673339, 3835.884923452301, 3525.629808870083, 3865.4588357629955, 3869.5356557213313, 3869.903252418712, 3891.0272431892026, 3826.9617303827163, 3877.689784817208, 4445.555444455528, 4460.264056430653, 4557.7721113944835, 4462.397576327155, 5073.720945348041, 5095.15929871567, 5118.616103792156, 5512.972435137879, 1130.9208355415205, 1178.834963105166, 1193.8209268609778, 1206.318430086998, 1223.5044806853061, 783.6160281462043, 797.1629788721934, 840.1556435781999, 851.3827475080641, 852.6887685994567, 4613.238815595456, 4858.198397264482, 4887.584555312767, 4887.682300650446, 4900.632452566072, 4183.728057676241, 4497.482789479186, 4881.707097574157, 5411.722402013724, 5424.891502169935, 4578.587927086512, 4677.321788340671, 4834.268638219395, 4894.430424027343, 4904.141775189399, 2381.8570885746562, 2779.902703405371, 2808.9297767555977, 2843.9004634837684, 2861.2846788302923, 4774.376711917895, 5211.166213405837, 5522.779088836482, 5546.668799488094, 5549.057829759552, 4830.903381932341, 5196.428392876781, 5487.314085739283, 5497.45025497447, 5587.469190426903, 4979.601631869442, 5161.509656582619, 5523.861903452445, 5550.944490555043, 5563.972180139073, 4514.110968979921, 4918.336024636628, 5003.974980125076, 5289.20661900718, 5384.353877534721, 4596.540345965377, 4810.5670489656095, 4906.871419573589, 5336.386315573759, 5346.679199247902, 4955.776990035385, 4993.500649935123, 5614.550835933034, 5614.578906581941, 5718.370979192368, 3105.2857842695853, 3419.2990436959867, 3596.5684117906017, 3642.725046233903, 3643.014557066352, 4998.550130488274, 5179.507946745204, 5266.710330931835, 5339.0, 5352.223927530408, 4169.812358443816, 4541.477730060953, 4730.763461826964, 4745.715257084586, 5182.963407318627, 4848.5636292733825, 4948.73807179167, 4977.850664480072, 5127.46161653021, 5213.374395072616, 5018.84943451697, 5054.797808087782, 5202.271681964604, 5230.163173892159, 5247.55395791362, 5469.671819690831, 5470.851121264579, 5487.585462396532, 5488.69812160335, 5488.780448782004, 4561.533234741554, 4924.581410580141, 5226.55742618771, 5379.811706590251, 5416.620836541404], "value": 3870.7564888078687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.0549258501021, 713.429256594724, 750.4371721209093, 755.5995322479087, 840.9992109389824, 14059.297035148253, 14331.355089020994, 14678.63303417415, 14741.926290368547, 15067.397304107822, 13284.0, 13525.0, 13813.654658633539, 13835.446582136703, 13846.861531384684, 741.3439106390856, 850.9276711479532, 876.2902049340055, 877.1316396767219, 878.9736307910773, 855.4054931822386, 865.809521905183, 888.8844450221462, 889.1064480197392, 893.2273583350387, 930.5719369090226, 934.2245935873209, 934.5887809363892, 934.6168071090854, 935.9532023398837, 927.661403587689, 929.8837645294338, 931.0782325497776, 932.2495391210073, 933.355984370782, 688.3632639808158, 690.6650274616807, 692.2661978303015, 693.3759616345329, 698.2598445647579, 12319.322437265946, 14385.0, 14515.927420362936, 14672.559823205322, 14712.337944792404, 13233.076739941347, 13463.394147263396, 13739.725205495834, 13744.587662370144, 13878.653033674138, 11090.445477726162, 11441.885581144248, 11517.76964460706, 11571.190016698834, 12013.038956883429, 3001.654809696891, 3678.9080272993388, 3682.815859207056, 3702.5186725725484, 3748.5126933498746, 100602.0, 103409.96590034079, 104576.0, 105529.4723526385, 106648.0, 10428.322159059637, 10450.425226612457, 10492.055714985689, 10871.184661150446, 11025.920409448556, 16025.839741602435, 21552.137914483246, 21575.56848863014, 21624.0, 21647.45881352979, 7206.783796486114, 7258.637068146677, 7381.409487241008, 7435.0, 7559.017327747468, 3967.8412863485714, 4074.459452058915, 4106.548279689232, 4118.588141185857, 4120.608542188487, 3512.1395258161915, 3588.551431071116, 3618.8009659468457, 3619.2580520993133, 3631.5460567429072, 688.896665500179, 714.6176795414532, 725.4341613541446, 725.7496163823472, 738.8337624034549, 643.4466358931315, 649.9772507962293, 689.7378995981495, 693.1266604078897, 706.3536863769696, 9825.312228144105, 9844.753881152885, 9956.551955162035, 10179.0, 10237.18102551794, 651.2835880531472, 659.8185498987721, 669.2805234373069, 680.8331958670059, 692.8337199072187, 4473.530279320625, 4802.807887684454, 4805.231163013901, 4810.903781924412, 4838.516148385133, 90569.54715226381, 92442.0, 92487.0, 92703.0, 93211.0, 46177.0, 65295.347046529874, 79226.60386698144, 82655.586722066, 85261.0, 58876.11685824716, 69069.0, 69478.3052169482, 70505.58988820297, 70740.0, 8772.605232764414, 10411.237399532629, 10533.525991330256, 10601.946990265307, 10629.0, 43816.685499435065, 44673.32990005088, 44715.55284447244, 45699.0, 45873.0, 43005.784971076195, 58034.70982645229, 60490.39509604847, 60856.695716521135, 61417.464563386275, 12144.167131807684, 12254.938725306316, 12403.565875194325, 12474.313912734886, 12950.352482376033, 13946.4421423146, 13996.790048149081, 14134.08128471646, 14138.78791818144, 14448.494302699355, 12951.861399196872, 13161.276129812952, 13234.205947643171, 13580.592582222549, 13796.517121900686, 12823.6217811745, 13035.0, 13328.600141995756, 13355.53255636048, 13632.250226237255, 12558.623241302776, 12901.806472902726, 13105.2136871788, 13325.400356983766, 13331.733365332446, 8407.915920840958, 10479.68560943173, 10870.510827012646, 10885.0, 11031.779364412827, 8970.730878073668, 10290.948545257226, 10410.323328983592, 10411.167106631603, 10441.060304572322], "value": 7262.98965916461, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 115.0, 114.0, 113.0, 114.0, 112.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 113.0, 111.0, 166.0, 138.0, 136.0, 125.0, 108.0, 131.0, 111.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 183.0, 185.0, 184.0, 182.0, 182.0, 186.0, 183.0, 183.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 105.0, 82.0, 81.0, 63.0, 59.0, 74.0, 59.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 87.0, 68.0, 69.0, 68.0, 83.0, 68.0, 68.0, 85.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 133.0, 87.0, 86.0, 87.0, 88.0, 88.0, 86.0, 86.0, 87.0], "value": 92.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 87.0, 88.0, 88.0, 85.0, 88.0, 86.0, 86.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 56.0, 57.0, 58.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 80.0, 76.0, 73.0, 69.0, 70.0, 71.0, 71.0, 77.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 88.0, 89.0, 88.0, 89.0, 87.0, 90.0, 93.0, 90.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 142.0, 141.0, 143.0, 145.0, 159.0, 195.0, 182.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 173.0, 172.0, 164.0, 149.0, 213.0, 234.0, 215.0, 174.0, 173.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.5, "unit": "score"}]}]} 03:20:43 INFO - Return code: 0 03:20:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:43 ERROR - # TBPL SUCCESS # 03:20:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:20:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:20:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:20:43 INFO - 2017-02-15 03:20:43.238 screenresolution[1794:10112] starting screenresolution argv=screenresolution get 03:20:43 INFO - 2017-02-15 03:20:43.241 screenresolution[1794:10112] Display 0: 1600x1200x32@60 03:20:43 INFO - 2017-02-15 03:20:43.247 screenresolution[1795:10115] starting screenresolution argv=screenresolution list 03:20:43 INFO - Available Modes on Display 0 03:20:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:20:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:20:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:20:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:20:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:20:43 INFO - Intel Iris: 03:20:43 INFO - Chipset Model: Intel Iris 03:20:43 INFO - Type: GPU 03:20:43 INFO - Bus: Built-In 03:20:43 INFO - VRAM (Dynamic, Max): 1536 MB 03:20:43 INFO - Vendor: Intel (0x8086) 03:20:43 INFO - Device ID: 0x0a2e 03:20:43 INFO - Revision ID: 0x0009 03:20:43 INFO - Displays: 03:20:43 INFO - Display: 03:20:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:20:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:20:43 INFO - Display Serial Number: 1600x1200 60 03:20:43 INFO - Main Display: Yes 03:20:43 INFO - Mirror: Off 03:20:43 INFO - Online: Yes 03:20:43 INFO - Rotation: Supported 03:20:43 INFO - Return code: 0 03:20:43 INFO - Running post-action listener: _resource_record_post_action 03:20:43 INFO - [mozharness: 2017-02-15 11:20:43.484574Z] Finished run-tests step (success) 03:20:43 INFO - Running post-run listener: _resource_record_post_run 03:20:43 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38126592; Write bytes: 558571520; Read time: 247; Write time: 1733 03:20:43 INFO - TinderboxPrint: CPU usage
54.0% 03:20:43 INFO - TinderboxPrint: I/O read bytes / time
38,126,592 / 247 03:20:43 INFO - TinderboxPrint: I/O write bytes / time
558,571,520 / 1,733 03:20:43 INFO - TinderboxPrint: CPU idle
2,209.4 (46.0%) 03:20:43 INFO - TinderboxPrint: CPU system
966.2 (20.1%) 03:20:43 INFO - TinderboxPrint: CPU user
1,629.8 (33.9%) 03:20:43 INFO - TinderboxPrint: Swap in / out
289,673,216 / 0 03:20:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250771968; Write bytes: 243089408; Read time: 18141; Write time: 524 03:20:43 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34554880; Write bytes: 299587584; Read time: 223; Write time: 1157 03:20:43 INFO - Running post-run listener: _upload_blobber_files 03:20:43 INFO - Blob upload gear active. 03:20:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:43 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 03:20:43 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'] 03:20:43 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 03:20:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:20:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:45 INFO - (blobuploader) - INFO - Done attempting. 03:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:20:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:46 INFO - (blobuploader) - INFO - Done attempting. 03:20:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:47 INFO - (blobuploader) - INFO - Done attempting. 03:20:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:49 INFO - (blobuploader) - INFO - Done attempting. 03:20:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:49 INFO - Return code: 0 03:20:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ae6eee254e7dc91bc85ac8b6c56e8f9f109eb6d4074cf361b6df42adb7c31c2a3afe21fac01e898be30c00494a25d15487e7515c2511fb594f7e21f3f71bbb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4da1d88b405ab8a3dc52bc1d6f6262fa7397ae8d90907ec49c13f6096c87095f59c405ee4ff5dd8d96df9da586d0cfeb9bdb36b13767286beeee1fee037bf863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc0593cc3010c2a938ae66240012131c52a463808c37b04e50b5fcd4aed086c1433a161e2c96c216de98766b8ed067d5c09e7b1e7e24a30c1ad4bd0ca087836", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9228d4007cc5b1813fa0404e23684153a5d693e4ff21ef963c76e76d5437bad918a5ee6a700f455c274543f4b81fa68053ea61883e96651bc037ee90fcea110"} 03:20:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:49 INFO - Contents: 03:20:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ae6eee254e7dc91bc85ac8b6c56e8f9f109eb6d4074cf361b6df42adb7c31c2a3afe21fac01e898be30c00494a25d15487e7515c2511fb594f7e21f3f71bbb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4da1d88b405ab8a3dc52bc1d6f6262fa7397ae8d90907ec49c13f6096c87095f59c405ee4ff5dd8d96df9da586d0cfeb9bdb36b13767286beeee1fee037bf863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc0593cc3010c2a938ae66240012131c52a463808c37b04e50b5fcd4aed086c1433a161e2c96c216de98766b8ed067d5c09e7b1e7e24a30c1ad4bd0ca087836", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9228d4007cc5b1813fa0404e23684153a5d693e4ff21ef963c76e76d5437bad918a5ee6a700f455c274543f4b81fa68053ea61883e96651bc037ee90fcea110"} 03:20:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:49 INFO - Copying logs to upload dir... 03:20:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.465408 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-15 03:20:50.007128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 03:20:50.010512) ========= 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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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/9ae6eee254e7dc91bc85ac8b6c56e8f9f109eb6d4074cf361b6df42adb7c31c2a3afe21fac01e898be30c00494a25d15487e7515c2511fb594f7e21f3f71bbb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4da1d88b405ab8a3dc52bc1d6f6262fa7397ae8d90907ec49c13f6096c87095f59c405ee4ff5dd8d96df9da586d0cfeb9bdb36b13767286beeee1fee037bf863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc0593cc3010c2a938ae66240012131c52a463808c37b04e50b5fcd4aed086c1433a161e2c96c216de98766b8ed067d5c09e7b1e7e24a30c1ad4bd0ca087836", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9228d4007cc5b1813fa0404e23684153a5d693e4ff21ef963c76e76d5437bad918a5ee6a700f455c274543f4b81fa68053ea61883e96651bc037ee90fcea110"} build_url:https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010956 build_url: 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/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/9ae6eee254e7dc91bc85ac8b6c56e8f9f109eb6d4074cf361b6df42adb7c31c2a3afe21fac01e898be30c00494a25d15487e7515c2511fb594f7e21f3f71bbb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4da1d88b405ab8a3dc52bc1d6f6262fa7397ae8d90907ec49c13f6096c87095f59c405ee4ff5dd8d96df9da586d0cfeb9bdb36b13767286beeee1fee037bf863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc0593cc3010c2a938ae66240012131c52a463808c37b04e50b5fcd4aed086c1433a161e2c96c216de98766b8ed067d5c09e7b1e7e24a30c1ad4bd0ca087836", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9228d4007cc5b1813fa0404e23684153a5d693e4ff21ef963c76e76d5437bad918a5ee6a700f455c274543f4b81fa68053ea61883e96651bc037ee90fcea110"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 03:20:50.044565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:20:50.044917) ========= 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.AzSe0qZ3AC/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.7PpwFfhW5b/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005312 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:20:50.094086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 03:20:50.094403) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 03:20:50.094735) ========= ========= Total master_lag: 1.70 =========